builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0001 starttime: 1470836439.62 results: success (0) buildid: 20160810034016 builduid: 1b0bfc7595a94fb38bb09f7b55e8740c revision: 2f24daceada71e15c03b5f90765264c720ed035a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-10 06:40:39.620431) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-10 06:40:39.620884) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-10 06:40:39.621157) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-10 06:40:39.682667) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-10 06:40:39.683051) ========= 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.QiCI2haLpB/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.B4jfseCfOH/Listeners TMPDIR=/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/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-10 06:40:39-- 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% 181M=0s 2016-08-10 06:40:40 (181 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.595260 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-10 06:40:40.301033) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-10 06:40:40.304396) ========= 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.QiCI2haLpB/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.B4jfseCfOH/Listeners TMPDIR=/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/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.026658 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-10 06:40:40.353050) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-08-10 06:40:40.354536) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 2f24daceada71e15c03b5f90765264c720ed035a --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 2f24daceada71e15c03b5f90765264c720ed035a --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.QiCI2haLpB/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.B4jfseCfOH/Listeners TMPDIR=/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/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-10 06:40:40,429 truncating revision to first 12 chars 2016-08-10 06:40:40,429 Setting DEBUG logging. 2016-08-10 06:40:40,429 attempt 1/10 2016-08-10 06:40:40,429 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/2f24daceada7?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-10 06:40:42,290 unpacking tar archive at: fx-team-2f24daceada7/testing/mozharness/ program finished with exit code 0 elapsedTime=2.124501 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-08-10 06:40:42.498007) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-10 06:40:42.498319) ========= script_repo_revision: 2f24daceada71e15c03b5f90765264c720ed035a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-10 06:40:42.498702) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-10 06:40:42.498963) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-10 06:40:42.515768) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2016-08-10 06:40:42.516148) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.QiCI2haLpB/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.B4jfseCfOH/Listeners TMPDIR=/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/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 06:40:42 INFO - MultiFileLogger online at 20160810 06:40:42 in /builds/slave/test 06:40:42 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 06:40:42 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:40:42 INFO - {'append_to_log': False, 06:40:42 INFO - 'base_work_dir': '/builds/slave/test', 06:40:42 INFO - 'blob_upload_branch': 'Fx-Team', 06:40:42 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:40:42 INFO - 'branch': 'Fx-Team', 06:40:42 INFO - 'buildbot_json_path': 'buildprops.json', 06:40:42 INFO - 'config_files': ('talos/mac_config.py',), 06:40:42 INFO - 'default_actions': ('clobber', 06:40:42 INFO - 'read-buildbot-config', 06:40:42 INFO - 'download-and-extract', 06:40:42 INFO - 'populate-webroot', 06:40:42 INFO - 'create-virtualenv', 06:40:42 INFO - 'install', 06:40:42 INFO - 'run-tests'), 06:40:42 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:40:42 INFO - 'download_minidump_stackwalk': True, 06:40:42 INFO - 'download_symbols': 'ondemand', 06:40:42 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:40:42 INFO - 'tooltool.py': '/tools/tooltool.py', 06:40:42 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:40:42 INFO - '/tools/misc-python/virtualenv.py')}, 06:40:42 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:40:42 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:40:42 INFO - 'installer_path': 'installer.exe', 06:40:42 INFO - 'log_level': 'info', 06:40:42 INFO - 'log_name': 'talos', 06:40:42 INFO - 'log_to_console': True, 06:40:42 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 06:40:42 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 06:40:42 INFO - 'opt_config_files': (), 06:40:42 INFO - 'pip_index': False, 06:40:42 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 06:40:42 INFO - 'cmd': ('bash', 06:40:42 INFO - '-c', 06:40:42 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 06:40:42 INFO - 'enabled': True, 06:40:42 INFO - 'halt_on_failure': False, 06:40:42 INFO - 'name': 'check_screen_resolution'},), 06:40:42 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 06:40:42 INFO - 'cmd': ('bash', 06:40:42 INFO - '-c', 06:40:42 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 06:40:42 INFO - 'enabled': True, 06:40:42 INFO - 'halt_on_failure': False, 06:40:42 INFO - 'name': 'check_screen_resolution'},), 06:40:42 INFO - 'run_cmd_checks_enabled': True, 06:40:42 INFO - 'sps_profile': False, 06:40:42 INFO - 'sps_profile_interval': 0, 06:40:42 INFO - 'suite': 'dromaeojs', 06:40:42 INFO - 'system_bits': '32', 06:40:42 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:40:42 INFO - 'title': 't-yosemite-r7-0001', 06:40:42 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:40:42 INFO - 'use_talos_json': True, 06:40:42 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:40:42 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:40:42 INFO - 'work_dir': 'build'} 06:40:42 INFO - [mozharness: 2016-08-10 13:40:42.700090Z] Running clobber step. 06:40:42 INFO - Running pre-action listener: _resource_record_pre_action 06:40:42 INFO - Running main action method: clobber 06:40:42 INFO - rmtree: /builds/slave/test/build 06:40:42 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:40:44 INFO - Running post-action listener: _resource_record_post_action 06:40:44 INFO - [mozharness: 2016-08-10 13:40:44.879900Z] Finished clobber step (success) 06:40:44 INFO - [mozharness: 2016-08-10 13:40:44.880060Z] Running read-buildbot-config step. 06:40:44 INFO - Running pre-action listener: _resource_record_pre_action 06:40:44 INFO - Running main action method: read_buildbot_config 06:40:44 INFO - Using buildbot properties: 06:40:44 INFO - { 06:40:44 INFO - "project": "", 06:40:44 INFO - "product": "firefox", 06:40:44 INFO - "script_repo_revision": "production", 06:40:44 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 06:40:44 INFO - "repository": "", 06:40:44 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 06:40:44 INFO - "buildid": "20160810034016", 06:40:44 INFO - "pgo_build": "False", 06:40:44 INFO - "basedir": "/builds/slave/test", 06:40:44 INFO - "buildnumber": 912, 06:40:44 INFO - "slavename": "t-yosemite-r7-0001", 06:40:44 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 06:40:44 INFO - "platform": "yosemite_r7", 06:40:44 INFO - "scheduler": "tests-fx-team-macosx64-talos-7-3600", 06:40:44 INFO - "branch": "fx-team", 06:40:44 INFO - "repo_path": "integration/fx-team", 06:40:44 INFO - "revision": "2f24daceada71e15c03b5f90765264c720ed035a", 06:40:44 INFO - "stage_platform": "macosx64", 06:40:44 INFO - "builduid": "1b0bfc7595a94fb38bb09f7b55e8740c", 06:40:44 INFO - "slavebuilddir": "test" 06:40:44 INFO - } 06:40:44 INFO - Found installer url https://queue.taskcluster.net/v1/task/Rg32TgxBRoKmgTSrt3I79A/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg. 06:40:44 INFO - Running post-action listener: _resource_record_post_action 06:40:44 INFO - [mozharness: 2016-08-10 13:40:44.883532Z] Finished read-buildbot-config step (success) 06:40:44 INFO - [mozharness: 2016-08-10 13:40:44.883648Z] Running download-and-extract step. 06:40:44 INFO - Running pre-action listener: _resource_record_pre_action 06:40:44 INFO - Running main action method: download_and_extract 06:40:44 INFO - mkdir: /builds/slave/test/build/tests 06:40:44 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')]} 06:40:44 INFO - trying https://queue.taskcluster.net/v1/task/Rg32TgxBRoKmgTSrt3I79A/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json 06:40:44 INFO - Downloading https://queue.taskcluster.net/v1/task/Rg32TgxBRoKmgTSrt3I79A/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 06:40:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Rg32TgxBRoKmgTSrt3I79A/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 06:40:46 INFO - Downloaded 1199 bytes. 06:40:46 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 06:40:46 INFO - Using the following test package requirements: 06:40:46 INFO - {u'common': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 06:40:46 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 06:40:46 INFO - u'firefox-51.0a1.en-US.mac.cppunittest.tests.zip'], 06:40:46 INFO - u'gtest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 06:40:46 INFO - u'firefox-51.0a1.en-US.mac.gtest.tests.zip'], 06:40:46 INFO - u'jittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 06:40:46 INFO - u'jsshell-mac.zip'], 06:40:46 INFO - u'mochitest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 06:40:46 INFO - u'firefox-51.0a1.en-US.mac.mochitest.tests.zip'], 06:40:46 INFO - u'mozbase': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 06:40:46 INFO - u'reftest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 06:40:46 INFO - u'firefox-51.0a1.en-US.mac.reftest.tests.zip'], 06:40:46 INFO - u'talos': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 06:40:46 INFO - u'firefox-51.0a1.en-US.mac.talos.tests.zip'], 06:40:46 INFO - u'web-platform': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 06:40:46 INFO - u'firefox-51.0a1.en-US.mac.web-platform.tests.zip'], 06:40:46 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 06:40:46 INFO - u'firefox-51.0a1.en-US.mac.xpcshell.tests.zip']} 06:40:46 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip'] for test suite category: common 06:40: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')]} 06:40:46 INFO - trying https://queue.taskcluster.net/v1/task/Rg32TgxBRoKmgTSrt3I79A/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 06:40:46 INFO - Downloading https://queue.taskcluster.net/v1/task/Rg32TgxBRoKmgTSrt3I79A/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 06:40:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Rg32TgxBRoKmgTSrt3I79A/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 06:40:47 INFO - Downloaded 16326003 bytes. 06:40: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'] 06:40: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 06:40:50 INFO - Return code: 0 06:40: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 06:40: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')]} 06:40:50 INFO - trying https://queue.taskcluster.net/v1/task/Rg32TgxBRoKmgTSrt3I79A/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 06:40:50 INFO - Downloading https://queue.taskcluster.net/v1/task/Rg32TgxBRoKmgTSrt3I79A/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 06:40:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Rg32TgxBRoKmgTSrt3I79A/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 06:40:51 INFO - Downloaded 16326003 bytes. 06:40: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'] 06:40: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 06:40:54 INFO - Return code: 0 06:40:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:40:54 INFO - trying https://queue.taskcluster.net/v1/task/Rg32TgxBRoKmgTSrt3I79A/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip 06:40:54 INFO - Downloading https://queue.taskcluster.net/v1/task/Rg32TgxBRoKmgTSrt3I79A/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 06:40:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Rg32TgxBRoKmgTSrt3I79A/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 06:40:56 INFO - Downloaded 14413723 bytes. 06:40: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'] 06:40: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 06:40:57 INFO - Return code: 0 06:40:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:40:57 INFO - trying https://queue.taskcluster.net/v1/task/Rg32TgxBRoKmgTSrt3I79A/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 06:40:57 INFO - Downloading https://queue.taskcluster.net/v1/task/Rg32TgxBRoKmgTSrt3I79A/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg 06:40:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Rg32TgxBRoKmgTSrt3I79A/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 06:41:01 INFO - Downloaded 110874418 bytes. 06:41:01 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Rg32TgxBRoKmgTSrt3I79A/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 06:41:01 INFO - mkdir: /builds/slave/test/properties 06:41:01 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:41:01 INFO - Writing to file /builds/slave/test/properties/build_url 06:41:01 INFO - Contents: 06:41:01 INFO - build_url:https://queue.taskcluster.net/v1/task/Rg32TgxBRoKmgTSrt3I79A/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 06:41:02 INFO - Running post-action listener: _resource_record_post_action 06:41:02 INFO - Running post-action listener: set_extra_try_arguments 06:41:02 INFO - [mozharness: 2016-08-10 13:41:02.532517Z] Finished download-and-extract step (success) 06:41:02 INFO - [mozharness: 2016-08-10 13:41:02.532644Z] Running populate-webroot step. 06:41:02 INFO - Running pre-action listener: _resource_record_pre_action 06:41:02 INFO - Running main action method: populate_webroot 06:41:02 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:41:02 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:41:02 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:41:02 INFO - '--tppagecycles', 06:41:02 INFO - '7'], 06:41:02 INFO - 'tests': ['tsvgm']}}, 06:41:02 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:41:02 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:41:02 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:41:02 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:41:02 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:41:02 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:41:02 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:41:02 INFO - 'talos_options': ['--disable-e10s'], 06:41:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:41:02 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:41:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:41:02 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:41:02 INFO - 'talos_options': ['--disable-e10s'], 06:41:02 INFO - 'tests': ['damp', 'tps']}, 06:41:02 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:41:02 INFO - 'tests': ['damp', 'tps']}, 06:41:02 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:41:02 INFO - 'tests': ['dromaeo_dom']}, 06:41:02 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:41:02 INFO - 'g4': {'talos_options': ['--disable-e10s'], 06:41:02 INFO - 'tests': ['basic_compositor_video']}, 06:41:02 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 06:41:02 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:41:02 INFO - 'tests': ['a11yr', 06:41:02 INFO - 'ts_paint', 06:41:02 INFO - 'tpaint', 06:41:02 INFO - 'sessionrestore', 06:41:02 INFO - 'sessionrestore_no_auto_restore', 06:41:02 INFO - 'tabpaint']}, 06:41:02 INFO - 'other-e10s': {'tests': ['a11yr', 06:41:02 INFO - 'ts_paint', 06:41:02 INFO - 'tpaint', 06:41:02 INFO - 'sessionrestore', 06:41:02 INFO - 'sessionrestore_no_auto_restore', 06:41:02 INFO - 'tabpaint']}, 06:41:02 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:41:02 INFO - 'ts_paint', 06:41:02 INFO - 'tpaint', 06:41:02 INFO - 'sessionrestore', 06:41:02 INFO - 'sessionrestore_no_auto_restore', 06:41:02 INFO - 'tabpaint']}, 06:41:02 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:41:02 INFO - 'ts_paint', 06:41:02 INFO - 'tpaint', 06:41:02 INFO - 'sessionrestore', 06:41:02 INFO - 'sessionrestore_no_auto_restore', 06:41:02 INFO - 'tabpaint']}, 06:41:02 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:41:02 INFO - 'tests': ['a11yr', 06:41:02 INFO - 'ts_paint', 06:41:02 INFO - 'tpaint', 06:41:02 INFO - 'sessionrestore', 06:41:02 INFO - 'sessionrestore_no_auto_restore', 06:41:02 INFO - 'tabpaint']}, 06:41:02 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:41:02 INFO - 'tests': ['a11yr', 06:41:02 INFO - 'ts_paint', 06:41:02 INFO - 'tpaint', 06:41:02 INFO - 'sessionrestore', 06:41:02 INFO - 'sessionrestore_no_auto_restore', 06:41:02 INFO - 'tabpaint']}, 06:41:02 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:41:02 INFO - 'tests': ['tsvgx', 06:41:02 INFO - 'tsvgr_opacity', 06:41:02 INFO - 'tart', 06:41:02 INFO - 'tscrollx', 06:41:02 INFO - 'cart']}, 06:41:02 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:41:02 INFO - 'tsvgr_opacity', 06:41:02 INFO - 'tart', 06:41:02 INFO - 'tscrollx', 06:41:02 INFO - 'cart']}, 06:41:02 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:41:02 INFO - 'talos_options': ['--disable-e10s'], 06:41:02 INFO - 'tests': ['tp5o']}, 06:41:02 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:41:02 INFO - 'tests': ['tp5o']}, 06:41:02 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:41:02 INFO - 'talos_options': ['--disable-e10s', 06:41:02 INFO - '--xperf_path', 06:41:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:41:02 INFO - 'tests': ['tp5n']}, 06:41:02 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:41:02 INFO - 'talos_options': ['--xperf_path', 06:41:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:41:02 INFO - 'tests': ['tp5n']}}, 06:41:02 INFO - 'talos.zip': {'path': '', 06:41:02 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:41:02 INFO - Running post-action listener: _resource_record_post_action 06:41:02 INFO - [mozharness: 2016-08-10 13:41:02.551750Z] Finished populate-webroot step (success) 06:41:02 INFO - [mozharness: 2016-08-10 13:41:02.551861Z] Running create-virtualenv step. 06:41:02 INFO - Running pre-action listener: _resource_record_pre_action 06:41:02 INFO - Running main action method: create_virtualenv 06:41:02 INFO - Creating virtualenv /builds/slave/test/build/venv 06:41:02 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 06:41:02 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:41:02 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:41:02 INFO - Using real prefix '/tools/python27' 06:41:02 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:41:03 INFO - Installing distribute.............................................................................................................................................................................................done. 06:41:06 INFO - Installing pip.................done. 06:41:06 INFO - Return code: 0 06:41:06 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:41:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:41:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:41:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:41:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:41:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:41:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:41:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1080dca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108171618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd289d99ff0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108040d30>, '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 0x107da5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108038b20>, '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.QiCI2haLpB/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.B4jfseCfOH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/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 06:41:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 06:41:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 06:41:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QiCI2haLpB/Render', 06:41:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:41:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:41:06 INFO - 'HOME': '/Users/cltbld', 06:41:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:41:06 INFO - 'LOGNAME': 'cltbld', 06:41:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:41:06 INFO - 'MOZ_NO_REMOTE': '1', 06:41:06 INFO - 'NO_EM_RESTART': '1', 06:41:06 INFO - 'PAGER': '/bin/cat', 06:41:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:41:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:41:06 INFO - 'PWD': '/builds/slave/test', 06:41:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:41:06 INFO - 'SHELL': '/bin/bash', 06:41:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.B4jfseCfOH/Listeners', 06:41:06 INFO - 'TMPDIR': '/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/', 06:41:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:41:06 INFO - 'USER': 'cltbld', 06:41:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:41:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:41:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:41:06 INFO - 'XPC_FLAGS': '0x0', 06:41:06 INFO - 'XPC_SERVICE_NAME': '0', 06:41:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:41:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:41:06 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 06:41:06 INFO - Cleaning up... 06:41:06 INFO - Return code: 0 06:41:06 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 06:41:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:41:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:41:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:41:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:41:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:41:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:41:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1080dca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108171618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd289d99ff0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108040d30>, '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 0x107da5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108038b20>, '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.QiCI2haLpB/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.B4jfseCfOH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/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 06:41:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 06:41:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 06:41:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QiCI2haLpB/Render', 06:41:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:41:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:41:06 INFO - 'HOME': '/Users/cltbld', 06:41:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:41:06 INFO - 'LOGNAME': 'cltbld', 06:41:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:41:06 INFO - 'MOZ_NO_REMOTE': '1', 06:41:06 INFO - 'NO_EM_RESTART': '1', 06:41:06 INFO - 'PAGER': '/bin/cat', 06:41:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:41:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:41:06 INFO - 'PWD': '/builds/slave/test', 06:41:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:41:06 INFO - 'SHELL': '/bin/bash', 06:41:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.B4jfseCfOH/Listeners', 06:41:06 INFO - 'TMPDIR': '/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/', 06:41:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:41:06 INFO - 'USER': 'cltbld', 06:41:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:41:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:41:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:41:06 INFO - 'XPC_FLAGS': '0x0', 06:41:06 INFO - 'XPC_SERVICE_NAME': '0', 06:41:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:41:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:41:06 INFO - Downloading/unpacking psutil>=3.1.1 06:41:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:41:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:41:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:41:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:41:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:41:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:41:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:41:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:41:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:41:10 INFO - Installing collected packages: psutil 06:41:10 INFO - Running setup.py install for psutil 06:41:10 INFO - building 'psutil._psutil_osx' extension 06:41:10 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 06:41:10 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 06:41:11 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 06:41:11 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 06:41:11 INFO - building 'psutil._psutil_posix' extension 06:41:11 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 06:41:11 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 06:41:11 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 06:41:11 INFO - ^ 06:41:11 INFO - 1 warning generated. 06:41:11 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 06:41:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:41:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:41:11 INFO - Successfully installed psutil 06:41:11 INFO - Cleaning up... 06:41:11 INFO - Return code: 0 06:41:11 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 06:41:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:41:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:41:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:41:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:41:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:41:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:41:11 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 0x1080dca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108171618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd289d99ff0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108040d30>, '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 0x107da5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108038b20>, '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.QiCI2haLpB/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.B4jfseCfOH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/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 06:41:11 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 06:41:11 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 06:41:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QiCI2haLpB/Render', 06:41:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:41:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:41:11 INFO - 'HOME': '/Users/cltbld', 06:41:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:41:11 INFO - 'LOGNAME': 'cltbld', 06:41:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:41:11 INFO - 'MOZ_NO_REMOTE': '1', 06:41:11 INFO - 'NO_EM_RESTART': '1', 06:41:11 INFO - 'PAGER': '/bin/cat', 06:41:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:41:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:41:11 INFO - 'PWD': '/builds/slave/test', 06:41:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:41:11 INFO - 'SHELL': '/bin/bash', 06:41:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.B4jfseCfOH/Listeners', 06:41:11 INFO - 'TMPDIR': '/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/', 06:41:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:41:11 INFO - 'USER': 'cltbld', 06:41:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:41:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:41:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:41:11 INFO - 'XPC_FLAGS': '0x0', 06:41:11 INFO - 'XPC_SERVICE_NAME': '0', 06:41:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:41:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:41:11 INFO - Downloading/unpacking mozsystemmonitor==0.3 06:41: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 06:41: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 06:41: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 06:41: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 06:41: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 06:41: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 06:41:14 INFO - Downloading mozsystemmonitor-0.3.tar.gz 06:41:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:41:14 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 06:41:14 INFO - Installing collected packages: mozsystemmonitor 06:41:14 INFO - Running setup.py install for mozsystemmonitor 06:41:14 INFO - Successfully installed mozsystemmonitor 06:41:14 INFO - Cleaning up... 06:41:14 INFO - Return code: 0 06:41:14 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 06:41: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')]} 06:41:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:41:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:41: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')]} 06:41:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:41:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:41: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', '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 0x1080dca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108171618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd289d99ff0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108040d30>, '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 0x107da5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108038b20>, '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.QiCI2haLpB/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.B4jfseCfOH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/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 06:41: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 06:41: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 jsonschema==2.5.1 06:41:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QiCI2haLpB/Render', 06:41:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:41:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:41:14 INFO - 'HOME': '/Users/cltbld', 06:41:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:41:14 INFO - 'LOGNAME': 'cltbld', 06:41:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:41:14 INFO - 'MOZ_NO_REMOTE': '1', 06:41:14 INFO - 'NO_EM_RESTART': '1', 06:41:14 INFO - 'PAGER': '/bin/cat', 06:41:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:41:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:41:14 INFO - 'PWD': '/builds/slave/test', 06:41:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:41:14 INFO - 'SHELL': '/bin/bash', 06:41:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.B4jfseCfOH/Listeners', 06:41:14 INFO - 'TMPDIR': '/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/', 06:41:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:41:14 INFO - 'USER': 'cltbld', 06:41:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:41:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:41:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:41:14 INFO - 'XPC_FLAGS': '0x0', 06:41:14 INFO - 'XPC_SERVICE_NAME': '0', 06:41:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:41:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:41:14 INFO - Downloading/unpacking jsonschema==2.5.1 06:41:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:41:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:41:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:41:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:41:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:41:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:41:17 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:41:17 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 06:41: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 06:41: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 06:41: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 06:41: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 06:41: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 06:41: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 06:41:17 INFO - Downloading functools32-3.2.3-2.tar.gz 06:41:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:41:17 INFO - warning: no files found matching '*.txt' 06:41:17 INFO - no previously-included directories found matching 'build' 06:41:17 INFO - no previously-included directories found matching 'dist' 06:41:17 INFO - no previously-included directories found matching '.git*' 06:41:17 INFO - Installing collected packages: jsonschema, functools32 06:41:17 INFO - Running setup.py install for functools32 06:41:18 INFO - warning: no files found matching '*.txt' 06:41:18 INFO - no previously-included directories found matching 'build' 06:41:18 INFO - no previously-included directories found matching 'dist' 06:41:18 INFO - no previously-included directories found matching '.git*' 06:41:18 INFO - Successfully installed jsonschema functools32 06:41:18 INFO - Cleaning up... 06:41:18 INFO - Return code: 0 06:41:18 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 06:41:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:41:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:41:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:41:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:41:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:41:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:41:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1080dca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108171618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd289d99ff0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108040d30>, '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 0x107da5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108038b20>, '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.QiCI2haLpB/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.B4jfseCfOH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/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 06:41:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 06:41:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 06:41:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QiCI2haLpB/Render', 06:41:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:41:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:41:18 INFO - 'HOME': '/Users/cltbld', 06:41:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:41:18 INFO - 'LOGNAME': 'cltbld', 06:41:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:41:18 INFO - 'MOZ_NO_REMOTE': '1', 06:41:18 INFO - 'NO_EM_RESTART': '1', 06:41:18 INFO - 'PAGER': '/bin/cat', 06:41:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:41:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:41:18 INFO - 'PWD': '/builds/slave/test', 06:41:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:41:18 INFO - 'SHELL': '/bin/bash', 06:41:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.B4jfseCfOH/Listeners', 06:41:18 INFO - 'TMPDIR': '/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/', 06:41:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:41:18 INFO - 'USER': 'cltbld', 06:41:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:41:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:41:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:41:18 INFO - 'XPC_FLAGS': '0x0', 06:41:18 INFO - 'XPC_SERVICE_NAME': '0', 06:41:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:41:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:41:18 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 06:41:18 INFO - Cleaning up... 06:41:18 INFO - Return code: 0 06:41:18 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:41:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:41:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:41:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:41:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:41:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:41:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:41:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1080dca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108171618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd289d99ff0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108040d30>, '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 0x107da5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108038b20>, '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.QiCI2haLpB/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.B4jfseCfOH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/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 06:41:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 06:41:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 06:41:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QiCI2haLpB/Render', 06:41:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:41:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:41:18 INFO - 'HOME': '/Users/cltbld', 06:41:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:41:18 INFO - 'LOGNAME': 'cltbld', 06:41:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:41:18 INFO - 'MOZ_NO_REMOTE': '1', 06:41:18 INFO - 'NO_EM_RESTART': '1', 06:41:18 INFO - 'PAGER': '/bin/cat', 06:41:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:41:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:41:18 INFO - 'PWD': '/builds/slave/test', 06:41:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:41:18 INFO - 'SHELL': '/bin/bash', 06:41:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.B4jfseCfOH/Listeners', 06:41:18 INFO - 'TMPDIR': '/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/', 06:41:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:41:18 INFO - 'USER': 'cltbld', 06:41:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:41:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:41:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:41:18 INFO - 'XPC_FLAGS': '0x0', 06:41:18 INFO - 'XPC_SERVICE_NAME': '0', 06:41:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:41:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:41:18 INFO - Downloading/unpacking blobuploader==1.2.4 06:41: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 06:41: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 06:41: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 06:41: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 06:41: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 06:41: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 06:41:21 INFO - Downloading blobuploader-1.2.4.tar.gz 06:41:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:41:21 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:41:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:41:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:41:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:41:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:41:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:41:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:41:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:41:21 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:41:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:41:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:41:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:41:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:41:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:41:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:41:22 INFO - Downloading docopt-0.6.1.tar.gz 06:41:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:41:22 INFO - Installing collected packages: blobuploader, requests, docopt 06:41:22 INFO - Running setup.py install for blobuploader 06:41:22 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:41:22 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:41:22 INFO - Running setup.py install for requests 06:41:23 INFO - Running setup.py install for docopt 06:41:23 INFO - Successfully installed blobuploader requests docopt 06:41:23 INFO - Cleaning up... 06:41:23 INFO - Return code: 0 06:41:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:41:23 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')]} 06:41:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:41:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:41:23 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')]} 06:41:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:41:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:41:23 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 0x1080dca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108171618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd289d99ff0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108040d30>, '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 0x107da5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108038b20>, '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.QiCI2haLpB/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.B4jfseCfOH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/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 06:41:23 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 06:41:23 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 06:41:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QiCI2haLpB/Render', 06:41:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:41:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:41:23 INFO - 'HOME': '/Users/cltbld', 06:41:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:41:23 INFO - 'LOGNAME': 'cltbld', 06:41:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:41:23 INFO - 'MOZ_NO_REMOTE': '1', 06:41:23 INFO - 'NO_EM_RESTART': '1', 06:41:23 INFO - 'PAGER': '/bin/cat', 06:41:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:41:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:41:23 INFO - 'PWD': '/builds/slave/test', 06:41:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:41:23 INFO - 'SHELL': '/bin/bash', 06:41:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.B4jfseCfOH/Listeners', 06:41:23 INFO - 'TMPDIR': '/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/', 06:41:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:41:23 INFO - 'USER': 'cltbld', 06:41:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:41:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:41:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:41:23 INFO - 'XPC_FLAGS': '0x0', 06:41:23 INFO - 'XPC_SERVICE_NAME': '0', 06:41:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:41:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:41:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:41:23 INFO - Running setup.py (path:/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/pip-Bgrw9M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:41:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:41:23 INFO - Running setup.py (path:/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/pip-FHbloZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:41:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:41:23 INFO - Running setup.py (path:/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/pip-42RS0Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:41:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:41:23 INFO - Running setup.py (path:/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/pip-e6ntGi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:41:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:41:23 INFO - Running setup.py (path:/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/pip-t_FmsS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:41:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:41:24 INFO - Running setup.py (path:/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/pip-rKyaT3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:41:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:41:24 INFO - Running setup.py (path:/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/pip-W3eSo9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:41:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:41:24 INFO - Running setup.py (path:/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/pip-WtUUO6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:41:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:41:24 INFO - Running setup.py (path:/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/pip-kyPaXO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:41:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:41:24 INFO - Running setup.py (path:/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/pip-Sma_a1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:41:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:41:24 INFO - Running setup.py (path:/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/pip-q15YCX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:41:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:41:24 INFO - Running setup.py (path:/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/pip-dJSG42-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:41:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:41:24 INFO - Running setup.py (path:/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/pip-Ti73tt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:41:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:41:24 INFO - Running setup.py (path:/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/pip-6TAV3a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:41:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:41:24 INFO - Running setup.py (path:/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/pip-ju5C74-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:41:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:41:25 INFO - Running setup.py (path:/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/pip-yZNEo_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:41:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:41:25 INFO - Running setup.py (path:/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/pip-E0xtRV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:41:25 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:41:25 INFO - Running setup.py install for manifestparser 06:41:25 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:41:25 INFO - Running setup.py install for mozcrash 06:41:25 INFO - Running setup.py install for mozdebug 06:41:25 INFO - Running setup.py install for mozdevice 06:41:25 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:41:25 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:41:25 INFO - Running setup.py install for mozfile 06:41:26 INFO - Running setup.py install for mozhttpd 06:41:26 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:41:26 INFO - Running setup.py install for mozinfo 06:41:26 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:41:26 INFO - Running setup.py install for mozInstall 06:41:26 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:41:26 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:41:26 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:41:26 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:41:26 INFO - Running setup.py install for mozleak 06:41:26 INFO - Running setup.py install for mozlog 06:41:26 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:41:26 INFO - Running setup.py install for moznetwork 06:41:26 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:41:26 INFO - Running setup.py install for mozprocess 06:41:27 INFO - Running setup.py install for mozprofile 06:41:27 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:41:27 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:41:27 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:41:27 INFO - Running setup.py install for mozrunner 06:41:27 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:41:27 INFO - Running setup.py install for mozscreenshot 06:41:27 INFO - Running setup.py install for moztest 06:41:27 INFO - Running setup.py install for mozversion 06:41:27 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:41:27 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:41:27 INFO - Cleaning up... 06:41:27 INFO - Return code: 0 06:41:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:41:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:41:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:41:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:41:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:41:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:41:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:41:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1080dca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108171618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd289d99ff0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108040d30>, '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 0x107da5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108038b20>, '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.QiCI2haLpB/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.B4jfseCfOH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/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 06:41:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 06:41:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 06:41:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QiCI2haLpB/Render', 06:41:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:41:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:41:27 INFO - 'HOME': '/Users/cltbld', 06:41:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:41:27 INFO - 'LOGNAME': 'cltbld', 06:41:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:41:27 INFO - 'MOZ_NO_REMOTE': '1', 06:41:27 INFO - 'NO_EM_RESTART': '1', 06:41:27 INFO - 'PAGER': '/bin/cat', 06:41:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:41:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:41:27 INFO - 'PWD': '/builds/slave/test', 06:41:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:41:27 INFO - 'SHELL': '/bin/bash', 06:41:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.B4jfseCfOH/Listeners', 06:41:27 INFO - 'TMPDIR': '/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/', 06:41:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:41:27 INFO - 'USER': 'cltbld', 06:41:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:41:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:41:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:41:27 INFO - 'XPC_FLAGS': '0x0', 06:41:27 INFO - 'XPC_SERVICE_NAME': '0', 06:41:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:41:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:41:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:41:28 INFO - Running setup.py (path:/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/pip-gAsqk2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:41:28 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)) 06:41:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:41:28 INFO - Running setup.py (path:/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/pip-Xj35Iv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:41:28 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)) 06:41:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:41:28 INFO - Running setup.py (path:/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/pip-cxMMfA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:41:28 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)) 06:41:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:41:28 INFO - Running setup.py (path:/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/pip-Iu8ERM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:41:28 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)) 06:41:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:41:28 INFO - Running setup.py (path:/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/pip-KqKlCd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:41:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 06:41:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:41:28 INFO - Running setup.py (path:/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/pip-xU3qsQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:41:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 06:41:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:41:28 INFO - Running setup.py (path:/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/pip-Nrljp0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:41:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 06:41:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:41:28 INFO - Running setup.py (path:/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/pip-racp8y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:41:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 06:41:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:41:28 INFO - Running setup.py (path:/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/pip-ILAwW6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:41:29 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)) 06:41:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:41:29 INFO - Running setup.py (path:/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/pip-DlyjcU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:41:29 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)) 06:41:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:41:29 INFO - Running setup.py (path:/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/pip-MSffzS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:41:29 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)) 06:41:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:41:29 INFO - Running setup.py (path:/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/pip-D5_z2D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:41:29 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)) 06:41:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:41:29 INFO - Running setup.py (path:/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/pip-i2k2BX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:41:29 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)) 06:41:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:41:29 INFO - Running setup.py (path:/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/pip-HmtGV8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:41:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 06:41:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:41:29 INFO - Running setup.py (path:/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/pip-hbJb9r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:41:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 06:41:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:41:29 INFO - Running setup.py (path:/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/pip-nlYuu1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:41:29 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 06:41:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:41:29 INFO - Running setup.py (path:/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/pip-1ZvS5M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:41:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 06:41:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:41:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:41:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 06:41:29 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:41:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:41:29 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:41:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:41:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:41:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:41:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:41:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:41:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:41:32 INFO - Downloading blessings-1.6.tar.gz 06:41:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:41:32 INFO - Installing collected packages: blessings 06:41:32 INFO - Running setup.py install for blessings 06:41:32 INFO - Successfully installed blessings 06:41:32 INFO - Cleaning up... 06:41:32 INFO - Return code: 0 06:41:32 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:41:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:41:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:41:32 INFO - Reading from file tmpfile_stdout 06:41:32 INFO - Current package versions: 06:41:32 INFO - blessings == 1.6 06:41:32 INFO - blobuploader == 1.2.4 06:41:32 INFO - docopt == 0.6.1 06:41:32 INFO - functools32 == 3.2.3-2 06:41:32 INFO - jsonschema == 2.5.1 06:41:32 INFO - manifestparser == 1.1 06:41:32 INFO - mozInstall == 1.12 06:41:32 INFO - mozcrash == 0.17 06:41:32 INFO - mozdebug == 0.1 06:41:32 INFO - mozdevice == 0.48 06:41:32 INFO - mozfile == 1.2 06:41:32 INFO - mozhttpd == 0.7 06:41:32 INFO - mozinfo == 0.9 06:41:32 INFO - mozleak == 0.1 06:41:32 INFO - mozlog == 3.3 06:41:32 INFO - moznetwork == 0.27 06:41:32 INFO - mozprocess == 0.23 06:41:32 INFO - mozprofile == 0.28 06:41:32 INFO - mozrunner == 6.12 06:41:32 INFO - mozscreenshot == 0.1 06:41:32 INFO - mozsystemmonitor == 0.3 06:41:32 INFO - moztest == 0.7 06:41:32 INFO - mozversion == 1.4 06:41:32 INFO - psutil == 3.1.1 06:41:32 INFO - requests == 1.2.3 06:41:32 INFO - wsgiref == 0.1.2 06:41:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:41:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:41:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:41:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:41:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:41:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:41:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:41:32 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 0x1080dca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108171618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd289d99ff0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108040d30>, '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 0x107da5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108038b20>, '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.QiCI2haLpB/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.B4jfseCfOH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/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 06:41:32 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 06:41:32 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 06:41:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QiCI2haLpB/Render', 06:41:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:41:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:41:32 INFO - 'HOME': '/Users/cltbld', 06:41:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:41:32 INFO - 'LOGNAME': 'cltbld', 06:41:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:41:32 INFO - 'MOZ_NO_REMOTE': '1', 06:41:32 INFO - 'NO_EM_RESTART': '1', 06:41:32 INFO - 'PAGER': '/bin/cat', 06:41:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:41:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:41:32 INFO - 'PWD': '/builds/slave/test', 06:41:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:41:32 INFO - 'SHELL': '/bin/bash', 06:41:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.B4jfseCfOH/Listeners', 06:41:32 INFO - 'TMPDIR': '/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/', 06:41:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:41:32 INFO - 'USER': 'cltbld', 06:41:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:41:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:41:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:41:32 INFO - 'XPC_FLAGS': '0x0', 06:41:32 INFO - 'XPC_SERVICE_NAME': '0', 06:41:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:41:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:41:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 06:41:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 06:41:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 06:41:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 06:41:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 06:41:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 06:41:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 06:41:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 06:41:33 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 06:41:33 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 06:41:33 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 06:41:33 INFO - Cleaning up... 06:41:33 INFO - Return code: 0 06:41:33 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:41:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:41:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:41:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:41:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:41:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:41:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:41:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1080dca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108171618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd289d99ff0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108040d30>, '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 0x107da5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108038b20>, '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.QiCI2haLpB/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.B4jfseCfOH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/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 06:41:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 06:41:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 06:41:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QiCI2haLpB/Render', 06:41:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:41:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:41:33 INFO - 'HOME': '/Users/cltbld', 06:41:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:41:33 INFO - 'LOGNAME': 'cltbld', 06:41:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:41:33 INFO - 'MOZ_NO_REMOTE': '1', 06:41:33 INFO - 'NO_EM_RESTART': '1', 06:41:33 INFO - 'PAGER': '/bin/cat', 06:41:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:41:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:41:33 INFO - 'PWD': '/builds/slave/test', 06:41:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:41:33 INFO - 'SHELL': '/bin/bash', 06:41:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.B4jfseCfOH/Listeners', 06:41:33 INFO - 'TMPDIR': '/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/', 06:41:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:41:33 INFO - 'USER': 'cltbld', 06:41:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:41:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:41:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:41:33 INFO - 'XPC_FLAGS': '0x0', 06:41:33 INFO - 'XPC_SERVICE_NAME': '0', 06:41:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:41:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:41:33 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 06:41:33 INFO - Cleaning up... 06:41:33 INFO - Return code: 0 06:41:33 INFO - Running post-action listener: _resource_record_post_action 06:41:33 INFO - Running post-action listener: _start_resource_monitoring 06:41:33 INFO - Starting resource monitoring. 06:41:33 INFO - [mozharness: 2016-08-10 13:41:33.530146Z] Finished create-virtualenv step (success) 06:41:33 INFO - [mozharness: 2016-08-10 13:41:33.531071Z] Running install step. 06:41:33 INFO - Running pre-action listener: _resource_record_pre_action 06:41:33 INFO - Running main action method: install 06:41:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:41:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:41:33 INFO - Reading from file tmpfile_stdout 06:41:33 INFO - Detecting whether we're running mozinstall >=1.0... 06:41:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:41:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:41:33 INFO - Reading from file tmpfile_stdout 06:41:33 INFO - Output received: 06:41:33 INFO - Usage: mozinstall [options] installer 06:41:33 INFO - Options: 06:41:33 INFO - -h, --help show this help message and exit 06:41:33 INFO - -d DEST, --destination=DEST 06:41:33 INFO - Directory to install application into. [default: 06:41:33 INFO - "/builds/slave/test"] 06:41:33 INFO - --app=APP Application being installed. [default: firefox] 06:41:33 INFO - mkdir: /builds/slave/test/build/application 06:41:33 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'] 06:41:33 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 06:42:08 INFO - Reading from file tmpfile_stdout 06:42:08 INFO - Output received: 06:42:08 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 06:42:08 INFO - Running post-action listener: _resource_record_post_action 06:42:08 INFO - [mozharness: 2016-08-10 13:42:08.821075Z] Finished install step (success) 06:42:08 INFO - [mozharness: 2016-08-10 13:42:08.821219Z] Running run-tests step. 06:42:08 INFO - Running pre-action listener: _resource_record_pre_action 06:42:08 INFO - Running main action method: run_tests 06:42:08 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 06:42:08 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 06:42:08 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 06:42:08 INFO - 2016-08-10 06:42:08.835 screenresolution[1652:9088] starting screenresolution argv=screenresolution get 06:42:08 INFO - 2016-08-10 06:42:08.838 screenresolution[1652:9088] Display 0: 1600x1200x32@60 06:42:08 INFO - 2016-08-10 06:42:08.844 screenresolution[1653:9090] starting screenresolution argv=screenresolution list 06:42:08 INFO - Available Modes on Display 0 06:42:08 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 06:42:08 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 06:42:08 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 06:42:08 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 06:42:09 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 06:42:09 INFO - Intel Iris: 06:42:09 INFO - Chipset Model: Intel Iris 06:42:09 INFO - Type: GPU 06:42:09 INFO - Bus: Built-In 06:42:09 INFO - VRAM (Dynamic, Max): 1536 MB 06:42:09 INFO - Vendor: Intel (0x8086) 06:42:09 INFO - Device ID: 0x0a2e 06:42:09 INFO - Revision ID: 0x0009 06:42:09 INFO - Displays: 06:42:09 INFO - Display: 06:42:09 INFO - Resolution: 1600 x 1200 @ 60 Hz 06:42:09 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 06:42:09 INFO - Display Serial Number: 1600x1200 60 06:42:09 INFO - Main Display: Yes 06:42:09 INFO - Mirror: Off 06:42:09 INFO - Online: Yes 06:42:09 INFO - Rotation: Supported 06:42:09 INFO - Return code: 0 06:42:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:42:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:42:09 INFO - Python 2.7.3 06:42:09 INFO - Return code: 0 06:42:09 INFO - grabbing minidump binary from tooltool 06:42:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:42:09 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108040d30>, '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 0x107da5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108038b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:42:09 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 06:42:09 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 06:42:09 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 06:42:09 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:42:09 INFO - Return code: 0 06:42:09 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 06:42:09 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:42:09 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:42:09 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 06:42:09 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:42:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Rg32TgxBRoKmgTSrt3I79A/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0001', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 06:42:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Rg32TgxBRoKmgTSrt3I79A/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0001 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 06:42:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QiCI2haLpB/Render', 06:42:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:42:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:42:09 INFO - 'HOME': '/Users/cltbld', 06:42:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:42:09 INFO - 'LOGNAME': 'cltbld', 06:42:09 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:42:09 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 06:42:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:42:09 INFO - 'MOZ_NO_REMOTE': '1', 06:42:09 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:42:09 INFO - 'NO_EM_RESTART': '1', 06:42:09 INFO - 'PAGER': '/bin/cat', 06:42:09 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:42:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:42:09 INFO - 'PWD': '/builds/slave/test', 06:42:09 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:42:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:42:09 INFO - 'SHELL': '/bin/bash', 06:42:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.B4jfseCfOH/Listeners', 06:42:09 INFO - 'TMPDIR': '/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/', 06:42:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:42:09 INFO - 'USER': 'cltbld', 06:42:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:42:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:42:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:42:09 INFO - 'XPC_FLAGS': '0x0', 06:42:09 INFO - 'XPC_SERVICE_NAME': '0', 06:42:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:42:09 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Rg32TgxBRoKmgTSrt3I79A/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0001', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 06:42:09 INFO - mozversion application_buildid: 20160810034016 06:42:09 INFO - mozversion application_changeset: 2f24daceada71e15c03b5f90765264c720ed035a 06:42:09 INFO - mozversion application_display_name: Nightly 06:42:09 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:42:09 INFO - mozversion application_name: Firefox 06:42:09 INFO - mozversion application_remotingname: firefox 06:42:09 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 06:42:09 INFO - mozversion application_vendor: Mozilla 06:42:09 INFO - mozversion application_version: 51.0a1 06:42:09 INFO - mozversion platform_buildid: 20160810034016 06:42:09 INFO - mozversion platform_changeset: 2f24daceada71e15c03b5f90765264c720ed035a 06:42:09 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 06:42:09 INFO - mozversion platform_version: 51.0a1 06:42:09 INFO - using testdate: 1470836529 06:42:09 INFO - actual date: 1470836529 06:42:09 INFO - starting webserver on 'localhost:49279' 06:42:09 INFO - SUITE-START | Running 2 tests 06:42:09 INFO - TEST-START | dromaeo_css 06:42:09 INFO - operating with platform_type : mac_ 06:42:09 INFO - Initialising browser for dromaeo_css test... 06:42:09 INFO - TEST-INFO | started process 1663 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/tmp4JsjGO/profile http://localhost:49279/getInfo.html) 06:42:11 INFO - PROCESS | 1663 | __metrics Screen width/height:1600/1200 06:42:11 INFO - PROCESS | 1663 | colorDepth:24 06:42:11 INFO - PROCESS | 1663 | Browser inner width/height: 1024/689 06:42:11 INFO - PROCESS | 1663 | __metrics 06:42:11 INFO - PROCESS | 1663 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 06:42:11 INFO - PROCESS | 1663 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:42:12 INFO - TEST-INFO | 1663: exit 0 06:42:12 INFO - Browser initialized. 06:42:12 INFO - Running cycle 1/1 for dromaeo_css test... 06:42:12 INFO - TEST-INFO | started process 1666 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/tmp4JsjGO/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:42:24 INFO - PROCESS | 1666 | RSS: Main: 243589120 06:42:24 INFO - PROCESS | 1666 | 06:43:15 INFO - PROCESS | 1666 | 1470836595469 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] 06:45:28 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49279/tests/dromaeo/cssquery-ext.html) 06:45:30 INFO - PROCESS | 1666 | RSS: Main: 342941696 06:45:30 INFO - PROCESS | 1666 | 06:48:32 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-ext.html (next: http://localhost:49279/tests/dromaeo/cssquery-jquery.html) 06:48:33 INFO - PROCESS | 1666 | RSS: Main: 419627008 06:48:33 INFO - PROCESS | 1666 | 06:51:35 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49279/tests/dromaeo/cssquery-mootools.html) 06:51:36 INFO - PROCESS | 1666 | RSS: Main: 379281408 06:51:36 INFO - PROCESS | 1666 | 06:54:38 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49279/tests/dromaeo/cssquery-prototype.html) 06:54:39 INFO - PROCESS | 1666 | RSS: Main: 358977536 06:54:39 INFO - PROCESS | 1666 | 06:57:42 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49279/tests/dromaeo/cssquery-yui.html) 06:57:43 INFO - PROCESS | 1666 | RSS: Main: 343932928 06:57:43 INFO - PROCESS | 1666 | 07:00:46 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-yui.html (next: http://localhost:49279/tests/dromaeo/cssquery-dojo.html) 07:00:46 INFO - PROCESS | 1666 | RSS: Main: 410230784 07:00:46 INFO - PROCESS | 1666 | 07:00:46 INFO - PROCESS | 1666 | __start_tp_report 07:00:46 INFO - PROCESS | 1666 | _x_x_mozilla_page_load 07:00:46 INFO - PROCESS | 1666 | _x_x_mozilla_page_load_details 07:00:46 INFO - PROCESS | 1666 | |i|pagename|runs| 07:00:46 INFO - PROCESS | 1666 | |0;dojo.html;3319.4025075486416;3356.664333566642;3379.4254976653965;3386.8475918583667;3421.2815308785152;5477.863053423666;5570.498655121039;5604.439556044394;5673.943260567393;5675.460831221033;5574.303212098488;5672.5178359839465;5680.431956804317;5691.800786972457;5779.21980532628;4983.900321993558;5151.4075881273575;5203.271541984134;5232;5255.658382205163;4575.656825738066;5138.743062846861;5271.947280527184;5346.117890548055;5359.758810853501;5258.421573626898;5263.947360526384;5272.340957380327;5291.100512912795;5321.068812957717;5100.591952643779;5141.820036298712;5233.136532472137;5247.265382846424;5257.237700533439;5117.82087626935;5179.223116532513;5192.532672059533;5193;5199.064168449678;5609.859753506154;5620.325560932673;5623.49388555028;5631.380548139701;5632.957902787997;6068.597629500875;6083.756649734005;6097.390260973867;6112.969435152841;6136.7545298188015;6118.9694051529905;6129.632222066645;6199.442050215503;6240.188775459206;6283.717232724538;5683.403242659461;5745.971270143665;5773.509251713609;5792.362840087587;5811.27359080115;6166.506679465632;6247.531435142291;6263.060540918807;6363.045543168561;6385.776497822554;5994.880102397928;6031.457168854824;6074.179985701962;6093.573449858556;6102.389761023951;6179.980303249913;6219.564630475823;6228.56400051992;6240.906386404207;6245.906311405332;5927.466528012414;6141.201643786279;6142.140100385949;6163.476104531165;6165.167702360213;5992.730327135289;5994.6403215807195;6057.636541807506;6073.210482637317;6079.0273556230795;4837.782299796518;4848.612111031109;4852.102361063215;4852.830150944771;4854.660173787872;4284.528701842857;4385.122975404932;4414.3157810539415;4423.292273236267;4445.155420470165;4979.726115063706;5594.944050559524;5725.484706376446;5743.798967036218;5755.22304488897;6254.34329395416;6275.843103922347;6276.435120839146;6289.308176100625;6310.05349197624;5554.444555544414;5609.691466969274;5629.6903670298525;5673.177389278531;5703.429657034263;5378.300820893259;5388.245645609618;5394.3796463406425;5412.729363531807;5441.483059109458;6365.936340636535;6370.108184854124;6375.203099612549;6382.170317858649;6387.329330420332;6119.969400152971;6155.907661385172;6252.9062064069985;6276.686165691788;6301.684915754286;6293.37066293367;6328.6202827830475;6342.207224096988;6383.585066970632;6392.0731493934045;6135.447809697149;6137.447629713347;6150.815475535741;6165.630062196283;6175.567710260419;5977.491913187428;6225;6249.406306400884;6252.468540174136;6264.31092579825;5932.733027013708;5939.910901336397;5960.910586341121;6029.306629737636;6057.182280392267;5986.191864098291;5988.9818730814995;5997.520198384206;6022;6036.456718895321;5626.2967129108865;5824.796132135355;5853.531717462508;5896.64620122794;5897.675627840338;5955.5235581154275;5987.072003839412;6012.549058820693;6062.939370606237;6092.634441933498;4844.4186697596515;5831.620944638585;5848.56135789826;5857.707114644166;5872.236609240771 07:00:46 INFO - PROCESS | 1666 | |1;ext.html;479.1112486337843;514.6346094273066;521.1063026908853;524.1220954900541;531.9468053194681;30553;40376.1924761505;41476.79261603695;41506.7924660377;44229.115417691624;43083;43397.56602433975;43401;43410;43567.34648980268;9593.616255349794;9799.412035277906;9807.852882206773;9808.558614862348;9819.852702209473;9682;9767.267454940873;9770.755731106743;9777.804443911118;9793.412395256308;9743.610255589769;9786.90213097867;9811;9818.558164882561;9822.508874556279;9749.658761943334;9790.020997900225;9795.510224488818;9796.26528010402;9838.606455741727;9649.758756031086;9703.61185552577;9715.125638692552;9719.56261968213;9723.708288751279;40790.796046019874;40984.590154098376;41110.1777964439;41137.382939255935;41319;3287.572615559986;3408.216110294646;3426;3453.015890471204;3553;31554.526682099786;32858.01425957225;32916.341673166644;33053.504197437054;33146.6685333146;3139.576157218769;3179.82510961897;3361.3613413451367;3376.2909788944353;3381.746369022333;475479;480200;481287;482330;487334;58124.4187558119;58408.41591584115;58420.415795842346;58556.70721646365;58564.414355856745;61782;61783.382166178664;61828.69085654543;61846;61940.380596194365;16119.194040297938;16334.428295009619;16363.59091022734;16408;16420.75368869468;12902.870971290167;12970.481180752853;12970.80543791844;12971.221726696429;13027.739445211233;15389;16097.67804643924;16148.838511614733;16193.757093643604;16277.511674649779;5975.40245975399;6006.279246490449;6035.849103772353;6038.788642397495;6073.362296958844;669.4402983224272;680.3128839871765;721.6247551273309;733.9028152911432;757.6401209425479;30495.93264235741;30699;30789.538156927665;31100.755969760958;31391.686083138877;897.5198268926093;1051.1800795379615;1052.4369462337613;1078.428432930548;1143.422571601336;15706;15939.011816956125;16007.462500436457;16039.037657740573;16067.598310042342;611470;618319;618593;618769;620053;58419;58439.70780146072;58518.53703657357;58548;58615.82768344609;1207.3299318878107;1331.9800202996962;1370.9657258568616;1385.6051025457696;1390.464671101613;29480.852595737742;29652.406951860412;29827.552586711652;30497.54253686152;30950.448813370236;42409.36385954275;43421.78289108534;51220;51904.48095519147;51954.96090078253;565454;568352;568984;569583;569828;39831.60168398395;39862.800685996386;39992.8000360008;40680.38979415252;40925.181496370504;39787.602123979545;47476.28785568288;47525;48798;50299.24551131663;30726.692733072385;40337.79534632974;41250.79374603108;41366.1726765469;41604.167916640894;39329.606703933736;39979.40030899597;39988.400173997994;40596.1880762389;41317.58682413137;33197.668023320424;33505;33587.328253435284;34155;38996.83009509719;26912.730872691023;35347.46978795269;36005.0998725034;36359.27281454409;36958.260834783694;25551.872240638677;25814.483710326065;25879;26562.601560976986;27768.305792355353 07:00:46 INFO - PROCESS | 1666 | |2;jquery.html;363.86900715742337;367.5681074737183;374.2253535182172;389.69019629394626;390.7948327128257;16078.437254696088;20266.189352425903;20390.898045509788;21215.57568848622;21488.677669834964;19954.102065407056;20185.899070504627;20816.271430499935;20860.582788344225;21106.366808995717;5149.433562308143;5751.856203594913;5906.704664766766;5971.850703732398;5988.161657367972;4187.392828039932;4326.6754993375625;4410.955890441087;4412.4925633552075;5915.290165180184;4290.892727681818;4312.63342615878;4317.892052698692;4581.587657110859;6615.206175258975;6663.866722665543;6710.16122984627;6715.764948226789;6720.59676419414;6723.29405412432;5526.944730552683;5697.430256974311;5739.885202295973;5747.59766816323;5748.310202775652;25341;25914.87042564794;25976.350591235183;25981.870090649616;26200.73799262002;2193.1885202475187;2348.56551537966;2362.5038741864228;2416.613341865293;2523.735007824189;15101.018433801877;15776;15891.205439727968;15914.010748656417;16134.951228170132;1657.411618875294;1863.4130248971667;1930.951726206842;1936.6126774644986;1976.8517361197967;94224;97626.51186744092;118211.63576728589;118549.40725296404;118594;10291.845622315672;10501.159907207406;10596.364218146782;10766.846630673897;10910.781784364426;13203.537876174289;13208.273544954927;13209.73580528384;13222.140560863512;13240.006999475077;8183.590820458953;8489.066202717697;8516.190961858614;8571.314294856396;8632.697855575025;8632;8632.482051076955;8635.525046122524;8827.514486703165;8859.158379953895;6352.333005034498;6453.709583068773;6455.8379491691;6467.773627923;6584.473242140617;1760.7710997570234;1823.2342416185234;1827.7532533108126;1845.5755176309524;1860.851131909444;752.3003606645763;905.5517518828223;913.9131782480654;923.9630414783468;990.757264470195;16850.91574542144;20414.38756837297;22249.66625500619;22254.109835606396;22403.43991400228;795.431266644352;916.4776077635684;967.3615413826841;1018.3228153278135;1047.350642601592;9218.172344490511;11396;11537.826932596017;11779.941100294614;11801.763964720829;572728;583812;587512;590830;603029;75963;93431.53284233535;112757.43621282004;113748;118115;951.1344676344494;967.4002118686459;988.2341185581232;989.2728844299434;996.5864166370875;19647.508812279237;20054.298099566444;20085.49786255355;20155.496112597302;20179.495512612302;49312.75343623402;53239.20141197963;53444.73277633587;53970.460295396544;54990.725046374515;66383.00425493525;70747.23131921743;72709.63645181741;73804.63097684477;76015.23984760081;7677.731279405194;7810.062792464941;7961.164077771982;7986.480878742863;8056.912316837152;12989.935050324688;13161.60515184546;13187.934060329637;13198.934005329911;13555.728885422433;11317.094632429551;11371.31772093677;11429.59996400122;11491.195616306779;11590.246633968765;11308.717282068013;11462.312261264351;11527.942360288145;11701.76596468083;11733.706657333634;9160.175584197454;11477.426128693698;11517.481713322753;11783.410829458664;11902.523899044287;7252.5648461092505;7554.471187016856;7909.802254943673;7945.562994035153;8035.638396272065;9720.368176068816;11293;11312.264702794291;11583.826655845987;11663.183577149519 07:00:46 INFO - PROCESS | 1666 | |3;mootools.html;1496.9401223951043;1511.5843143135637;1656.320908427545;1764.9911750441245;1822.4805930309865;7480.13978392485;7752;7968;8468.576571171448;8471.491710497367;6950.617716025617;7994.520328780277;8245.83508329833;8305.377096717755;8312.54281014544;2151.5051538146195;2195.637719776235;2196.0556960506974;2196.2642514757576;2196.7803219677985;1891.4703882912806;1962.9509262268414;2145.731783527059;2181.0512427094263;2190.463336482564;2109.5253567947243;2182.879941603211;2186.35502526755;2186.7157269555014;2188.4528867783056;2144.9249276275254;2175.184305885293;2176.2491940280497;2180.4439867833757;2185.978140218609;2159.84881058326;2169.8264138868853;2178.1396348442277;2179.08478439056;2180.531185795046;8353.457025293337;8426.452280601803;8432.40973131881;8443.535605541692;8478.279346255576;4939.110960027194;5002.59979201663;5079.390473143247;5083.440821509631;5088.491150884882;3244.756643251742;3414.5219669246326;3466.2201004773974;3467.133216695826;3476.443768996948;987.6247026130096;1024.8975102489767;1026.1534234256767;1042.5777560088177;1045.8065257927308;10721.249512534127;10803.945980270048;10809.837852432142;10810.135189184846;10824.999999999922;3459.60214575322;4301.569843015736;4406.515283318832;4484.68607197493;4485.730856148576;9347.626094956126;9353.90646093544;9354.906450935403;9356.578953947088;9357.485338306322;4999.175136102575;5000.89998200034;5006.199008158677;5007.499250075036;5018.247262910592;4071.877843664695;4545.931811022837;4579.6794224403975;4589.151007063704;4600.148972440109;3064.264576501668;3590.5817202204985;3735.1969326594913;3739.5886452490204;3797.316483033025;1094.7482079121846;1131.8472006279046;1177.12892459581;1195.1454709882476;1206.9577564785366;746.8356961468468;843.9156084391511;878.4816957994814;880.106691707917;880.506916126971;5486.1770734389365;5524.364698059774;5658.603897727202;5674.460926212003;5749.913751293734;929.1916033051289;932.8460803967405;932.9020452852353;944.7449188719007;970.0396607358805;3217.533457648628;3481.9651803482147;3713.795741234204;3853.7687738735767;3876.8836934891997;9938.155256803253;10063.04401081896;10157.898421015696;10162.510185004721;10228.53971571281;10138.746531336776;10144.239182061376;10156.4921753912;10157.085862272432;10162.898371016196;7655.004849369547;7869.763907082796;7877.251661092187;7890;7892.368610511146;5453.209284653783;5584.441555844383;5680.346760122474;5698.373178950395;5760.473474529337;9422.29332800029;9446.763830904007;9566.90433095688;9570.617175313188;9593;9295.488748118918;9507.524623768646;9650;9695;9703.12671859536;5780.768769249183;7224.313690199423;7246.1666908306215;7268.236835132235;7385.9630701846145;8006.039275287003;8092.757217283491;8106.270435660819;8122.065962414398;8130.268275855202;7093.609851458219;7172.569645821268;7181.35367816899;7242.637868106679;7282.235365286569;7027.543209691354;7065.187503437171;7086.149662040382;7101.609411482418;7131.607761573163;6331.145295385064;6548;6612.107365505595;6667.999800030035;6681.1314529110905;4698.671093023456;4719.457262414866;4746.525347465225;4786.664933454625;4841.201201801663;4700.811967521261;4721.032188401438;4836.371271734652;4858.781354839111;4988.977259661833 07:00:46 INFO - PROCESS | 1666 | |4;prototype.html;289.07640089912724;289.64373820201155;303.0877060049252;306.0558178020806;308.1787037544943;4166.500019997597;5208.427073021974;5224.838972421682;5249.186376111704;5304.363476382835;4618.976905115478;4972.900541989158;5155.891483331083;5193.558547523456;5228.843134705965;4005.8783540608674;4009.8997525061814;4017.3127286539725;4018.839246430139;4025.476688030552;3269.6076470823537;3802.372608519591;4003.8589002134254;4015.638592526672;4045.1707399982934;3030.8937237908226;3175.4442972479837;3673.0633688409416;3695.297893400259;3963.8198990555225;3935.291647503448;3937.744046636974;3938.7833669148185;3941.8423263069444;3962.0094976255937;2622.645942797736;3220.259340351709;3247.1882029492626;3356.580427446569;3389.57630296213;4406.889827754299;4594.724316541018;5035.295058691786;5039.79840806371;5046.62150338726;4450.01974121516;4460.643148548141;4466.508684044752;4468.75421851798;4480.955190448119;5093.770780314895;5318.574514038867;5483.287172667568;5488.286522752017;5497.587680923907;3298.993806888898;3716.9442458363146;3729.1050147964293;3732.122951106488;3735.719821013408;4367.890802729926;4923.556879880792;5451.318585176853;5684.067417078172;5730.799422020209;3111.3621707549896;3756.286305601927;3771.2080463103057;3777.8855237704943;3826.234753049401;3400.9489857652156;3626.709863210937;3790.8104594770152;3841.3469710149343;3853.190829925691;4456.554344565518;4457.286834106592;4466.218411777991;4472.888177795581;4502.639788816887;5460.590455715837;5545.0018996581;5552.69460179694;5570.192322113352;5571.832845014656;1060.6605886116522;1253.1165528302524;1299.6685845109625;1308.6390154239484;1321.2336844630283;632.5951391109694;744.8435828476081;786.1980779604885;799.4124318625805;800.6477150053958;3756.3050835595504;4023.1752490739327;4363.694541382073;4367.6287515561535;4404.955950440454;4465.486469056035;4748.810047598126;4759.904801904012;4761.785719642625;4807.788417328068;3847.1533663841515;4096.446979657708;4114.938275925863;4173.478315210598;4319.654427645781;2150.7419109706934;2404.759524047616;2492.551340758681;2522.675595312439;2555.425029368377;4117.435374557649;4199.68502362324;4345.913081738411;4497.595216430537;4755.550891290988;4119.485064366954;4541.750203738826;4579.885502862388;4852.975735121302;4934.703917764874;3994.9201015979515;4290.485141783006;4624.722516649012;4819.7108173510405;4915.336429581961;3984.541777695602;4194.5386007539755;4237.385579091077;4507.301368287921;4733.739634329131;4224.91550169001;4431.6261958792875;4699.530046995274;4720.787564559534;4732.0125547269545;4409.426774519292;4469.882529367658;4540.06928579647;4622.791974361095;4783.9521604784895;2959.718826711459;3277.2462333662916;3299.9010029699148;3536.5756109267054;3654.4883716280274;4490.663200260059;5033.2701758245585;5543.307086614173;5702.857428564319;5729.341125770589;4581.473130590025;4672.018876036071;5262.657927234717;5584.398063249263;5596.328440586993;4954.4797796232315;5053.0399224147295;5426.67439953604;5441.972790136024;5517.620594851287;5364.597655175956;5371.5702743781185;5384.811531596375;5387.380451248;5437.809676661298;5030.62270329734;5530.281063461724;5538.390777014606;5564.10974244119;5567.4432556744005;4877.878053048702;4963.709435546712;5006.824761133488;5040.722760248222;5379.1662292344745 07:00:46 INFO - PROCESS | 1666 | |5;yui.html;705.217208898123;729.5476804381284;732.2128711634994;767.2519293688653;782.4444644302545;14967.625809354771;16398.91800540997;16432.342706291733;16458.423955161572;16477.340906363763;14787.92606036971;14974.475893343735;14979.101253924771;14985.025973311727;14989;653.6894974886939;674.298729321505;676.7022510095567;678.9592624442524;816.9387295952813;681.5059082165416;685.4824607421415;822.5106061893164;844.2486187293314;852.1861622150863;759.2521366454039;884.5798245833242;892.5760263874672;895.5880295064278;903.1059251341158;891.3092353426082;891.6433426629335;895.3150839607705;896.8206358728248;897.5153417154729;509.97450127493846;657.9276279609239;659.9406053455212;661.566673828643;663.2604645819877;13270.601881943558;13742.93128534361;13750.243736594482;13868.653283667989;13870.722585548334;14294.285285735672;14913.552593422215;14931.626709332246;14937.551873443705;14937.925310373486;9727.708168754949;11812.29126252419;12130.818037729441;12153.270803751802;12459.439325230296;3871.8838434847;3898.8830335089992;3905.082305658168;3930.155016671401;3988.222296652154;104231;105591.27313449202;105972;110824.4458777701;111304;11042.834357484644;11166.218364714392;11262.831057534144;11325.207235493437;11477.615957415015;20242.583019188514;21629.78370216309;22933.967971441325;22935.885320573623;23015.7698423017;6646.933530664728;7602.163761986177;7928.7224947127725;8006.799830004296;8038.075621303625;4444.82220711168;4493.370928070073;4634.675572709878;4699.953000469952;4749.95250047502;3252.902412927616;3609.6751292383287;3691.3909204981414;3745.194783121642;3747.868824591126;652.4831160047348;676.8781619308571;683.5830143612393;683.8153698501476;686.4542688562605;542.1867199201198;621.5400603553338;661.5501459007825;693.3551796828897;696.2098018748757;8901.421407608485;9066.863997040049;9352.111549402796;9450.716478505656;9532.237421006303;527.0616314049191;635.9364063593604;649.376598465469;675.321302091395;678.6064082831946;4151.709380343407;4653.883652908705;4659.743714095757;4691.366665500182;4727.125481785881;89747;91076.72308192348;94197;98881.022379552;151660;111387;119425;139385;140438;140599.5940040607;116502;120986;121003;121495;124195;8888;8984.505852177932;9013.60289155182;9063.909360906306;9242.399244049115;43511.56488435075;62984;64107;65975;66117.66941165263;60746;64380.67809660922;82825.58587207025;100284;102072;12056.578019769266;12150.75698486043;12292.877071229173;12333.50665973351;12397.132200746222;13088.476460941456;13700.588982330546;13706.24615646149;13764.449422023006;13993.510227142002;12237.632871013884;12398.194117382342;12481.56314528987;12753.553625623059;12830.10189286741;11922.463489142836;12118.93940530327;12169.939150304192;12260.203086799329;12385.19496232742;10027.899721002697;12121.454534546143;12140.33228172459;12305;12383.442745076673;10164.136048435967;10297.9485102574;10476.895231047592;10799.40603266828;10871.96716311949;8664;10029.548670309707;10289;10825.621103261348;10830.458477076272 07:00:46 INFO - PROCESS | 1666 | __end_tp_report 07:00:46 INFO - PROCESS | 1666 | __start_cc_report 07:00:46 INFO - PROCESS | 1666 | _x_x_mozilla_cycle_collect,1366 07:00:46 INFO - PROCESS | 1666 | __end_cc_report 07:00:46 INFO - PROCESS | 1666 | __startTimestamp1470837646510__endTimestamp 07:00:46 INFO - PROCESS | 1666 | 07:00:46 INFO - PROCESS | 1666 | ------- Summary: start ------- 07:00:46 INFO - PROCESS | 1666 | Number of tests: 6 07:00:46 INFO - PROCESS | 1666 | 07:00:46 INFO - PROCESS | 1666 | [#0] dojo.html Cycles:165 Average:5693.86 Median:5872.24 stddev:638.67 (10.9%) stddev-sans-first:612.86 07:00:46 INFO - PROCESS | 1666 | Values: 3319.4 3356.7 3379.4 3386.8 3421.3 5477.9 5570.5 5604.4 5673.9 5675.5 5574.3 5672.5 5680.4 5691.8 5779.2 4983.9 5151.4 5203.3 5232.0 5255.7 4575.7 5138.7 5271.9 5346.1 5359.8 5258.4 5263.9 5272.3 5291.1 5321.1 5100.6 5141.8 5233.1 5247.3 5257.2 5117.8 5179.2 5192.5 5193.0 5199.1 5609.9 5620.3 5623.5 5631.4 5633.0 6068.6 6083.8 6097.4 6113.0 6136.8 6119.0 6129.6 6199.4 6240.2 6283.7 5683.4 5746.0 5773.5 5792.4 5811.3 6166.5 6247.5 6263.1 6363.0 6385.8 5994.9 6031.5 6074.2 6093.6 6102.4 6180.0 6219.6 6228.6 6240.9 6245.9 5927.5 6141.2 6142.1 6163.5 6165.2 5992.7 5994.6 6057.6 6073.2 6079.0 4837.8 4848.6 4852.1 4852.8 4854.7 4284.5 4385.1 4414.3 4423.3 4445.2 4979.7 5594.9 5725.5 5743.8 5755.2 6254.3 6275.8 6276.4 6289.3 6310.1 5554.4 5609.7 5629.7 5673.2 5703.4 5378.3 5388.2 5394.4 5412.7 5441.5 6365.9 6370.1 6375.2 6382.2 6387.3 6120.0 6155.9 6252.9 6276.7 6301.7 6293.4 6328.6 6342.2 6383.6 6392.1 6135.4 6137.4 6150.8 6165.6 6175.6 5977.5 6225.0 6249.4 6252.5 6264.3 5932.7 5939.9 5960.9 6029.3 6057.2 5986.2 5989.0 5997.5 6022.0 6036.5 5626.3 5824.8 5853.5 5896.6 5897.7 5955.5 5987.1 6012.5 6062.9 6092.6 4844.4 5831.6 5848.6 5857.7 5872.2 07:00:46 INFO - PROCESS | 1666 | 07:00:46 INFO - PROCESS | 1666 | [#1] ext.html Cycles:180 Average:69444.19 Median:41421.48 stddev:149028.65 (359.8%) stddev-sans-first:149356.76 07:00:46 INFO - PROCESS | 1666 | Values: 479.1 514.6 521.1 524.1 531.9 30553.0 40376.2 41476.8 41506.8 44229.1 43083.0 43397.6 43401.0 43410.0 43567.3 9593.6 9799.4 9807.9 9808.6 9819.9 9682.0 9767.3 9770.8 9777.8 9793.4 9743.6 9786.9 9811.0 9818.6 9822.5 9749.7 9790.0 9795.5 9796.3 9838.6 9649.8 9703.6 9715.1 9719.6 9723.7 40790.8 40984.6 41110.2 41137.4 41319.0 3287.6 3408.2 3426.0 3453.0 3553.0 31554.5 32858.0 32916.3 33053.5 33146.7 3139.6 3179.8 3361.4 3376.3 3381.7 475479.0 480200.0 481287.0 482330.0 487334.0 58124.4 58408.4 58420.4 58556.7 58564.4 61782.0 61783.4 61828.7 61846.0 61940.4 16119.2 16334.4 16363.6 16408.0 16420.8 12902.9 12970.5 12970.8 12971.2 13027.7 15389.0 16097.7 16148.8 16193.8 16277.5 5975.4 6006.3 6035.8 6038.8 6073.4 669.4 680.3 721.6 733.9 757.6 30495.9 30699.0 30789.5 31100.8 31391.7 897.5 1051.2 1052.4 1078.4 1143.4 15706.0 15939.0 16007.5 16039.0 16067.6 611470.0 618319.0 618593.0 618769.0 620053.0 58419.0 58439.7 58518.5 58548.0 58615.8 1207.3 1332.0 1371.0 1385.6 1390.5 29480.9 29652.4 29827.6 30497.5 30950.4 42409.4 43421.8 51220.0 51904.5 51955.0 565454.0 568352.0 568984.0 569583.0 569828.0 39831.6 39862.8 39992.8 40680.4 40925.2 39787.6 47476.3 47525.0 48798.0 50299.2 30726.7 40337.8 41250.8 41366.2 41604.2 39329.6 39979.4 39988.4 40596.2 41317.6 33197.7 33505.0 33587.3 34155.0 38996.8 26912.7 35347.5 36005.1 36359.3 36958.3 25551.9 25814.5 25879.0 26562.6 27768.3 07:00:46 INFO - PROCESS | 1666 | 07:00:46 INFO - PROCESS | 1666 | [#2] jquery.html Cycles:180 Average:33816.22 Median:365.72 stddev:97348.51 (26618.4%) stddev-sans-first:97589.19 07:00:46 INFO - PROCESS | 1666 | Values: 363.9 367.6 374.2 389.7 390.8 16078.4 20266.2 20390.9 21215.6 21488.7 19954.1 20185.9 20816.3 20860.6 21106.4 5149.4 5751.9 5906.7 5971.9 5988.2 4187.4 4326.7 4411.0 4412.5 5915.3 4290.9 4312.6 4317.9 4581.6 6615.2 6663.9 6710.2 6715.8 6720.6 6723.3 5526.9 5697.4 5739.9 5747.6 5748.3 25341.0 25914.9 25976.4 25981.9 26200.7 2193.2 2348.6 2362.5 2416.6 2523.7 15101.0 15776.0 15891.2 15914.0 16135.0 1657.4 1863.4 1931.0 1936.6 1976.9 94224.0 97626.5 118211.6 118549.4 118594.0 10291.8 10501.2 10596.4 10766.8 10910.8 13203.5 13208.3 13209.7 13222.1 13240.0 8183.6 8489.1 8516.2 8571.3 8632.7 8632.0 8632.5 8635.5 8827.5 8859.2 6352.3 6453.7 6455.8 6467.8 6584.5 1760.8 1823.2 1827.8 1845.6 1860.9 752.3 905.6 913.9 924.0 990.8 16850.9 20414.4 22249.7 22254.1 22403.4 795.4 916.5 967.4 1018.3 1047.4 9218.2 11396.0 11537.8 11779.9 11801.8 572728.0 583812.0 587512.0 590830.0 603029.0 75963.0 93431.5 112757.4 113748.0 118115.0 951.1 967.4 988.2 989.3 996.6 19647.5 20054.3 20085.5 20155.5 20179.5 49312.8 53239.2 53444.7 53970.5 54990.7 66383.0 70747.2 72709.6 73804.6 76015.2 7677.7 7810.1 7961.2 7986.5 8056.9 12989.9 13161.6 13187.9 13198.9 13555.7 11317.1 11371.3 11429.6 11491.2 11590.2 11308.7 11462.3 11527.9 11701.8 11733.7 9160.2 11477.4 11517.5 11783.4 11902.5 7252.6 7554.5 7909.8 7945.6 8035.6 9720.4 11293.0 11312.3 11583.8 11663.2 07:00:46 INFO - PROCESS | 1666 | 07:00:46 INFO - PROCESS | 1666 | [#3] mootools.html Cycles:180 Average:5396.84 Median:5001.75 stddev:3031.54 (60.6%) stddev-sans-first:3025.88 07:00:46 INFO - PROCESS | 1666 | Values: 1496.9 1511.6 1656.3 1765.0 1822.5 7480.1 7752.0 7968.0 8468.6 8471.5 6950.6 7994.5 8245.8 8305.4 8312.5 2151.5 2195.6 2196.1 2196.3 2196.8 1891.5 1963.0 2145.7 2181.1 2190.5 2109.5 2182.9 2186.4 2186.7 2188.5 2144.9 2175.2 2176.2 2180.4 2186.0 2159.8 2169.8 2178.1 2179.1 2180.5 8353.5 8426.5 8432.4 8443.5 8478.3 4939.1 5002.6 5079.4 5083.4 5088.5 3244.8 3414.5 3466.2 3467.1 3476.4 987.6 1024.9 1026.2 1042.6 1045.8 10721.2 10803.9 10809.8 10810.1 10825.0 3459.6 4301.6 4406.5 4484.7 4485.7 9347.6 9353.9 9354.9 9356.6 9357.5 4999.2 5000.9 5006.2 5007.5 5018.2 4071.9 4545.9 4579.7 4589.2 4600.1 3064.3 3590.6 3735.2 3739.6 3797.3 1094.7 1131.8 1177.1 1195.1 1207.0 746.8 843.9 878.5 880.1 880.5 5486.2 5524.4 5658.6 5674.5 5749.9 929.2 932.8 932.9 944.7 970.0 3217.5 3482.0 3713.8 3853.8 3876.9 9938.2 10063.0 10157.9 10162.5 10228.5 10138.7 10144.2 10156.5 10157.1 10162.9 7655.0 7869.8 7877.3 7890.0 7892.4 5453.2 5584.4 5680.3 5698.4 5760.5 9422.3 9446.8 9566.9 9570.6 9593.0 9295.5 9507.5 9650.0 9695.0 9703.1 5780.8 7224.3 7246.2 7268.2 7386.0 8006.0 8092.8 8106.3 8122.1 8130.3 7093.6 7172.6 7181.4 7242.6 7282.2 7027.5 7065.2 7086.1 7101.6 7131.6 6331.1 6548.0 6612.1 6668.0 6681.1 4698.7 4719.5 4746.5 4786.7 4841.2 4700.8 4721.0 4836.4 4858.8 4989.0 07:00:46 INFO - PROCESS | 1666 | 07:00:46 INFO - PROCESS | 1666 | [#4] prototype.html Cycles:180 Average:4141.27 Median:4466.36 stddev:1276.36 (28.6%) stddev-sans-first:1246.76 07:00:46 INFO - PROCESS | 1666 | Values: 289.1 289.6 303.1 306.1 308.2 4166.5 5208.4 5224.8 5249.2 5304.4 4619.0 4972.9 5155.9 5193.6 5228.8 4005.9 4009.9 4017.3 4018.8 4025.5 3269.6 3802.4 4003.9 4015.6 4045.2 3030.9 3175.4 3673.1 3695.3 3963.8 3935.3 3937.7 3938.8 3941.8 3962.0 2622.6 3220.3 3247.2 3356.6 3389.6 4406.9 4594.7 5035.3 5039.8 5046.6 4450.0 4460.6 4466.5 4468.8 4481.0 5093.8 5318.6 5483.3 5488.3 5497.6 3299.0 3716.9 3729.1 3732.1 3735.7 4367.9 4923.6 5451.3 5684.1 5730.8 3111.4 3756.3 3771.2 3777.9 3826.2 3400.9 3626.7 3790.8 3841.3 3853.2 4456.6 4457.3 4466.2 4472.9 4502.6 5460.6 5545.0 5552.7 5570.2 5571.8 1060.7 1253.1 1299.7 1308.6 1321.2 632.6 744.8 786.2 799.4 800.6 3756.3 4023.2 4363.7 4367.6 4405.0 4465.5 4748.8 4759.9 4761.8 4807.8 3847.2 4096.4 4114.9 4173.5 4319.7 2150.7 2404.8 2492.6 2522.7 2555.4 4117.4 4199.7 4345.9 4497.6 4755.6 4119.5 4541.8 4579.9 4853.0 4934.7 3994.9 4290.5 4624.7 4819.7 4915.3 3984.5 4194.5 4237.4 4507.3 4733.7 4224.9 4431.6 4699.5 4720.8 4732.0 4409.4 4469.9 4540.1 4622.8 4784.0 2959.7 3277.2 3299.9 3536.6 3654.5 4490.7 5033.3 5543.3 5702.9 5729.3 4581.5 4672.0 5262.7 5584.4 5596.3 4954.5 5053.0 5426.7 5442.0 5517.6 5364.6 5371.6 5384.8 5387.4 5437.8 5030.6 5530.3 5538.4 5564.1 5567.4 4877.9 4963.7 5006.8 5040.7 5379.2 07:00:46 INFO - PROCESS | 1666 | 07:00:46 INFO - PROCESS | 1666 | [#5] yui.html Cycles:180 Average:23425.29 Median:3809.88 stddev:36947.32 (969.8%) stddev-sans-first:37011.58 07:00:46 INFO - PROCESS | 1666 | Values: 705.2 729.5 732.2 767.3 782.4 14967.6 16398.9 16432.3 16458.4 16477.3 14787.9 14974.5 14979.1 14985.0 14989.0 653.7 674.3 676.7 679.0 816.9 681.5 685.5 822.5 844.2 852.2 759.3 884.6 892.6 895.6 903.1 891.3 891.6 895.3 896.8 897.5 510.0 657.9 659.9 661.6 663.3 13270.6 13742.9 13750.2 13868.7 13870.7 14294.3 14913.6 14931.6 14937.6 14937.9 9727.7 11812.3 12130.8 12153.3 12459.4 3871.9 3898.9 3905.1 3930.2 3988.2 104231.0 105591.3 105972.0 110824.4 111304.0 11042.8 11166.2 11262.8 11325.2 11477.6 20242.6 21629.8 22934.0 22935.9 23015.8 6646.9 7602.2 7928.7 8006.8 8038.1 4444.8 4493.4 4634.7 4700.0 4750.0 3252.9 3609.7 3691.4 3745.2 3747.9 652.5 676.9 683.6 683.8 686.5 542.2 621.5 661.6 693.4 696.2 8901.4 9066.9 9352.1 9450.7 9532.2 527.1 635.9 649.4 675.3 678.6 4151.7 4653.9 4659.7 4691.4 4727.1 89747.0 91076.7 94197.0 98881.0 151660.0 111387.0 119425.0 139385.0 140438.0 140599.6 116502.0 120986.0 121003.0 121495.0 124195.0 8888.0 8984.5 9013.6 9063.9 9242.4 43511.6 62984.0 64107.0 65975.0 66117.7 60746.0 64380.7 82825.6 100284.0 102072.0 12056.6 12150.8 12292.9 12333.5 12397.1 13088.5 13700.6 13706.2 13764.4 13993.5 12237.6 12398.2 12481.6 12753.6 12830.1 11922.5 12118.9 12169.9 12260.2 12385.2 10027.9 12121.5 12140.3 12305.0 12383.4 10164.1 10297.9 10476.9 10799.4 10872.0 8664.0 10029.5 10289.0 10825.6 10830.5 07:00:46 INFO - PROCESS | 1666 | -------- Summary: end -------- 07:00:46 INFO - PROCESS | 1666 | 07:00:47 INFO - TEST-INFO | 1666: exit 0 07:00:47 INFO - TEST-OK | dromaeo_css | took 1117749ms 07:00:47 INFO - TEST-START | kraken 07:00:47 INFO - operating with platform_type : mac_ 07:00:47 INFO - Initialising browser for kraken test... 07:00:47 INFO - TEST-INFO | started process 1672 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/tmp1_OF3o/profile http://localhost:49279/getInfo.html) 07:00:49 INFO - PROCESS | 1672 | __metrics Screen width/height:1600/1200 07:00:49 INFO - PROCESS | 1672 | colorDepth:24 07:00:49 INFO - PROCESS | 1672 | Browser inner width/height: 1024/689 07:00:49 INFO - PROCESS | 1672 | __metrics 07:00:49 INFO - PROCESS | 1672 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 07:00:49 INFO - PROCESS | 1672 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:00:50 INFO - TEST-INFO | 1672: exit 0 07:00:50 INFO - Browser initialized. 07:00:50 INFO - Running cycle 1/1 for kraken test... 07:00:50 INFO - TEST-INFO | started process 1673 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/tmp1_OF3o/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:01:02 INFO - PROCESS | 1673 | RSS: Main: 243589120 07:01:02 INFO - PROCESS | 1673 | 07:01:05 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49279/tests/kraken/driver.html?testName=audio-beat-detection) 07:01:06 INFO - PROCESS | 1673 | RSS: Main: 293195776 07:01:06 INFO - PROCESS | 1673 | 07:01:08 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49279/tests/kraken/driver.html?testName=audio-dft) 07:01:09 INFO - PROCESS | 1673 | RSS: Main: 299483136 07:01:09 INFO - PROCESS | 1673 | 07:01:12 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49279/tests/kraken/driver.html?testName=audio-fft) 07:01:13 INFO - PROCESS | 1673 | RSS: Main: 394960896 07:01:13 INFO - PROCESS | 1673 | 07:01:15 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49279/tests/kraken/driver.html?testName=audio-oscillator) 07:01:16 INFO - PROCESS | 1673 | RSS: Main: 297533440 07:01:16 INFO - PROCESS | 1673 | 07:01:18 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49279/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:01:18 INFO - PROCESS | 1673 | RSS: Main: 301355008 07:01:18 INFO - PROCESS | 1673 | 07:01:21 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49279/tests/kraken/driver.html?testName=imaging-darkroom) 07:01:22 INFO - PROCESS | 1673 | RSS: Main: 339611648 07:01:22 INFO - PROCESS | 1673 | 07:01:25 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49279/tests/kraken/driver.html?testName=imaging-desaturate) 07:01:25 INFO - PROCESS | 1673 | RSS: Main: 341258240 07:01:25 INFO - PROCESS | 1673 | 07:01:28 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49279/tests/kraken/driver.html?testName=json-parse-financial) 07:01:29 INFO - PROCESS | 1673 | RSS: Main: 339173376 07:01:29 INFO - PROCESS | 1673 | 07:01:30 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49279/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:01:31 INFO - PROCESS | 1673 | RSS: Main: 314163200 07:01:31 INFO - PROCESS | 1673 | 07:01:33 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:01:33 INFO - PROCESS | 1673 | RSS: Main: 320733184 07:01:33 INFO - PROCESS | 1673 | 07:01:36 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:01:36 INFO - PROCESS | 1673 | RSS: Main: 325828608 07:01:36 INFO - PROCESS | 1673 | 07:01:39 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:01:40 INFO - PROCESS | 1673 | RSS: Main: 330465280 07:01:40 INFO - PROCESS | 1673 | 07:01:43 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:01:44 INFO - PROCESS | 1673 | RSS: Main: 332816384 07:01:44 INFO - PROCESS | 1673 | 07:01:45 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49279/tests/kraken/driver.html?testName=ai-astar) 07:01:45 INFO - PROCESS | 1673 | RSS: Main: 376315904 07:01:45 INFO - PROCESS | 1673 | 07:01:45 INFO - PROCESS | 1673 | __start_tp_report 07:01:45 INFO - PROCESS | 1673 | _x_x_mozilla_page_load 07:01:45 INFO - PROCESS | 1673 | _x_x_mozilla_page_load_details 07:01:45 INFO - PROCESS | 1673 | |i|pagename|runs| 07:01:45 INFO - PROCESS | 1673 | |0;ai-astar;116;113;113;113;114;112;113;113;122;168 07:01:45 INFO - PROCESS | 1673 | |1;audio-beat-detection;137;120;104;175;92;122;133;106;161;137 07:01:45 INFO - PROCESS | 1673 | |2;audio-dft;185;182;183;184;185;184;183;186;184;180 07:01:45 INFO - PROCESS | 1673 | |3;audio-fft;80;56;65;88;57;57;65;66;84;56 07:01:45 INFO - PROCESS | 1673 | |4;audio-oscillator;82;68;102;71;75;70;126;100;98;100 07:01:45 INFO - PROCESS | 1673 | |5;imaging-gaussian-blur;91;86;90;88;91;87;90;88;90;86 07:01:45 INFO - PROCESS | 1673 | |6;imaging-darkroom;94;95;96;95;95;95;95;95;94;133 07:01:45 INFO - PROCESS | 1673 | |7;imaging-desaturate;87;84;83;86;84;84;85;82;84;86 07:01:45 INFO - PROCESS | 1673 | |8;json-parse-financial;56;52;51;54;52;52;53;52;53;52 07:01:45 INFO - PROCESS | 1673 | |9;json-stringify-tinderbox;65;103;112;83;74;69;71;70;68;70 07:01:45 INFO - PROCESS | 1673 | |10;stanford-crypto-aes;86;82;82;85;85;83;86;82;83;87 07:01:45 INFO - PROCESS | 1673 | |11;stanford-crypto-ccm;139;150;157;152;159;146;153;135;210;139 07:01:45 INFO - PROCESS | 1673 | |12;stanford-crypto-pbkdf2;165;165;169;164;162;214;231;162;162;158 07:01:45 INFO - PROCESS | 1673 | |13;stanford-crypto-sha256-iterative;66;67;67;66;66;68;66;65;64;66 07:01:45 INFO - PROCESS | 1673 | __end_tp_report 07:01:45 INFO - PROCESS | 1673 | __start_cc_report 07:01:45 INFO - PROCESS | 1673 | _x_x_mozilla_cycle_collect,2035 07:01:45 INFO - PROCESS | 1673 | __end_cc_report 07:01:45 INFO - PROCESS | 1673 | __startTimestamp1470837705946__endTimestamp 07:01:45 INFO - PROCESS | 1673 | 07:01:45 INFO - PROCESS | 1673 | ------- Summary: start ------- 07:01:45 INFO - PROCESS | 1673 | Number of tests: 14 07:01:45 INFO - PROCESS | 1673 | 07:01:45 INFO - PROCESS | 1673 | [#0] ai-astar Cycles:10 Average:119.70 Median:113.50 stddev:17.22 (15.2%) stddev-sans-first:18.21 07:01:45 INFO - PROCESS | 1673 | Values: 116.0 113.0 113.0 113.0 114.0 112.0 113.0 113.0 122.0 168.0 07:01:45 INFO - PROCESS | 1673 | 07:01:45 INFO - PROCESS | 1673 | [#1] audio-beat-detection Cycles:10 Average:128.70 Median:137.00 stddev:25.68 (18.7%) stddev-sans-first:27.06 07:01:45 INFO - PROCESS | 1673 | Values: 137.0 120.0 104.0 175.0 92.0 122.0 133.0 106.0 161.0 137.0 07:01:45 INFO - PROCESS | 1673 | 07:01:45 INFO - PROCESS | 1673 | [#2] audio-dft Cycles:10 Average:183.60 Median:184.00 stddev:1.71 (0.9%) stddev-sans-first:1.74 07:01:45 INFO - PROCESS | 1673 | Values: 185.0 182.0 183.0 184.0 185.0 184.0 183.0 186.0 184.0 180.0 07:01:45 INFO - PROCESS | 1673 | 07:01:45 INFO - PROCESS | 1673 | [#3] audio-fft Cycles:10 Average:67.40 Median:65.50 stddev:12.24 (18.7%) stddev-sans-first:12.10 07:01:45 INFO - PROCESS | 1673 | Values: 80.0 56.0 65.0 88.0 57.0 57.0 65.0 66.0 84.0 56.0 07:01:45 INFO - PROCESS | 1673 | 07:01:45 INFO - PROCESS | 1673 | [#4] audio-oscillator Cycles:10 Average:89.20 Median:70.50 stddev:18.95 (26.9%) stddev-sans-first:19.92 07:01:45 INFO - PROCESS | 1673 | Values: 82.0 68.0 102.0 71.0 75.0 70.0 126.0 100.0 98.0 100.0 07:01:45 INFO - PROCESS | 1673 | 07:01:45 INFO - PROCESS | 1673 | [#5] imaging-gaussian-blur Cycles:10 Average:88.70 Median:90.00 stddev:1.95 (2.2%) stddev-sans-first:1.88 07:01:45 INFO - PROCESS | 1673 | Values: 91.0 86.0 90.0 88.0 91.0 87.0 90.0 88.0 90.0 86.0 07:01:45 INFO - PROCESS | 1673 | 07:01:45 INFO - PROCESS | 1673 | [#6] imaging-darkroom Cycles:10 Average:98.70 Median:95.00 stddev:12.07 (12.7%) stddev-sans-first:12.68 07:01:45 INFO - PROCESS | 1673 | Values: 94.0 95.0 96.0 95.0 95.0 95.0 95.0 95.0 94.0 133.0 07:01:45 INFO - PROCESS | 1673 | 07:01:45 INFO - PROCESS | 1673 | [#7] imaging-desaturate Cycles:10 Average:84.50 Median:84.50 stddev:1.51 (1.8%) stddev-sans-first:1.30 07:01:45 INFO - PROCESS | 1673 | Values: 87.0 84.0 83.0 86.0 84.0 84.0 85.0 82.0 84.0 86.0 07:01:45 INFO - PROCESS | 1673 | 07:01:45 INFO - PROCESS | 1673 | [#8] json-parse-financial Cycles:10 Average:52.70 Median:52.50 stddev:1.42 (2.7%) stddev-sans-first:0.87 07:01:45 INFO - PROCESS | 1673 | Values: 56.0 52.0 51.0 54.0 52.0 52.0 53.0 52.0 53.0 52.0 07:01:45 INFO - PROCESS | 1673 | 07:01:45 INFO - PROCESS | 1673 | [#9] json-stringify-tinderbox Cycles:10 Average:78.50 Median:70.00 stddev:16.15 (23.1%) stddev-sans-first:16.37 07:01:45 INFO - PROCESS | 1673 | Values: 65.0 103.0 112.0 83.0 74.0 69.0 71.0 70.0 68.0 70.0 07:01:45 INFO - PROCESS | 1673 | 07:01:45 INFO - PROCESS | 1673 | [#10] stanford-crypto-aes Cycles:10 Average:84.10 Median:85.00 stddev:1.91 (2.2%) stddev-sans-first:1.90 07:01:45 INFO - PROCESS | 1673 | Values: 86.0 82.0 82.0 85.0 85.0 83.0 86.0 82.0 83.0 87.0 07:01:45 INFO - PROCESS | 1673 | 07:01:45 INFO - PROCESS | 1673 | [#11] stanford-crypto-ccm Cycles:10 Average:154.00 Median:152.50 stddev:21.26 (13.9%) stddev-sans-first:21.84 07:01:45 INFO - PROCESS | 1673 | Values: 139.0 150.0 157.0 152.0 159.0 146.0 153.0 135.0 210.0 139.0 07:01:45 INFO - PROCESS | 1673 | 07:01:45 INFO - PROCESS | 1673 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:175.20 Median:165.00 stddev:25.41 (15.4%) stddev-sans-first:26.68 07:01:45 INFO - PROCESS | 1673 | Values: 165.0 165.0 169.0 164.0 162.0 214.0 231.0 162.0 162.0 158.0 07:01:45 INFO - PROCESS | 1673 | 07:01:45 INFO - PROCESS | 1673 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.10 Median:66.00 stddev:1.10 (1.7%) stddev-sans-first:1.17 07:01:45 INFO - PROCESS | 1673 | Values: 66.0 67.0 67.0 66.0 66.0 68.0 66.0 65.0 64.0 66.0 07:01:45 INFO - PROCESS | 1673 | -------- Summary: end -------- 07:01:45 INFO - PROCESS | 1673 | 07:01:46 INFO - TEST-INFO | 1673: exit 0 07:01:46 INFO - TEST-OK | kraken | took 59607ms 07:01:46 INFO - SUITE-END | took 1177s 07:01:47 INFO - Completed test suite (00:19:37) 07:01:47 INFO - javascript benchmark 07:01:47 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3319.4025075486416, 3356.664333566642, 3379.4254976653965, 3386.8475918583667, 3421.2815308785152, 5477.863053423666, 5570.498655121039, 5604.439556044394, 5673.943260567393, 5675.460831221033, 5574.303212098488, 5672.5178359839465, 5680.431956804317, 5691.800786972457, 5779.21980532628, 4983.900321993558, 5151.4075881273575, 5203.271541984134, 5232.0, 5255.658382205163, 4575.656825738066, 5138.743062846861, 5271.947280527184, 5346.117890548055, 5359.758810853501, 5258.421573626898, 5263.947360526384, 5272.340957380327, 5291.100512912795, 5321.068812957717, 5100.591952643779, 5141.820036298712, 5233.136532472137, 5247.265382846424, 5257.237700533439, 5117.82087626935, 5179.223116532513, 5192.532672059533, 5193.0, 5199.064168449678, 5609.859753506154, 5620.325560932673, 5623.49388555028, 5631.380548139701, 5632.957902787997, 6068.597629500875, 6083.756649734005, 6097.390260973867, 6112.969435152841, 6136.7545298188015, 6118.9694051529905, 6129.632222066645, 6199.442050215503, 6240.188775459206, 6283.717232724538, 5683.403242659461, 5745.971270143665, 5773.509251713609, 5792.362840087587, 5811.27359080115, 6166.506679465632, 6247.531435142291, 6263.060540918807, 6363.045543168561, 6385.776497822554, 5994.880102397928, 6031.457168854824, 6074.179985701962, 6093.573449858556, 6102.389761023951, 6179.980303249913, 6219.564630475823, 6228.56400051992, 6240.906386404207, 6245.906311405332, 5927.466528012414, 6141.201643786279, 6142.140100385949, 6163.476104531165, 6165.167702360213, 5992.730327135289, 5994.6403215807195, 6057.636541807506, 6073.210482637317, 6079.0273556230795, 4837.782299796518, 4848.612111031109, 4852.102361063215, 4852.830150944771, 4854.660173787872, 4284.528701842857, 4385.122975404932, 4414.3157810539415, 4423.292273236267, 4445.155420470165, 4979.726115063706, 5594.944050559524, 5725.484706376446, 5743.798967036218, 5755.22304488897, 6254.34329395416, 6275.843103922347, 6276.435120839146, 6289.308176100625, 6310.05349197624, 5554.444555544414, 5609.691466969274, 5629.6903670298525, 5673.177389278531, 5703.429657034263, 5378.300820893259, 5388.245645609618, 5394.3796463406425, 5412.729363531807, 5441.483059109458, 6365.936340636535, 6370.108184854124, 6375.203099612549, 6382.170317858649, 6387.329330420332, 6119.969400152971, 6155.907661385172, 6252.9062064069985, 6276.686165691788, 6301.684915754286, 6293.37066293367, 6328.6202827830475, 6342.207224096988, 6383.585066970632, 6392.0731493934045, 6135.447809697149, 6137.447629713347, 6150.815475535741, 6165.630062196283, 6175.567710260419, 5977.491913187428, 6225.0, 6249.406306400884, 6252.468540174136, 6264.31092579825, 5932.733027013708, 5939.910901336397, 5960.910586341121, 6029.306629737636, 6057.182280392267, 5986.191864098291, 5988.9818730814995, 5997.520198384206, 6022.0, 6036.456718895321, 5626.2967129108865, 5824.796132135355, 5853.531717462508, 5896.64620122794, 5897.675627840338, 5955.5235581154275, 5987.072003839412, 6012.549058820693, 6062.939370606237, 6092.634441933498, 4844.4186697596515, 5831.620944638585, 5848.56135789826, 5857.707114644166, 5872.236609240771], "value": 5653.168088550603, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [479.1112486337843, 514.6346094273066, 521.1063026908853, 524.1220954900541, 531.9468053194681, 30553.0, 40376.1924761505, 41476.79261603695, 41506.7924660377, 44229.115417691624, 43083.0, 43397.56602433975, 43401.0, 43410.0, 43567.34648980268, 9593.616255349794, 9799.412035277906, 9807.852882206773, 9808.558614862348, 9819.852702209473, 9682.0, 9767.267454940873, 9770.755731106743, 9777.804443911118, 9793.412395256308, 9743.610255589769, 9786.90213097867, 9811.0, 9818.558164882561, 9822.508874556279, 9749.658761943334, 9790.020997900225, 9795.510224488818, 9796.26528010402, 9838.606455741727, 9649.758756031086, 9703.61185552577, 9715.125638692552, 9719.56261968213, 9723.708288751279, 40790.796046019874, 40984.590154098376, 41110.1777964439, 41137.382939255935, 41319.0, 3287.572615559986, 3408.216110294646, 3426.0, 3453.015890471204, 3553.0, 31554.526682099786, 32858.01425957225, 32916.341673166644, 33053.504197437054, 33146.6685333146, 3139.576157218769, 3179.82510961897, 3361.3613413451367, 3376.2909788944353, 3381.746369022333, 475479.0, 480200.0, 481287.0, 482330.0, 487334.0, 58124.4187558119, 58408.41591584115, 58420.415795842346, 58556.70721646365, 58564.414355856745, 61782.0, 61783.382166178664, 61828.69085654543, 61846.0, 61940.380596194365, 16119.194040297938, 16334.428295009619, 16363.59091022734, 16408.0, 16420.75368869468, 12902.870971290167, 12970.481180752853, 12970.80543791844, 12971.221726696429, 13027.739445211233, 15389.0, 16097.67804643924, 16148.838511614733, 16193.757093643604, 16277.511674649779, 5975.40245975399, 6006.279246490449, 6035.849103772353, 6038.788642397495, 6073.362296958844, 669.4402983224272, 680.3128839871765, 721.6247551273309, 733.9028152911432, 757.6401209425479, 30495.93264235741, 30699.0, 30789.538156927665, 31100.755969760958, 31391.686083138877, 897.5198268926093, 1051.1800795379615, 1052.4369462337613, 1078.428432930548, 1143.422571601336, 15706.0, 15939.011816956125, 16007.462500436457, 16039.037657740573, 16067.598310042342, 611470.0, 618319.0, 618593.0, 618769.0, 620053.0, 58419.0, 58439.70780146072, 58518.53703657357, 58548.0, 58615.82768344609, 1207.3299318878107, 1331.9800202996962, 1370.9657258568616, 1385.6051025457696, 1390.464671101613, 29480.852595737742, 29652.406951860412, 29827.552586711652, 30497.54253686152, 30950.448813370236, 42409.36385954275, 43421.78289108534, 51220.0, 51904.48095519147, 51954.96090078253, 565454.0, 568352.0, 568984.0, 569583.0, 569828.0, 39831.60168398395, 39862.800685996386, 39992.8000360008, 40680.38979415252, 40925.181496370504, 39787.602123979545, 47476.28785568288, 47525.0, 48798.0, 50299.24551131663, 30726.692733072385, 40337.79534632974, 41250.79374603108, 41366.1726765469, 41604.167916640894, 39329.606703933736, 39979.40030899597, 39988.400173997994, 40596.1880762389, 41317.58682413137, 33197.668023320424, 33505.0, 33587.328253435284, 34155.0, 38996.83009509719, 26912.730872691023, 35347.46978795269, 36005.0998725034, 36359.27281454409, 36958.260834783694, 25551.872240638677, 25814.483710326065, 25879.0, 26562.601560976986, 27768.305792355353], "value": 19899.99291326952, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [363.86900715742337, 367.5681074737183, 374.2253535182172, 389.69019629394626, 390.7948327128257, 16078.437254696088, 20266.189352425903, 20390.898045509788, 21215.57568848622, 21488.677669834964, 19954.102065407056, 20185.899070504627, 20816.271430499935, 20860.582788344225, 21106.366808995717, 5149.433562308143, 5751.856203594913, 5906.704664766766, 5971.850703732398, 5988.161657367972, 4187.392828039932, 4326.6754993375625, 4410.955890441087, 4412.4925633552075, 5915.290165180184, 4290.892727681818, 4312.63342615878, 4317.892052698692, 4581.587657110859, 6615.206175258975, 6663.866722665543, 6710.16122984627, 6715.764948226789, 6720.59676419414, 6723.29405412432, 5526.944730552683, 5697.430256974311, 5739.885202295973, 5747.59766816323, 5748.310202775652, 25341.0, 25914.87042564794, 25976.350591235183, 25981.870090649616, 26200.73799262002, 2193.1885202475187, 2348.56551537966, 2362.5038741864228, 2416.613341865293, 2523.735007824189, 15101.018433801877, 15776.0, 15891.205439727968, 15914.010748656417, 16134.951228170132, 1657.411618875294, 1863.4130248971667, 1930.951726206842, 1936.6126774644986, 1976.8517361197967, 94224.0, 97626.51186744092, 118211.63576728589, 118549.40725296404, 118594.0, 10291.845622315672, 10501.159907207406, 10596.364218146782, 10766.846630673897, 10910.781784364426, 13203.537876174289, 13208.273544954927, 13209.73580528384, 13222.140560863512, 13240.006999475077, 8183.590820458953, 8489.066202717697, 8516.190961858614, 8571.314294856396, 8632.697855575025, 8632.0, 8632.482051076955, 8635.525046122524, 8827.514486703165, 8859.158379953895, 6352.333005034498, 6453.709583068773, 6455.8379491691, 6467.773627923, 6584.473242140617, 1760.7710997570234, 1823.2342416185234, 1827.7532533108126, 1845.5755176309524, 1860.851131909444, 752.3003606645763, 905.5517518828223, 913.9131782480654, 923.9630414783468, 990.757264470195, 16850.91574542144, 20414.38756837297, 22249.66625500619, 22254.109835606396, 22403.43991400228, 795.431266644352, 916.4776077635684, 967.3615413826841, 1018.3228153278135, 1047.350642601592, 9218.172344490511, 11396.0, 11537.826932596017, 11779.941100294614, 11801.763964720829, 572728.0, 583812.0, 587512.0, 590830.0, 603029.0, 75963.0, 93431.53284233535, 112757.43621282004, 113748.0, 118115.0, 951.1344676344494, 967.4002118686459, 988.2341185581232, 989.2728844299434, 996.5864166370875, 19647.508812279237, 20054.298099566444, 20085.49786255355, 20155.496112597302, 20179.495512612302, 49312.75343623402, 53239.20141197963, 53444.73277633587, 53970.460295396544, 54990.725046374515, 66383.00425493525, 70747.23131921743, 72709.63645181741, 73804.63097684477, 76015.23984760081, 7677.731279405194, 7810.062792464941, 7961.164077771982, 7986.480878742863, 8056.912316837152, 12989.935050324688, 13161.60515184546, 13187.934060329637, 13198.934005329911, 13555.728885422433, 11317.094632429551, 11371.31772093677, 11429.59996400122, 11491.195616306779, 11590.246633968765, 11308.717282068013, 11462.312261264351, 11527.942360288145, 11701.76596468083, 11733.706657333634, 9160.175584197454, 11477.426128693698, 11517.481713322753, 11783.410829458664, 11902.523899044287, 7252.5648461092505, 7554.471187016856, 7909.802254943673, 7945.562994035153, 8035.638396272065, 9720.368176068816, 11293.0, 11312.264702794291, 11583.826655845987, 11663.183577149519], "value": 9587.07356440869, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1496.9401223951043, 1511.5843143135637, 1656.320908427545, 1764.9911750441245, 1822.4805930309865, 7480.13978392485, 7752.0, 7968.0, 8468.576571171448, 8471.491710497367, 6950.617716025617, 7994.520328780277, 8245.83508329833, 8305.377096717755, 8312.54281014544, 2151.5051538146195, 2195.637719776235, 2196.0556960506974, 2196.2642514757576, 2196.7803219677985, 1891.4703882912806, 1962.9509262268414, 2145.731783527059, 2181.0512427094263, 2190.463336482564, 2109.5253567947243, 2182.879941603211, 2186.35502526755, 2186.7157269555014, 2188.4528867783056, 2144.9249276275254, 2175.184305885293, 2176.2491940280497, 2180.4439867833757, 2185.978140218609, 2159.84881058326, 2169.8264138868853, 2178.1396348442277, 2179.08478439056, 2180.531185795046, 8353.457025293337, 8426.452280601803, 8432.40973131881, 8443.535605541692, 8478.279346255576, 4939.110960027194, 5002.59979201663, 5079.390473143247, 5083.440821509631, 5088.491150884882, 3244.756643251742, 3414.5219669246326, 3466.2201004773974, 3467.133216695826, 3476.443768996948, 987.6247026130096, 1024.8975102489767, 1026.1534234256767, 1042.5777560088177, 1045.8065257927308, 10721.249512534127, 10803.945980270048, 10809.837852432142, 10810.135189184846, 10824.999999999922, 3459.60214575322, 4301.569843015736, 4406.515283318832, 4484.68607197493, 4485.730856148576, 9347.626094956126, 9353.90646093544, 9354.906450935403, 9356.578953947088, 9357.485338306322, 4999.175136102575, 5000.89998200034, 5006.199008158677, 5007.499250075036, 5018.247262910592, 4071.877843664695, 4545.931811022837, 4579.6794224403975, 4589.151007063704, 4600.148972440109, 3064.264576501668, 3590.5817202204985, 3735.1969326594913, 3739.5886452490204, 3797.316483033025, 1094.7482079121846, 1131.8472006279046, 1177.12892459581, 1195.1454709882476, 1206.9577564785366, 746.8356961468468, 843.9156084391511, 878.4816957994814, 880.106691707917, 880.506916126971, 5486.1770734389365, 5524.364698059774, 5658.603897727202, 5674.460926212003, 5749.913751293734, 929.1916033051289, 932.8460803967405, 932.9020452852353, 944.7449188719007, 970.0396607358805, 3217.533457648628, 3481.9651803482147, 3713.795741234204, 3853.7687738735767, 3876.8836934891997, 9938.155256803253, 10063.04401081896, 10157.898421015696, 10162.510185004721, 10228.53971571281, 10138.746531336776, 10144.239182061376, 10156.4921753912, 10157.085862272432, 10162.898371016196, 7655.004849369547, 7869.763907082796, 7877.251661092187, 7890.0, 7892.368610511146, 5453.209284653783, 5584.441555844383, 5680.346760122474, 5698.373178950395, 5760.473474529337, 9422.29332800029, 9446.763830904007, 9566.90433095688, 9570.617175313188, 9593.0, 9295.488748118918, 9507.524623768646, 9650.0, 9695.0, 9703.12671859536, 5780.768769249183, 7224.313690199423, 7246.1666908306215, 7268.236835132235, 7385.9630701846145, 8006.039275287003, 8092.757217283491, 8106.270435660819, 8122.065962414398, 8130.268275855202, 7093.609851458219, 7172.569645821268, 7181.35367816899, 7242.637868106679, 7282.235365286569, 7027.543209691354, 7065.187503437171, 7086.149662040382, 7101.609411482418, 7131.607761573163, 6331.145295385064, 6548.0, 6612.107365505595, 6667.999800030035, 6681.1314529110905, 4698.671093023456, 4719.457262414866, 4746.525347465225, 4786.664933454625, 4841.201201801663, 4700.811967521261, 4721.032188401438, 4836.371271734652, 4858.781354839111, 4988.977259661833], "value": 4334.085101694621, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [289.07640089912724, 289.64373820201155, 303.0877060049252, 306.0558178020806, 308.1787037544943, 4166.500019997597, 5208.427073021974, 5224.838972421682, 5249.186376111704, 5304.363476382835, 4618.976905115478, 4972.900541989158, 5155.891483331083, 5193.558547523456, 5228.843134705965, 4005.8783540608674, 4009.8997525061814, 4017.3127286539725, 4018.839246430139, 4025.476688030552, 3269.6076470823537, 3802.372608519591, 4003.8589002134254, 4015.638592526672, 4045.1707399982934, 3030.8937237908226, 3175.4442972479837, 3673.0633688409416, 3695.297893400259, 3963.8198990555225, 3935.291647503448, 3937.744046636974, 3938.7833669148185, 3941.8423263069444, 3962.0094976255937, 2622.645942797736, 3220.259340351709, 3247.1882029492626, 3356.580427446569, 3389.57630296213, 4406.889827754299, 4594.724316541018, 5035.295058691786, 5039.79840806371, 5046.62150338726, 4450.01974121516, 4460.643148548141, 4466.508684044752, 4468.75421851798, 4480.955190448119, 5093.770780314895, 5318.574514038867, 5483.287172667568, 5488.286522752017, 5497.587680923907, 3298.993806888898, 3716.9442458363146, 3729.1050147964293, 3732.122951106488, 3735.719821013408, 4367.890802729926, 4923.556879880792, 5451.318585176853, 5684.067417078172, 5730.799422020209, 3111.3621707549896, 3756.286305601927, 3771.2080463103057, 3777.8855237704943, 3826.234753049401, 3400.9489857652156, 3626.709863210937, 3790.8104594770152, 3841.3469710149343, 3853.190829925691, 4456.554344565518, 4457.286834106592, 4466.218411777991, 4472.888177795581, 4502.639788816887, 5460.590455715837, 5545.0018996581, 5552.69460179694, 5570.192322113352, 5571.832845014656, 1060.6605886116522, 1253.1165528302524, 1299.6685845109625, 1308.6390154239484, 1321.2336844630283, 632.5951391109694, 744.8435828476081, 786.1980779604885, 799.4124318625805, 800.6477150053958, 3756.3050835595504, 4023.1752490739327, 4363.694541382073, 4367.6287515561535, 4404.955950440454, 4465.486469056035, 4748.810047598126, 4759.904801904012, 4761.785719642625, 4807.788417328068, 3847.1533663841515, 4096.446979657708, 4114.938275925863, 4173.478315210598, 4319.654427645781, 2150.7419109706934, 2404.759524047616, 2492.551340758681, 2522.675595312439, 2555.425029368377, 4117.435374557649, 4199.68502362324, 4345.913081738411, 4497.595216430537, 4755.550891290988, 4119.485064366954, 4541.750203738826, 4579.885502862388, 4852.975735121302, 4934.703917764874, 3994.9201015979515, 4290.485141783006, 4624.722516649012, 4819.7108173510405, 4915.336429581961, 3984.541777695602, 4194.5386007539755, 4237.385579091077, 4507.301368287921, 4733.739634329131, 4224.91550169001, 4431.6261958792875, 4699.530046995274, 4720.787564559534, 4732.0125547269545, 4409.426774519292, 4469.882529367658, 4540.06928579647, 4622.791974361095, 4783.9521604784895, 2959.718826711459, 3277.2462333662916, 3299.9010029699148, 3536.5756109267054, 3654.4883716280274, 4490.663200260059, 5033.2701758245585, 5543.307086614173, 5702.857428564319, 5729.341125770589, 4581.473130590025, 4672.018876036071, 5262.657927234717, 5584.398063249263, 5596.328440586993, 4954.4797796232315, 5053.0399224147295, 5426.67439953604, 5441.972790136024, 5517.620594851287, 5364.597655175956, 5371.5702743781185, 5384.811531596375, 5387.380451248, 5437.809676661298, 5030.62270329734, 5530.281063461724, 5538.390777014606, 5564.10974244119, 5567.4432556744005, 4877.878053048702, 4963.709435546712, 5006.824761133488, 5040.722760248222, 5379.1662292344745], "value": 3737.6378449975336, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [705.217208898123, 729.5476804381284, 732.2128711634994, 767.2519293688653, 782.4444644302545, 14967.625809354771, 16398.91800540997, 16432.342706291733, 16458.423955161572, 16477.340906363763, 14787.92606036971, 14974.475893343735, 14979.101253924771, 14985.025973311727, 14989.0, 653.6894974886939, 674.298729321505, 676.7022510095567, 678.9592624442524, 816.9387295952813, 681.5059082165416, 685.4824607421415, 822.5106061893164, 844.2486187293314, 852.1861622150863, 759.2521366454039, 884.5798245833242, 892.5760263874672, 895.5880295064278, 903.1059251341158, 891.3092353426082, 891.6433426629335, 895.3150839607705, 896.8206358728248, 897.5153417154729, 509.97450127493846, 657.9276279609239, 659.9406053455212, 661.566673828643, 663.2604645819877, 13270.601881943558, 13742.93128534361, 13750.243736594482, 13868.653283667989, 13870.722585548334, 14294.285285735672, 14913.552593422215, 14931.626709332246, 14937.551873443705, 14937.925310373486, 9727.708168754949, 11812.29126252419, 12130.818037729441, 12153.270803751802, 12459.439325230296, 3871.8838434847, 3898.8830335089992, 3905.082305658168, 3930.155016671401, 3988.222296652154, 104231.0, 105591.27313449202, 105972.0, 110824.4458777701, 111304.0, 11042.834357484644, 11166.218364714392, 11262.831057534144, 11325.207235493437, 11477.615957415015, 20242.583019188514, 21629.78370216309, 22933.967971441325, 22935.885320573623, 23015.7698423017, 6646.933530664728, 7602.163761986177, 7928.7224947127725, 8006.799830004296, 8038.075621303625, 4444.82220711168, 4493.370928070073, 4634.675572709878, 4699.953000469952, 4749.95250047502, 3252.902412927616, 3609.6751292383287, 3691.3909204981414, 3745.194783121642, 3747.868824591126, 652.4831160047348, 676.8781619308571, 683.5830143612393, 683.8153698501476, 686.4542688562605, 542.1867199201198, 621.5400603553338, 661.5501459007825, 693.3551796828897, 696.2098018748757, 8901.421407608485, 9066.863997040049, 9352.111549402796, 9450.716478505656, 9532.237421006303, 527.0616314049191, 635.9364063593604, 649.376598465469, 675.321302091395, 678.6064082831946, 4151.709380343407, 4653.883652908705, 4659.743714095757, 4691.366665500182, 4727.125481785881, 89747.0, 91076.72308192348, 94197.0, 98881.022379552, 151660.0, 111387.0, 119425.0, 139385.0, 140438.0, 140599.5940040607, 116502.0, 120986.0, 121003.0, 121495.0, 124195.0, 8888.0, 8984.505852177932, 9013.60289155182, 9063.909360906306, 9242.399244049115, 43511.56488435075, 62984.0, 64107.0, 65975.0, 66117.66941165263, 60746.0, 64380.67809660922, 82825.58587207025, 100284.0, 102072.0, 12056.578019769266, 12150.75698486043, 12292.877071229173, 12333.50665973351, 12397.132200746222, 13088.476460941456, 13700.588982330546, 13706.24615646149, 13764.449422023006, 13993.510227142002, 12237.632871013884, 12398.194117382342, 12481.56314528987, 12753.553625623059, 12830.10189286741, 11922.463489142836, 12118.93940530327, 12169.939150304192, 12260.203086799329, 12385.19496232742, 10027.899721002697, 12121.454534546143, 12140.33228172459, 12305.0, 12383.442745076673, 10164.136048435967, 10297.9485102574, 10476.895231047592, 10799.40603266828, 10871.96716311949, 8664.0, 10029.548670309707, 10289.0, 10825.621103261348, 10830.458477076272], "value": 7560.022349271303, "unit": "score"}], "name": "dromaeo_css", "value": 7136.471615510784, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 113.0, 113.0, 113.0, 114.0, 112.0, 113.0, 113.0, 122.0, 168.0], "value": 119.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 120.0, 104.0, 175.0, 92.0, 122.0, 133.0, 106.0, 161.0, 137.0], "value": 128.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 182.0, 183.0, 184.0, 185.0, 184.0, 183.0, 186.0, 184.0, 180.0], "value": 183.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 56.0, 65.0, 88.0, 57.0, 57.0, 65.0, 66.0, 84.0, 56.0], "value": 67.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 68.0, 102.0, 71.0, 75.0, 70.0, 126.0, 100.0, 98.0, 100.0], "value": 89.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 86.0, 90.0, 88.0, 91.0, 87.0, 90.0, 88.0, 90.0, 86.0], "value": 88.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0, 133.0], "value": 98.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 84.0, 83.0, 86.0, 84.0, 84.0, 85.0, 82.0, 84.0, 86.0], "value": 84.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 52.0, 51.0, 54.0, 52.0, 52.0, 53.0, 52.0, 53.0, 52.0], "value": 52.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 103.0, 112.0, 83.0, 74.0, 69.0, 71.0, 70.0, 68.0, 70.0], "value": 78.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 82.0, 82.0, 85.0, 85.0, 83.0, 86.0, 82.0, 83.0, 87.0], "value": 84.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 150.0, 157.0, 152.0, 159.0, 146.0, 153.0, 135.0, 210.0, 139.0], "value": 154.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 165.0, 169.0, 164.0, 162.0, 214.0, 231.0, 162.0, 162.0, 158.0], "value": 175.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 67.0, 66.0, 66.0, 68.0, 66.0, 65.0, 64.0, 66.0], "value": 66.1, "unit": "score"}], "name": "kraken", "value": 1471.1000000000001, "alertThreshold": 2.0}]} 07:01:47 INFO - Return code: 0 07:01:47 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:01:47 INFO - # TBPL SUCCESS # 07:01:47 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:01:47 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:01:47 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:01:47 INFO - 2016-08-10 07:01:47.246 screenresolution[1677:11172] starting screenresolution argv=screenresolution get 07:01:47 INFO - 2016-08-10 07:01:47.249 screenresolution[1677:11172] Display 0: 1600x1200x32@60 07:01:47 INFO - 2016-08-10 07:01:47.255 screenresolution[1678:11175] starting screenresolution argv=screenresolution list 07:01:47 INFO - Available Modes on Display 0 07:01:47 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:01:47 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:01:47 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:01:47 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:01:47 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:01:47 INFO - Intel Iris: 07:01:47 INFO - Chipset Model: Intel Iris 07:01:47 INFO - Type: GPU 07:01:47 INFO - Bus: Built-In 07:01:47 INFO - VRAM (Dynamic, Max): 1536 MB 07:01:47 INFO - Vendor: Intel (0x8086) 07:01:47 INFO - Device ID: 0x0a2e 07:01:47 INFO - Revision ID: 0x0009 07:01:47 INFO - Displays: 07:01:47 INFO - Display: 07:01:47 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:01:47 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:01:47 INFO - Display Serial Number: 1600x1200 60 07:01:47 INFO - Main Display: Yes 07:01:47 INFO - Mirror: Off 07:01:47 INFO - Online: Yes 07:01:47 INFO - Rotation: Supported 07:01:47 INFO - Return code: 0 07:01:47 INFO - Running post-action listener: _resource_record_post_action 07:01:47 INFO - [mozharness: 2016-08-10 14:01:47.493675Z] Finished run-tests step (success) 07:01:47 INFO - Running post-run listener: _resource_record_post_run 07:01:47 INFO - Total resource usage - Wall time: 1213s; CPU: 54.0%; Read bytes: 32218112; Write bytes: 702464000; Read time: 320; Write time: 2155 07:01:47 INFO - TinderboxPrint: CPU usage
53.6% 07:01:47 INFO - TinderboxPrint: I/O read bytes / time
32,218,112 / 320 07:01:47 INFO - TinderboxPrint: I/O write bytes / time
702,464,000 / 2,155 07:01:47 INFO - TinderboxPrint: CPU idle
2,253.6 (46.4%) 07:01:47 INFO - TinderboxPrint: CPU system
974.9 (20.1%) 07:01:47 INFO - TinderboxPrint: CPU user
1,625.2 (33.5%) 07:01:47 INFO - TinderboxPrint: Swap in / out
432,037,888 / 0 07:01:47 INFO - install - Wall time: 35s; CPU: 54.0%; Read bytes: 401129984; Write bytes: 395081728; Read time: 30620; Write time: 709 07:01:47 INFO - run-tests - Wall time: 1179s; CPU: 54.0%; Read bytes: 30133248; Write bytes: 295544832; Read time: 297; Write time: 1416 07:01:47 INFO - Running post-run listener: _upload_blobber_files 07:01:47 INFO - Blob upload gear active. 07:01:47 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:01:47 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 07:01:47 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'] 07:01:47 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 07:01:48 INFO - (blobuploader) - INFO - Open directory for files ... 07:01:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:01:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:01:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:01:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:01:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:01:49 INFO - (blobuploader) - INFO - Done attempting. 07:01:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 07:01:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:01:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:01:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:01:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:01:50 INFO - (blobuploader) - INFO - Done attempting. 07:01:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:01:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:01:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:01:53 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:01:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:01:53 INFO - (blobuploader) - INFO - Done attempting. 07:01:53 INFO - (blobuploader) - INFO - Iteration through files over. 07:01:53 INFO - Return code: 0 07:01:53 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:01:53 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:01:53 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4a36cccbfc74442830830225e1ccd75aca691bec61bfe0da6650708fff0710f262989409e22ff5e8631777da8341c237765ab08d37afb45a7bae9e5c6c4165a8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b134ad7c30a3326e7e10db5425d13e8f5a1aef2dcdbab21ce60c26551003c0ce470093a66608ff3720f919ba646b86d0cd54abc6effa2f17c0c805761f70bf93", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/509039656c00bb7c07eb4ae6f3e7b850f973ae9be8f2e9efd72443a17b07ceb69453e61d0d6a4f624e13473e5d667e43f90253e2898ccb14ee5133ce37984a69"} 07:01:53 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:01:53 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:01:53 INFO - Contents: 07:01:53 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4a36cccbfc74442830830225e1ccd75aca691bec61bfe0da6650708fff0710f262989409e22ff5e8631777da8341c237765ab08d37afb45a7bae9e5c6c4165a8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b134ad7c30a3326e7e10db5425d13e8f5a1aef2dcdbab21ce60c26551003c0ce470093a66608ff3720f919ba646b86d0cd54abc6effa2f17c0c805761f70bf93", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/509039656c00bb7c07eb4ae6f3e7b850f973ae9be8f2e9efd72443a17b07ceb69453e61d0d6a4f624e13473e5d667e43f90253e2898ccb14ee5133ce37984a69"} 07:01:53 INFO - Running post-run listener: copy_logs_to_upload_dir 07:01:53 INFO - Copying logs to upload dir... 07:01:53 INFO - mkdir: /builds/slave/test/build/upload/logs 07:01:53 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1270.879711 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2016-08-10 07:01:53.442614) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-10 07:01:53.445682) ========= 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.QiCI2haLpB/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.B4jfseCfOH/Listeners TMPDIR=/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4a36cccbfc74442830830225e1ccd75aca691bec61bfe0da6650708fff0710f262989409e22ff5e8631777da8341c237765ab08d37afb45a7bae9e5c6c4165a8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b134ad7c30a3326e7e10db5425d13e8f5a1aef2dcdbab21ce60c26551003c0ce470093a66608ff3720f919ba646b86d0cd54abc6effa2f17c0c805761f70bf93", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/509039656c00bb7c07eb4ae6f3e7b850f973ae9be8f2e9efd72443a17b07ceb69453e61d0d6a4f624e13473e5d667e43f90253e2898ccb14ee5133ce37984a69"} build_url:https://queue.taskcluster.net/v1/task/Rg32TgxBRoKmgTSrt3I79A/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011125 build_url: 'https://queue.taskcluster.net/v1/task/Rg32TgxBRoKmgTSrt3I79A/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4a36cccbfc74442830830225e1ccd75aca691bec61bfe0da6650708fff0710f262989409e22ff5e8631777da8341c237765ab08d37afb45a7bae9e5c6c4165a8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b134ad7c30a3326e7e10db5425d13e8f5a1aef2dcdbab21ce60c26551003c0ce470093a66608ff3720f919ba646b86d0cd54abc6effa2f17c0c805761f70bf93", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/509039656c00bb7c07eb4ae6f3e7b850f973ae9be8f2e9efd72443a17b07ceb69453e61d0d6a4f624e13473e5d667e43f90253e2898ccb14ee5133ce37984a69"}' ========= master_lag: 0.05 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-10 07:01:53.505294) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-10 07:01:53.505654) ========= 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.QiCI2haLpB/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.B4jfseCfOH/Listeners TMPDIR=/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/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.005147 ========= master_lag: 0.09 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-10 07:01:53.605078) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-10 07:01:53.605427) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-10 07:01:53.605778) ========= ========= Total master_lag: 0.25 =========