builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0304 starttime: 1470558971.18 results: success (0) buildid: 20160806233553 builduid: 0be140ceff4042fbb8e95871892f5a85 revision: 70948f120f5f8fe002ffe36ff6e962b128a67b23 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-07 01:36:11.180139) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-07 01:36:11.180574) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-07 01:36:11.180844) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-07 01:36:11.283788) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-07 01:36:11.284058) ========= 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.gY66FdXvaA/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.FJCgzeNOmZ/Listeners TMPDIR=/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-08-07 01:36:11-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 58.2M=0s 2016-08-07 01:36:11 (58.2 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.114136 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-07 01:36:11.419782) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-07 01:36:11.420056) ========= 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.gY66FdXvaA/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.FJCgzeNOmZ/Listeners TMPDIR=/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/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.029667 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-07 01:36:11.470532) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-07 01:36:11.470871) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 70948f120f5f8fe002ffe36ff6e962b128a67b23 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 70948f120f5f8fe002ffe36ff6e962b128a67b23 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.gY66FdXvaA/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.FJCgzeNOmZ/Listeners TMPDIR=/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-08-07 01:36:11,555 truncating revision to first 12 chars 2016-08-07 01:36:11,555 Setting DEBUG logging. 2016-08-07 01:36:11,555 attempt 1/10 2016-08-07 01:36:11,555 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/70948f120f5f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-07 01:36:12,729 unpacking tar archive at: mozilla-central-70948f120f5f/testing/mozharness/ program finished with exit code 0 elapsedTime=1.435702 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-07 01:36:12.933201) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-07 01:36:12.933506) ========= script_repo_revision: 70948f120f5f8fe002ffe36ff6e962b128a67b23 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-07 01:36:12.933878) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-07 01:36:12.934140) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-07 01:36:12.953143) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2016-08-07 01:36:12.953433) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.gY66FdXvaA/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.FJCgzeNOmZ/Listeners TMPDIR=/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/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 01:36:13 INFO - MultiFileLogger online at 20160807 01:36:13 in /builds/slave/test 01:36:13 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 01:36:13 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 01:36:13 INFO - {'append_to_log': False, 01:36:13 INFO - 'base_work_dir': '/builds/slave/test', 01:36:13 INFO - 'blob_upload_branch': 'Firefox', 01:36:13 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 01:36:13 INFO - 'branch': 'Firefox', 01:36:13 INFO - 'buildbot_json_path': 'buildprops.json', 01:36:13 INFO - 'config_files': ('talos/mac_config.py',), 01:36:13 INFO - 'default_actions': ('clobber', 01:36:13 INFO - 'read-buildbot-config', 01:36:13 INFO - 'download-and-extract', 01:36:13 INFO - 'populate-webroot', 01:36:13 INFO - 'create-virtualenv', 01:36:13 INFO - 'install', 01:36:13 INFO - 'run-tests'), 01:36:13 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:36:13 INFO - 'download_minidump_stackwalk': True, 01:36:13 INFO - 'download_symbols': 'ondemand', 01:36:13 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 01:36:13 INFO - 'tooltool.py': '/tools/tooltool.py', 01:36:13 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 01:36:13 INFO - '/tools/misc-python/virtualenv.py')}, 01:36:13 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:36:13 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:36:13 INFO - 'installer_path': 'installer.exe', 01:36:13 INFO - 'log_level': 'info', 01:36:13 INFO - 'log_name': 'talos', 01:36:13 INFO - 'log_to_console': True, 01:36:13 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 01:36:13 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 01:36:13 INFO - 'opt_config_files': (), 01:36:13 INFO - 'pip_index': False, 01:36:13 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 01:36:13 INFO - 'cmd': ('bash', 01:36:13 INFO - '-c', 01:36:13 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 01:36:13 INFO - 'enabled': True, 01:36:13 INFO - 'halt_on_failure': False, 01:36:13 INFO - 'name': 'check_screen_resolution'},), 01:36:13 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 01:36:13 INFO - 'cmd': ('bash', 01:36:13 INFO - '-c', 01:36:13 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 01:36:13 INFO - 'enabled': True, 01:36:13 INFO - 'halt_on_failure': False, 01:36:13 INFO - 'name': 'check_screen_resolution'},), 01:36:13 INFO - 'run_cmd_checks_enabled': True, 01:36:13 INFO - 'sps_profile': False, 01:36:13 INFO - 'sps_profile_interval': 0, 01:36:13 INFO - 'suite': 'dromaeojs', 01:36:13 INFO - 'system_bits': '32', 01:36:13 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:36:13 INFO - 'title': 't-yosemite-r7-0304', 01:36:13 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:36:13 INFO - 'use_talos_json': True, 01:36:13 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 01:36:13 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:36:13 INFO - 'work_dir': 'build'} 01:36:13 INFO - [mozharness: 2016-08-07 08:36:13.143916Z] Running clobber step. 01:36:13 INFO - Running pre-action listener: _resource_record_pre_action 01:36:13 INFO - Running main action method: clobber 01:36:13 INFO - rmtree: /builds/slave/test/build 01:36:13 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 01:36:15 INFO - Running post-action listener: _resource_record_post_action 01:36:15 INFO - [mozharness: 2016-08-07 08:36:15.163041Z] Finished clobber step (success) 01:36:15 INFO - [mozharness: 2016-08-07 08:36:15.163199Z] Running read-buildbot-config step. 01:36:15 INFO - Running pre-action listener: _resource_record_pre_action 01:36:15 INFO - Running main action method: read_buildbot_config 01:36:15 INFO - Using buildbot properties: 01:36:15 INFO - { 01:36:15 INFO - "project": "", 01:36:15 INFO - "product": "firefox", 01:36:15 INFO - "script_repo_revision": "production", 01:36:15 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 01:36:15 INFO - "repository": "", 01:36:15 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 01:36:15 INFO - "buildid": "20160806233553", 01:36:15 INFO - "pgo_build": "False", 01:36:15 INFO - "basedir": "/builds/slave/test", 01:36:15 INFO - "buildnumber": 37, 01:36:15 INFO - "slavename": "t-yosemite-r7-0304", 01:36:15 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 01:36:15 INFO - "platform": "yosemite_r7", 01:36:15 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 01:36:15 INFO - "branch": "mozilla-central", 01:36:15 INFO - "repo_path": "mozilla-central", 01:36:15 INFO - "revision": "70948f120f5f8fe002ffe36ff6e962b128a67b23", 01:36:15 INFO - "stage_platform": "macosx64", 01:36:15 INFO - "builduid": "0be140ceff4042fbb8e95871892f5a85", 01:36:15 INFO - "slavebuilddir": "test" 01:36:15 INFO - } 01:36:15 INFO - Found installer url https://queue.taskcluster.net/v1/task/etJiaP1fT4KB_u8S9ZEPdg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg. 01:36:15 INFO - Running post-action listener: _resource_record_post_action 01:36:15 INFO - [mozharness: 2016-08-07 08:36:15.166448Z] Finished read-buildbot-config step (success) 01:36:15 INFO - [mozharness: 2016-08-07 08:36:15.166587Z] Running download-and-extract step. 01:36:15 INFO - Running pre-action listener: _resource_record_pre_action 01:36:15 INFO - Running main action method: download_and_extract 01:36:15 INFO - mkdir: /builds/slave/test/build/tests 01:36:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:36:15 INFO - trying https://queue.taskcluster.net/v1/task/etJiaP1fT4KB_u8S9ZEPdg/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json 01:36:15 INFO - Downloading https://queue.taskcluster.net/v1/task/etJiaP1fT4KB_u8S9ZEPdg/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 01:36:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/etJiaP1fT4KB_u8S9ZEPdg/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 01:36:16 INFO - Downloaded 1199 bytes. 01:36:16 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 01:36:16 INFO - Using the following test package requirements: 01:36:16 INFO - {u'common': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 01:36:16 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 01:36:16 INFO - u'firefox-51.0a1.en-US.mac.cppunittest.tests.zip'], 01:36:16 INFO - u'gtest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 01:36:16 INFO - u'firefox-51.0a1.en-US.mac.gtest.tests.zip'], 01:36:16 INFO - u'jittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 01:36:16 INFO - u'jsshell-mac.zip'], 01:36:16 INFO - u'mochitest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 01:36:16 INFO - u'firefox-51.0a1.en-US.mac.mochitest.tests.zip'], 01:36:16 INFO - u'mozbase': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 01:36:16 INFO - u'reftest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 01:36:16 INFO - u'firefox-51.0a1.en-US.mac.reftest.tests.zip'], 01:36:16 INFO - u'talos': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 01:36:16 INFO - u'firefox-51.0a1.en-US.mac.talos.tests.zip'], 01:36:16 INFO - u'web-platform': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 01:36:16 INFO - u'firefox-51.0a1.en-US.mac.web-platform.tests.zip'], 01:36:16 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 01:36:16 INFO - u'firefox-51.0a1.en-US.mac.xpcshell.tests.zip']} 01:36:16 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip'] for test suite category: common 01:36:16 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')]} 01:36:16 INFO - trying https://queue.taskcluster.net/v1/task/etJiaP1fT4KB_u8S9ZEPdg/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 01:36:16 INFO - Downloading https://queue.taskcluster.net/v1/task/etJiaP1fT4KB_u8S9ZEPdg/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 01:36:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/etJiaP1fT4KB_u8S9ZEPdg/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 01:36:17 INFO - Downloaded 16324054 bytes. 01:36:17 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'] 01:36:17 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 01:36:20 INFO - Return code: 0 01:36:20 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 01:36:20 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')]} 01:36:20 INFO - trying https://queue.taskcluster.net/v1/task/etJiaP1fT4KB_u8S9ZEPdg/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 01:36:20 INFO - Downloading https://queue.taskcluster.net/v1/task/etJiaP1fT4KB_u8S9ZEPdg/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 01:36:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/etJiaP1fT4KB_u8S9ZEPdg/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 01:36:21 INFO - Downloaded 16324054 bytes. 01:36:21 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'] 01:36:21 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 01:36:24 INFO - Return code: 0 01:36:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:36:24 INFO - trying https://queue.taskcluster.net/v1/task/etJiaP1fT4KB_u8S9ZEPdg/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip 01:36:24 INFO - Downloading https://queue.taskcluster.net/v1/task/etJiaP1fT4KB_u8S9ZEPdg/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 01:36:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/etJiaP1fT4KB_u8S9ZEPdg/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 01:36:26 INFO - Downloaded 14413723 bytes. 01:36:26 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'] 01:36:26 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 01:36:27 INFO - Return code: 0 01:36: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')]} 01:36:27 INFO - trying https://queue.taskcluster.net/v1/task/etJiaP1fT4KB_u8S9ZEPdg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 01:36:27 INFO - Downloading https://queue.taskcluster.net/v1/task/etJiaP1fT4KB_u8S9ZEPdg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg 01:36:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/etJiaP1fT4KB_u8S9ZEPdg/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 01:36:32 INFO - Downloaded 111836385 bytes. 01:36:32 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/etJiaP1fT4KB_u8S9ZEPdg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 01:36:32 INFO - mkdir: /builds/slave/test/properties 01:36:32 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 01:36:32 INFO - Writing to file /builds/slave/test/properties/build_url 01:36:32 INFO - Contents: 01:36:32 INFO - build_url:https://queue.taskcluster.net/v1/task/etJiaP1fT4KB_u8S9ZEPdg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 01:36:33 INFO - Running post-action listener: _resource_record_post_action 01:36:33 INFO - Running post-action listener: set_extra_try_arguments 01:36:33 INFO - [mozharness: 2016-08-07 08:36:33.430042Z] Finished download-and-extract step (success) 01:36:33 INFO - [mozharness: 2016-08-07 08:36:33.430201Z] Running populate-webroot step. 01:36:33 INFO - Running pre-action listener: _resource_record_pre_action 01:36:33 INFO - Running main action method: populate_webroot 01:36:33 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 01:36:33 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 01:36:33 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 01:36:33 INFO - '--tppagecycles', 01:36:33 INFO - '7'], 01:36:33 INFO - 'tests': ['tsvgm']}}, 01:36:33 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 01:36:33 INFO - 'tests': ['tresize', 'tcanvasmark']}, 01:36:33 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 01:36:33 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 01:36:33 INFO - 'tests': ['dromaeo_css', 'kraken']}, 01:36:33 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 01:36:33 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:36:33 INFO - 'talos_options': ['--disable-e10s'], 01:36:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:36:33 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:36:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:36:33 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:36:33 INFO - 'talos_options': ['--disable-e10s'], 01:36:33 INFO - 'tests': ['damp', 'tps']}, 01:36:33 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:36:33 INFO - 'tests': ['damp', 'tps']}, 01:36:33 INFO - 'g3': {'talos_options': ['--disable-e10s'], 01:36:33 INFO - 'tests': ['dromaeo_dom']}, 01:36:33 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:36:33 INFO - 'g4': {'talos_options': ['--disable-e10s'], 01:36:33 INFO - 'tests': ['basic_compositor_video']}, 01:36:33 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 01:36:33 INFO - 'other': {'talos_options': ['--disable-e10s'], 01:36:33 INFO - 'tests': ['a11yr', 01:36:33 INFO - 'ts_paint', 01:36:33 INFO - 'tpaint', 01:36:33 INFO - 'sessionrestore', 01:36:33 INFO - 'sessionrestore_no_auto_restore', 01:36:33 INFO - 'tabpaint']}, 01:36:33 INFO - 'other-e10s': {'tests': ['a11yr', 01:36:33 INFO - 'ts_paint', 01:36:33 INFO - 'tpaint', 01:36:33 INFO - 'sessionrestore', 01:36:33 INFO - 'sessionrestore_no_auto_restore', 01:36:33 INFO - 'tabpaint']}, 01:36:33 INFO - 'other-e10s_l64': {'tests': ['a11yr', 01:36:33 INFO - 'ts_paint', 01:36:33 INFO - 'tpaint', 01:36:33 INFO - 'sessionrestore', 01:36:33 INFO - 'sessionrestore_no_auto_restore', 01:36:33 INFO - 'tabpaint']}, 01:36:33 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 01:36:33 INFO - 'ts_paint', 01:36:33 INFO - 'tpaint', 01:36:33 INFO - 'sessionrestore', 01:36:33 INFO - 'sessionrestore_no_auto_restore', 01:36:33 INFO - 'tabpaint']}, 01:36:33 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 01:36:33 INFO - 'tests': ['a11yr', 01:36:33 INFO - 'ts_paint', 01:36:33 INFO - 'tpaint', 01:36:33 INFO - 'sessionrestore', 01:36:33 INFO - 'sessionrestore_no_auto_restore', 01:36:33 INFO - 'tabpaint']}, 01:36:33 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 01:36:33 INFO - 'tests': ['a11yr', 01:36:33 INFO - 'ts_paint', 01:36:33 INFO - 'tpaint', 01:36:33 INFO - 'sessionrestore', 01:36:33 INFO - 'sessionrestore_no_auto_restore', 01:36:33 INFO - 'tabpaint']}, 01:36:33 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 01:36:33 INFO - 'tests': ['tsvgx', 01:36:33 INFO - 'tsvgr_opacity', 01:36:33 INFO - 'tart', 01:36:33 INFO - 'tscrollx', 01:36:33 INFO - 'cart']}, 01:36:33 INFO - 'svgr-e10s': {'tests': ['tsvgx', 01:36:33 INFO - 'tsvgr_opacity', 01:36:33 INFO - 'tart', 01:36:33 INFO - 'tscrollx', 01:36:33 INFO - 'cart']}, 01:36:33 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:36:33 INFO - 'talos_options': ['--disable-e10s'], 01:36:33 INFO - 'tests': ['tp5o']}, 01:36:33 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:36:33 INFO - 'tests': ['tp5o']}, 01:36:33 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:36:33 INFO - 'talos_options': ['--disable-e10s', 01:36:33 INFO - '--xperf_path', 01:36:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:36:33 INFO - 'tests': ['tp5n']}, 01:36:33 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:36:33 INFO - 'talos_options': ['--xperf_path', 01:36:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:36:33 INFO - 'tests': ['tp5n']}}, 01:36:33 INFO - 'talos.zip': {'path': '', 01:36:33 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:36:33 INFO - Running post-action listener: _resource_record_post_action 01:36:33 INFO - [mozharness: 2016-08-07 08:36:33.449346Z] Finished populate-webroot step (success) 01:36:33 INFO - [mozharness: 2016-08-07 08:36:33.449463Z] Running create-virtualenv step. 01:36:33 INFO - Running pre-action listener: _resource_record_pre_action 01:36:33 INFO - Running main action method: create_virtualenv 01:36:33 INFO - Creating virtualenv /builds/slave/test/build/venv 01:36:33 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 01:36:33 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 01:36:33 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:36:33 INFO - Using real prefix '/tools/python27' 01:36:33 INFO - New python executable in /builds/slave/test/build/venv/bin/python 01:36:34 INFO - Installing distribute.............................................................................................................................................................................................done. 01:36:37 INFO - Installing pip.................done. 01:36:37 INFO - Return code: 0 01:36:37 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 01:36:37 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')]} 01:36:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:36:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:36:37 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')]} 01:36:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:36:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:36:37 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 0x10db70a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dc05618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f922a4d53d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dad4d30>, '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 0x10d839db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10daccb20>, '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.gY66FdXvaA/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.FJCgzeNOmZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/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 01:36:37 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 01:36:37 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 01:36:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gY66FdXvaA/Render', 01:36:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:36:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:36:37 INFO - 'HOME': '/Users/cltbld', 01:36:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:36:37 INFO - 'LOGNAME': 'cltbld', 01:36:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:36:37 INFO - 'MOZ_NO_REMOTE': '1', 01:36:37 INFO - 'NO_EM_RESTART': '1', 01:36:37 INFO - 'PAGER': '/bin/cat', 01:36:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:36:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:36:37 INFO - 'PWD': '/builds/slave/test', 01:36:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:36:37 INFO - 'SHELL': '/bin/bash', 01:36:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FJCgzeNOmZ/Listeners', 01:36:37 INFO - 'TMPDIR': '/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/', 01:36:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:36:37 INFO - 'USER': 'cltbld', 01:36:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:36:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:36:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:36:37 INFO - 'XPC_FLAGS': '0x0', 01:36:37 INFO - 'XPC_SERVICE_NAME': '0', 01:36:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:36:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:36:37 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 01:36:37 INFO - Cleaning up... 01:36:37 INFO - Return code: 0 01:36:37 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 01:36:37 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')]} 01:36:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:36:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:36:37 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')]} 01:36:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:36:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:36:37 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 0x10db70a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dc05618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f922a4d53d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dad4d30>, '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 0x10d839db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10daccb20>, '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.gY66FdXvaA/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.FJCgzeNOmZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/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 01:36:37 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 01:36:37 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 01:36:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gY66FdXvaA/Render', 01:36:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:36:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:36:37 INFO - 'HOME': '/Users/cltbld', 01:36:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:36:37 INFO - 'LOGNAME': 'cltbld', 01:36:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:36:37 INFO - 'MOZ_NO_REMOTE': '1', 01:36:37 INFO - 'NO_EM_RESTART': '1', 01:36:37 INFO - 'PAGER': '/bin/cat', 01:36:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:36:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:36:37 INFO - 'PWD': '/builds/slave/test', 01:36:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:36:37 INFO - 'SHELL': '/bin/bash', 01:36:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FJCgzeNOmZ/Listeners', 01:36:37 INFO - 'TMPDIR': '/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/', 01:36:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:36:37 INFO - 'USER': 'cltbld', 01:36:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:36:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:36:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:36:37 INFO - 'XPC_FLAGS': '0x0', 01:36:37 INFO - 'XPC_SERVICE_NAME': '0', 01:36:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:36:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:36:37 INFO - Downloading/unpacking psutil>=3.1.1 01:36:37 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 01:36:37 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 01:36:37 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 01:36:37 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 01:36:37 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 01:36:37 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 01:36:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 01:36:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:36:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:36:41 INFO - Installing collected packages: psutil 01:36:41 INFO - Running setup.py install for psutil 01:36:41 INFO - building 'psutil._psutil_osx' extension 01:36:41 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 01:36:42 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 01:36:42 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 01:36:42 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 01:36:42 INFO - building 'psutil._psutil_posix' extension 01:36:42 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 01:36:42 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 01:36:42 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 01:36:42 INFO - ^ 01:36:42 INFO - 1 warning generated. 01:36:42 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 01:36:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:36:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:36:42 INFO - Successfully installed psutil 01:36:42 INFO - Cleaning up... 01:36:42 INFO - Return code: 0 01:36:42 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 01:36:42 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')]} 01:36:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:36:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:36:42 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')]} 01:36:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:36:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:36:42 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 0x10db70a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dc05618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f922a4d53d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dad4d30>, '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 0x10d839db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10daccb20>, '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.gY66FdXvaA/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.FJCgzeNOmZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/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 01:36:42 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 01:36:42 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 01:36:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gY66FdXvaA/Render', 01:36:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:36:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:36:42 INFO - 'HOME': '/Users/cltbld', 01:36:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:36:42 INFO - 'LOGNAME': 'cltbld', 01:36:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:36:42 INFO - 'MOZ_NO_REMOTE': '1', 01:36:42 INFO - 'NO_EM_RESTART': '1', 01:36:42 INFO - 'PAGER': '/bin/cat', 01:36:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:36:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:36:42 INFO - 'PWD': '/builds/slave/test', 01:36:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:36:42 INFO - 'SHELL': '/bin/bash', 01:36:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FJCgzeNOmZ/Listeners', 01:36:42 INFO - 'TMPDIR': '/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/', 01:36:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:36:42 INFO - 'USER': 'cltbld', 01:36:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:36:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:36:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:36:42 INFO - 'XPC_FLAGS': '0x0', 01:36:42 INFO - 'XPC_SERVICE_NAME': '0', 01:36:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:36:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:36:42 INFO - Downloading/unpacking mozsystemmonitor==0.3 01:36:42 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 01:36:42 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 01:36:42 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 01:36:42 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 01:36:42 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 01:36:42 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 01:36:45 INFO - Downloading mozsystemmonitor-0.3.tar.gz 01:36:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:36:45 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 01:36:45 INFO - Installing collected packages: mozsystemmonitor 01:36:45 INFO - Running setup.py install for mozsystemmonitor 01:36:45 INFO - Successfully installed mozsystemmonitor 01:36:45 INFO - Cleaning up... 01:36:45 INFO - Return code: 0 01:36:45 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 01:36:45 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')]} 01:36:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:36:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:36:45 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')]} 01:36:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:36:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:36:45 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 0x10db70a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dc05618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f922a4d53d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dad4d30>, '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 0x10d839db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10daccb20>, '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.gY66FdXvaA/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.FJCgzeNOmZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/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 01:36:45 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 01:36:45 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 01:36:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gY66FdXvaA/Render', 01:36:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:36:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:36:45 INFO - 'HOME': '/Users/cltbld', 01:36:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:36:45 INFO - 'LOGNAME': 'cltbld', 01:36:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:36:45 INFO - 'MOZ_NO_REMOTE': '1', 01:36:45 INFO - 'NO_EM_RESTART': '1', 01:36:45 INFO - 'PAGER': '/bin/cat', 01:36:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:36:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:36:45 INFO - 'PWD': '/builds/slave/test', 01:36:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:36:45 INFO - 'SHELL': '/bin/bash', 01:36:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FJCgzeNOmZ/Listeners', 01:36:45 INFO - 'TMPDIR': '/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/', 01:36:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:36:45 INFO - 'USER': 'cltbld', 01:36:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:36:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:36:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:36:45 INFO - 'XPC_FLAGS': '0x0', 01:36:45 INFO - 'XPC_SERVICE_NAME': '0', 01:36:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:36:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:36:45 INFO - Downloading/unpacking jsonschema==2.5.1 01:36:45 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 01:36:45 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 01:36:45 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 01:36:45 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 01:36:45 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 01:36:45 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 01:36:48 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 01:36:48 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 01:36:48 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 01:36:48 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 01:36:48 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 01:36:48 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 01:36:48 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 01:36:48 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 01:36:48 INFO - Downloading functools32-3.2.3-2.tar.gz 01:36:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 01:36:48 INFO - warning: no files found matching '*.txt' 01:36:48 INFO - no previously-included directories found matching 'build' 01:36:48 INFO - no previously-included directories found matching 'dist' 01:36:48 INFO - no previously-included directories found matching '.git*' 01:36:48 INFO - Installing collected packages: jsonschema, functools32 01:36:48 INFO - Running setup.py install for functools32 01:36:49 INFO - warning: no files found matching '*.txt' 01:36:49 INFO - no previously-included directories found matching 'build' 01:36:49 INFO - no previously-included directories found matching 'dist' 01:36:49 INFO - no previously-included directories found matching '.git*' 01:36:49 INFO - Successfully installed jsonschema functools32 01:36:49 INFO - Cleaning up... 01:36:49 INFO - Return code: 0 01:36:49 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 01:36:49 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')]} 01:36:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:36:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:36:49 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')]} 01:36:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:36:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:36:49 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 0x10db70a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dc05618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f922a4d53d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dad4d30>, '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 0x10d839db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10daccb20>, '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.gY66FdXvaA/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.FJCgzeNOmZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/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 01:36:49 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 01:36:49 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 01:36:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gY66FdXvaA/Render', 01:36:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:36:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:36:49 INFO - 'HOME': '/Users/cltbld', 01:36:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:36:49 INFO - 'LOGNAME': 'cltbld', 01:36:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:36:49 INFO - 'MOZ_NO_REMOTE': '1', 01:36:49 INFO - 'NO_EM_RESTART': '1', 01:36:49 INFO - 'PAGER': '/bin/cat', 01:36:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:36:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:36:49 INFO - 'PWD': '/builds/slave/test', 01:36:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:36:49 INFO - 'SHELL': '/bin/bash', 01:36:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FJCgzeNOmZ/Listeners', 01:36:49 INFO - 'TMPDIR': '/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/', 01:36:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:36:49 INFO - 'USER': 'cltbld', 01:36:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:36:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:36:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:36:49 INFO - 'XPC_FLAGS': '0x0', 01:36:49 INFO - 'XPC_SERVICE_NAME': '0', 01:36:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:36:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:36:49 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 01:36:49 INFO - Cleaning up... 01:36:49 INFO - Return code: 0 01:36:49 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 01:36:49 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')]} 01:36:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:36:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:36:49 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')]} 01:36:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:36:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:36:49 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 0x10db70a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dc05618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f922a4d53d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dad4d30>, '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 0x10d839db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10daccb20>, '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.gY66FdXvaA/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.FJCgzeNOmZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/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 01:36:49 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 01:36:49 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 01:36:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gY66FdXvaA/Render', 01:36:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:36:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:36:49 INFO - 'HOME': '/Users/cltbld', 01:36:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:36:49 INFO - 'LOGNAME': 'cltbld', 01:36:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:36:49 INFO - 'MOZ_NO_REMOTE': '1', 01:36:49 INFO - 'NO_EM_RESTART': '1', 01:36:49 INFO - 'PAGER': '/bin/cat', 01:36:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:36:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:36:49 INFO - 'PWD': '/builds/slave/test', 01:36:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:36:49 INFO - 'SHELL': '/bin/bash', 01:36:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FJCgzeNOmZ/Listeners', 01:36:49 INFO - 'TMPDIR': '/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/', 01:36:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:36:49 INFO - 'USER': 'cltbld', 01:36:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:36:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:36:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:36:49 INFO - 'XPC_FLAGS': '0x0', 01:36:49 INFO - 'XPC_SERVICE_NAME': '0', 01:36:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:36:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:36:49 INFO - Downloading/unpacking blobuploader==1.2.4 01:36:49 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 01:36:49 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 01:36:49 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 01:36:49 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 01:36:49 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 01:36:49 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 01:36:52 INFO - Downloading blobuploader-1.2.4.tar.gz 01:36:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:36:52 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:36:52 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 01:36:52 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 01:36:52 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 01:36:52 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 01:36:52 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 01:36:52 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 01:36:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 01:36:52 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01:36:52 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 01:36:52 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 01:36:52 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 01:36:52 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 01:36:52 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 01:36:52 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 01:36:53 INFO - Downloading docopt-0.6.1.tar.gz 01:36:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 01:36:53 INFO - Installing collected packages: blobuploader, requests, docopt 01:36:53 INFO - Running setup.py install for blobuploader 01:36:53 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:36:53 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 01:36:53 INFO - Running setup.py install for requests 01:36:54 INFO - Running setup.py install for docopt 01:36:54 INFO - Successfully installed blobuploader requests docopt 01:36:54 INFO - Cleaning up... 01:36:54 INFO - Return code: 0 01:36:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:36: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')]} 01:36:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:36:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:36: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')]} 01:36:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:36:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:36:54 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 0x10db70a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dc05618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f922a4d53d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dad4d30>, '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 0x10d839db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10daccb20>, '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.gY66FdXvaA/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.FJCgzeNOmZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/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 01:36:54 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 01:36:54 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 01:36:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gY66FdXvaA/Render', 01:36:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:36:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:36:54 INFO - 'HOME': '/Users/cltbld', 01:36:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:36:54 INFO - 'LOGNAME': 'cltbld', 01:36:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:36:54 INFO - 'MOZ_NO_REMOTE': '1', 01:36:54 INFO - 'NO_EM_RESTART': '1', 01:36:54 INFO - 'PAGER': '/bin/cat', 01:36:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:36:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:36:54 INFO - 'PWD': '/builds/slave/test', 01:36:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:36:54 INFO - 'SHELL': '/bin/bash', 01:36:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FJCgzeNOmZ/Listeners', 01:36:54 INFO - 'TMPDIR': '/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/', 01:36:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:36:54 INFO - 'USER': 'cltbld', 01:36:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:36:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:36:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:36:54 INFO - 'XPC_FLAGS': '0x0', 01:36:54 INFO - 'XPC_SERVICE_NAME': '0', 01:36:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:36:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:36:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:36:54 INFO - Running setup.py (path:/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/pip-hwMX8e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:36:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:36:54 INFO - Running setup.py (path:/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/pip-N6lAUL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:36:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:36:54 INFO - Running setup.py (path:/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/pip-_xinAk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:36:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:36:54 INFO - Running setup.py (path:/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/pip-oGixfy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:36:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:36:55 INFO - Running setup.py (path:/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/pip-3aqBIP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:36:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:36:55 INFO - Running setup.py (path:/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/pip-4xNoBj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:36:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:36:55 INFO - Running setup.py (path:/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/pip-FHXYnq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:36:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:36:55 INFO - Running setup.py (path:/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/pip-EZXyE6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:36:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:36:55 INFO - Running setup.py (path:/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/pip-CIjoSU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:36:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:36:55 INFO - Running setup.py (path:/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/pip-DOy58T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:36:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:36:55 INFO - Running setup.py (path:/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/pip-qd2AkM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:36:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:36:55 INFO - Running setup.py (path:/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/pip-oyFgJ7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:36:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:36:55 INFO - Running setup.py (path:/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/pip-A3HarC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:36:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:36:55 INFO - Running setup.py (path:/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/pip-0OvkA3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:36:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:36:56 INFO - Running setup.py (path:/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/pip-iAuW5x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:36:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:36:56 INFO - Running setup.py (path:/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/pip-q3kFOM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:36:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:36:56 INFO - Running setup.py (path:/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/pip-3hLDKQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:36:56 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:36:56 INFO - Running setup.py install for manifestparser 01:36:56 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 01:36:56 INFO - Running setup.py install for mozcrash 01:36:56 INFO - Running setup.py install for mozdebug 01:36:56 INFO - Running setup.py install for mozdevice 01:36:57 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 01:36:57 INFO - Installing dm script to /builds/slave/test/build/venv/bin 01:36:57 INFO - Running setup.py install for mozfile 01:36:57 INFO - Running setup.py install for mozhttpd 01:36:57 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 01:36:57 INFO - Running setup.py install for mozinfo 01:36:57 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 01:36:57 INFO - Running setup.py install for mozInstall 01:36:57 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 01:36:57 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 01:36:57 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 01:36:57 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 01:36:57 INFO - Running setup.py install for mozleak 01:36:57 INFO - Running setup.py install for mozlog 01:36:57 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 01:36:57 INFO - Running setup.py install for moznetwork 01:36:58 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 01:36:58 INFO - Running setup.py install for mozprocess 01:36:58 INFO - Running setup.py install for mozprofile 01:36:58 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 01:36:58 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 01:36:58 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 01:36:58 INFO - Running setup.py install for mozrunner 01:36:58 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 01:36:58 INFO - Running setup.py install for mozscreenshot 01:36:58 INFO - Running setup.py install for moztest 01:36:58 INFO - Running setup.py install for mozversion 01:36:58 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 01:36:58 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:36:58 INFO - Cleaning up... 01:36:58 INFO - Return code: 0 01:36:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:36:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:36:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:36:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:36:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:36:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:36:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:36:58 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 0x10db70a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dc05618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f922a4d53d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dad4d30>, '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 0x10d839db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10daccb20>, '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.gY66FdXvaA/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.FJCgzeNOmZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/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 01:36:58 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 01:36:58 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 01:36:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gY66FdXvaA/Render', 01:36:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:36:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:36:58 INFO - 'HOME': '/Users/cltbld', 01:36:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:36:58 INFO - 'LOGNAME': 'cltbld', 01:36:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:36:58 INFO - 'MOZ_NO_REMOTE': '1', 01:36:58 INFO - 'NO_EM_RESTART': '1', 01:36:58 INFO - 'PAGER': '/bin/cat', 01:36:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:36:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:36:58 INFO - 'PWD': '/builds/slave/test', 01:36:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:36:58 INFO - 'SHELL': '/bin/bash', 01:36:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FJCgzeNOmZ/Listeners', 01:36:58 INFO - 'TMPDIR': '/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/', 01:36:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:36:58 INFO - 'USER': 'cltbld', 01:36:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:36:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:36:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:36:58 INFO - 'XPC_FLAGS': '0x0', 01:36:58 INFO - 'XPC_SERVICE_NAME': '0', 01:36:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:36:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:36:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:36:59 INFO - Running setup.py (path:/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/pip-hox4eV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:36:59 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)) 01:36:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:36:59 INFO - Running setup.py (path:/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/pip-uw8NR3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:36:59 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)) 01:36:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:36:59 INFO - Running setup.py (path:/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/pip-zWv5DZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:36:59 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)) 01:36:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:36:59 INFO - Running setup.py (path:/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/pip-7Ew3EH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:36:59 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)) 01:36:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:36:59 INFO - Running setup.py (path:/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/pip-ZRKZ5Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:36:59 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)) 01:36:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:36:59 INFO - Running setup.py (path:/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/pip-ZcsG6J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:36:59 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)) 01:36:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:36:59 INFO - Running setup.py (path:/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/pip-UD7zKA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:36:59 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)) 01:36:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:36:59 INFO - Running setup.py (path:/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/pip-o0zAKz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:37:00 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)) 01:37:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:37:00 INFO - Running setup.py (path:/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/pip-jWWjz7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:37:00 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)) 01:37:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:37:00 INFO - Running setup.py (path:/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/pip-LoZNLh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:37:00 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)) 01:37:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:37:00 INFO - Running setup.py (path:/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/pip-DX_5tM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:37:00 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)) 01:37:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:37:00 INFO - Running setup.py (path:/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/pip-wJgLQV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:37:00 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)) 01:37:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:37:00 INFO - Running setup.py (path:/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/pip-xOGjI9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:37:00 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)) 01:37:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:37:00 INFO - Running setup.py (path:/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/pip-L5IJdJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:37:00 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)) 01:37:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:37:00 INFO - Running setup.py (path:/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/pip-BLyP6l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:37:00 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)) 01:37:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:37:00 INFO - Running setup.py (path:/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/pip-9qxnbR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:37:00 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)) 01:37:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:37:00 INFO - Running setup.py (path:/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/pip-1McgzS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:37:01 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)) 01:37:01 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)) 01:37:01 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)) 01:37:01 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)) 01:37:01 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)) 01:37:01 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)) 01:37:01 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:37:01 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 01:37:01 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 01:37:01 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 01:37:01 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 01:37:01 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 01:37:01 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 01:37:03 INFO - Downloading blessings-1.6.tar.gz 01:37:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 01:37:03 INFO - Installing collected packages: blessings 01:37:03 INFO - Running setup.py install for blessings 01:37:03 INFO - Successfully installed blessings 01:37:03 INFO - Cleaning up... 01:37:03 INFO - Return code: 0 01:37:03 INFO - Done creating virtualenv /builds/slave/test/build/venv. 01:37:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:37:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:37:04 INFO - Reading from file tmpfile_stdout 01:37:04 INFO - Current package versions: 01:37:04 INFO - blessings == 1.6 01:37:04 INFO - blobuploader == 1.2.4 01:37:04 INFO - docopt == 0.6.1 01:37:04 INFO - functools32 == 3.2.3-2 01:37:04 INFO - jsonschema == 2.5.1 01:37:04 INFO - manifestparser == 1.1 01:37:04 INFO - mozInstall == 1.12 01:37:04 INFO - mozcrash == 0.17 01:37:04 INFO - mozdebug == 0.1 01:37:04 INFO - mozdevice == 0.48 01:37:04 INFO - mozfile == 1.2 01:37:04 INFO - mozhttpd == 0.7 01:37:04 INFO - mozinfo == 0.9 01:37:04 INFO - mozleak == 0.1 01:37:04 INFO - mozlog == 3.3 01:37:04 INFO - moznetwork == 0.27 01:37:04 INFO - mozprocess == 0.23 01:37:04 INFO - mozprofile == 0.28 01:37:04 INFO - mozrunner == 6.12 01:37:04 INFO - mozscreenshot == 0.1 01:37:04 INFO - mozsystemmonitor == 0.3 01:37:04 INFO - moztest == 0.7 01:37:04 INFO - mozversion == 1.4 01:37:04 INFO - psutil == 3.1.1 01:37:04 INFO - requests == 1.2.3 01:37:04 INFO - wsgiref == 0.1.2 01:37:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:37:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:37:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:37:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:37:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:37:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:37:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:37:04 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 0x10db70a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dc05618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f922a4d53d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dad4d30>, '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 0x10d839db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10daccb20>, '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.gY66FdXvaA/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.FJCgzeNOmZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/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 01:37:04 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 01:37:04 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 01:37:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gY66FdXvaA/Render', 01:37:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:37:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:37:04 INFO - 'HOME': '/Users/cltbld', 01:37:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:37:04 INFO - 'LOGNAME': 'cltbld', 01:37:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:37:04 INFO - 'MOZ_NO_REMOTE': '1', 01:37:04 INFO - 'NO_EM_RESTART': '1', 01:37:04 INFO - 'PAGER': '/bin/cat', 01:37:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:37:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:37:04 INFO - 'PWD': '/builds/slave/test', 01:37:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:37:04 INFO - 'SHELL': '/bin/bash', 01:37:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FJCgzeNOmZ/Listeners', 01:37:04 INFO - 'TMPDIR': '/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/', 01:37:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:37:04 INFO - 'USER': 'cltbld', 01:37:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:37:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:37:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:37:04 INFO - 'XPC_FLAGS': '0x0', 01:37:04 INFO - 'XPC_SERVICE_NAME': '0', 01:37:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:37:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:37:04 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)) 01:37:04 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)) 01:37:04 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)) 01:37:04 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)) 01:37:04 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)) 01:37:04 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)) 01:37:04 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)) 01:37:04 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)) 01:37:04 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)) 01:37:04 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)) 01:37:04 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)) 01:37:04 INFO - Cleaning up... 01:37:04 INFO - Return code: 0 01:37:04 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 01:37:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:37:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:37:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:37:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:37:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:37:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:37:04 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 0x10db70a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dc05618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f922a4d53d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dad4d30>, '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 0x10d839db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10daccb20>, '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.gY66FdXvaA/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.FJCgzeNOmZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/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 01:37:04 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 01:37:04 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 01:37:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gY66FdXvaA/Render', 01:37:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:37:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:37:04 INFO - 'HOME': '/Users/cltbld', 01:37:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:37:04 INFO - 'LOGNAME': 'cltbld', 01:37:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:37:04 INFO - 'MOZ_NO_REMOTE': '1', 01:37:04 INFO - 'NO_EM_RESTART': '1', 01:37:04 INFO - 'PAGER': '/bin/cat', 01:37:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:37:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:37:04 INFO - 'PWD': '/builds/slave/test', 01:37:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:37:04 INFO - 'SHELL': '/bin/bash', 01:37:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FJCgzeNOmZ/Listeners', 01:37:04 INFO - 'TMPDIR': '/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/', 01:37:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:37:04 INFO - 'USER': 'cltbld', 01:37:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:37:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:37:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:37:04 INFO - 'XPC_FLAGS': '0x0', 01:37:04 INFO - 'XPC_SERVICE_NAME': '0', 01:37:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:37:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:37:04 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 01:37:04 INFO - Cleaning up... 01:37:04 INFO - Return code: 0 01:37:04 INFO - Running post-action listener: _resource_record_post_action 01:37:04 INFO - Running post-action listener: _start_resource_monitoring 01:37:04 INFO - Starting resource monitoring. 01:37:04 INFO - [mozharness: 2016-08-07 08:37:04.791703Z] Finished create-virtualenv step (success) 01:37:04 INFO - [mozharness: 2016-08-07 08:37:04.792701Z] Running install step. 01:37:04 INFO - Running pre-action listener: _resource_record_pre_action 01:37:04 INFO - Running main action method: install 01:37:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:37:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:37:05 INFO - Reading from file tmpfile_stdout 01:37:05 INFO - Detecting whether we're running mozinstall >=1.0... 01:37:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 01:37:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 01:37:05 INFO - Reading from file tmpfile_stdout 01:37:05 INFO - Output received: 01:37:05 INFO - Usage: mozinstall [options] installer 01:37:05 INFO - Options: 01:37:05 INFO - -h, --help show this help message and exit 01:37:05 INFO - -d DEST, --destination=DEST 01:37:05 INFO - Directory to install application into. [default: 01:37:05 INFO - "/builds/slave/test"] 01:37:05 INFO - --app=APP Application being installed. [default: firefox] 01:37:05 INFO - mkdir: /builds/slave/test/build/application 01:37:05 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'] 01:37:05 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 01:37:39 INFO - Reading from file tmpfile_stdout 01:37:39 INFO - Output received: 01:37:39 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 01:37:39 INFO - Running post-action listener: _resource_record_post_action 01:37:39 INFO - [mozharness: 2016-08-07 08:37:39.094110Z] Finished install step (success) 01:37:39 INFO - [mozharness: 2016-08-07 08:37:39.094244Z] Running run-tests step. 01:37:39 INFO - Running pre-action listener: _resource_record_pre_action 01:37:39 INFO - Running main action method: run_tests 01:37:39 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 01:37:39 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 01:37:39 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 01:37:39 INFO - 2016-08-07 01:37:39.108 screenresolution[1657:13720] starting screenresolution argv=screenresolution get 01:37:39 INFO - 2016-08-07 01:37:39.111 screenresolution[1657:13720] Display 0: 1600x1200x32@60 01:37:39 INFO - 2016-08-07 01:37:39.116 screenresolution[1658:13722] starting screenresolution argv=screenresolution list 01:37:39 INFO - Available Modes on Display 0 01:37:39 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 01:37:39 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 01:37:39 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 01:37:39 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 01:37:39 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 01:37:39 INFO - Intel Iris: 01:37:39 INFO - Chipset Model: Intel Iris 01:37:39 INFO - Type: GPU 01:37:39 INFO - Bus: Built-In 01:37:39 INFO - VRAM (Dynamic, Max): 1536 MB 01:37:39 INFO - Vendor: Intel (0x8086) 01:37:39 INFO - Device ID: 0x0a2e 01:37:39 INFO - Revision ID: 0x0009 01:37:39 INFO - Displays: 01:37:39 INFO - Display: 01:37:39 INFO - Resolution: 1600 x 1200 @ 60 Hz 01:37:39 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 01:37:39 INFO - Display Serial Number: 1600x1200 60 01:37:39 INFO - Main Display: Yes 01:37:39 INFO - Mirror: Off 01:37:39 INFO - Online: Yes 01:37:39 INFO - Rotation: Supported 01:37:39 INFO - Return code: 0 01:37:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 01:37:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 01:37:39 INFO - Python 2.7.3 01:37:39 INFO - Return code: 0 01:37:39 INFO - grabbing minidump binary from tooltool 01:37:39 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')]} 01:37:39 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 0x10dad4d30>, '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 0x10d839db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10daccb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 01:37:39 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 01:37:39 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 01:37:39 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 01:37:39 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:37:39 INFO - Return code: 0 01:37:39 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 01:37:39 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 01:37:39 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 01:37:39 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 01:37:39 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 01:37:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/etJiaP1fT4KB_u8S9ZEPdg/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0304', '--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 01:37:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/etJiaP1fT4KB_u8S9ZEPdg/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0304 --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 01:37:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gY66FdXvaA/Render', 01:37:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:37:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:37:39 INFO - 'HOME': '/Users/cltbld', 01:37:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:37:39 INFO - 'LOGNAME': 'cltbld', 01:37:39 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 01:37:39 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 01:37:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:37:39 INFO - 'MOZ_NO_REMOTE': '1', 01:37:39 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 01:37:39 INFO - 'NO_EM_RESTART': '1', 01:37:39 INFO - 'PAGER': '/bin/cat', 01:37:39 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:37:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:37:39 INFO - 'PWD': '/builds/slave/test', 01:37:39 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 01:37:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:37:39 INFO - 'SHELL': '/bin/bash', 01:37:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FJCgzeNOmZ/Listeners', 01:37:39 INFO - 'TMPDIR': '/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/', 01:37:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:37:39 INFO - 'USER': 'cltbld', 01:37:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:37:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:37:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:37:39 INFO - 'XPC_FLAGS': '0x0', 01:37:39 INFO - 'XPC_SERVICE_NAME': '0', 01:37:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:37:39 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/etJiaP1fT4KB_u8S9ZEPdg/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0304', '--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 01:37:39 INFO - mozversion application_buildid: 20160806233553 01:37:39 INFO - mozversion application_changeset: 70948f120f5f8fe002ffe36ff6e962b128a67b23 01:37:39 INFO - mozversion application_display_name: Nightly 01:37:39 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:37:39 INFO - mozversion application_name: Firefox 01:37:39 INFO - mozversion application_remotingname: firefox 01:37:39 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 01:37:39 INFO - mozversion application_vendor: Mozilla 01:37:39 INFO - mozversion application_version: 51.0a1 01:37:39 INFO - mozversion platform_buildid: 20160806233553 01:37:39 INFO - mozversion platform_changeset: 70948f120f5f8fe002ffe36ff6e962b128a67b23 01:37:39 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 01:37:39 INFO - mozversion platform_version: 51.0a1 01:37:39 INFO - using testdate: 1470559059 01:37:39 INFO - actual date: 1470559059 01:37:39 INFO - starting webserver on 'localhost:49274' 01:37:39 INFO - SUITE-START | Running 2 tests 01:37:39 INFO - TEST-START | dromaeo_css 01:37:39 INFO - operating with platform_type : mac_ 01:37:39 INFO - Initialising browser for dromaeo_css test... 01:37:39 INFO - TEST-INFO | started process 1668 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/tmpd2SZxd/profile http://localhost:49274/getInfo.html) 01:37:42 INFO - PROCESS | 1668 | __metrics Screen width/height:1600/1200 01:37:42 INFO - PROCESS | 1668 | colorDepth:24 01:37:42 INFO - PROCESS | 1668 | Browser inner width/height: 1024/689 01:37:42 INFO - PROCESS | 1668 | __metrics 01:37:42 INFO - PROCESS | 1668 | 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" 01:37:42 INFO - PROCESS | 1668 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 01:37:42 INFO - TEST-INFO | 1668: exit 0 01:37:42 INFO - Browser initialized. 01:37:42 INFO - Running cycle 1/1 for dromaeo_css test... 01:37:42 INFO - TEST-INFO | started process 1671 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/tmpd2SZxd/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:37:54 INFO - PROCESS | 1671 | RSS: Main: 243367936 01:37:54 INFO - PROCESS | 1671 | 01:38:46 INFO - PROCESS | 1671 | 1470559126236 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] 01:40:57 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49274/tests/dromaeo/cssquery-ext.html) 01:40:59 INFO - PROCESS | 1671 | RSS: Main: 359743488 01:40:59 INFO - PROCESS | 1671 | 01:44:02 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-ext.html (next: http://localhost:49274/tests/dromaeo/cssquery-jquery.html) 01:44:02 INFO - PROCESS | 1671 | RSS: Main: 386723840 01:44:02 INFO - PROCESS | 1671 | 01:47:05 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49274/tests/dromaeo/cssquery-mootools.html) 01:47:05 INFO - PROCESS | 1671 | RSS: Main: 365473792 01:47:05 INFO - PROCESS | 1671 | 01:50:08 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49274/tests/dromaeo/cssquery-prototype.html) 01:50:08 INFO - PROCESS | 1671 | RSS: Main: 353202176 01:50:08 INFO - PROCESS | 1671 | 01:53:11 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49274/tests/dromaeo/cssquery-yui.html) 01:53:12 INFO - PROCESS | 1671 | RSS: Main: 347754496 01:53:12 INFO - PROCESS | 1671 | 01:56:15 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-yui.html (next: http://localhost:49274/tests/dromaeo/cssquery-dojo.html) 01:56:16 INFO - PROCESS | 1671 | RSS: Main: 451055616 01:56:16 INFO - PROCESS | 1671 | 01:56:16 INFO - PROCESS | 1671 | __start_tp_report 01:56:16 INFO - PROCESS | 1671 | _x_x_mozilla_page_load 01:56:16 INFO - PROCESS | 1671 | _x_x_mozilla_page_load_details 01:56:16 INFO - PROCESS | 1671 | |i|pagename|runs| 01:56:16 INFO - PROCESS | 1671 | |0;dojo.html;3017.95473067904;3378.729701623869;3402.098443912362;3404.55740753702;3443.328550932569;5650.434956504348;5703.087505999041;5772.3361813391475;5802.767889284423;5815.709214539272;4784.378030855993;5757.596968212227;5862.970685146579;5904.763809447628;5910.497607703351;5166.328377310944;5177.58579313654;5239.659422137549;5258.710770907599;5270.604704647148;5280.920786188191;5282.656627319212;5283.101872681634;5290.656107353029;5339.519443250107;5183.429822719498;5186.533212010918;5189.574880578819;5232.58139348855;5247.23915032322;5274.97362513185;5275.736213189325;5291.417944026154;5299.046171689094;5301.098813201765;5189.143791274435;5235.58115350771;5248.21276808478;5265.131253343232;5281.656692314988;5712.400197979194;5798.652080875118;5837.766489340422;5866.354700982888;5875.471207591338;6261.436470717612;6299.811005669837;6318.873622527523;6334.461570766491;6336.841578960517;5121.974390128063;6249.031400132987;6302.810915672491;6320.841978950563;6321.24145102586;5866.472017518401;5937.643741375531;5940.8811823764145;5946.791862284843;5952.196453478811;6337.4613157882095;6351.555391122577;6371.936280637227;6373.012183111625;6397.10440538325;6084.452399283997;6109.908351374733;6111.266648002179;6240.344763799826;6266.843328916722;6194.101855230966;6286.874262514815;6289.842753931189;6294.622322660655;6307.810765677037;6139.846503837351;6175.505959523227;6194.938050619527;6206.782762603287;6210.534209934273;6161.907571386433;6228.5017198624;6232;6242.344553821783;6246.718897649616;4882.7558622068755;4910.189818679949;4928;4947.529984651453;4958.677685950402;3977.2642061218767;4395.1868904252815;4431.778411079433;4435.379046933432;4435.844745433894;5808.535317174616;5817.941820581825;5826.854328641818;5843.883122337529;5892.175095486636;6186.1648677428875;6203.4416902479;6299.590526615755;6302.590331628429;6305.873882522415;5814.622049566765;5848.970755146197;5856.443637854397;5880;5900.321463031806;5454.427285135083;5501.889962200814;5512.118061110203;5514.972425137928;5531;6227.128202051807;6257.937420625735;6415.326390728999;6431.5819471734185;6439.034144878212;6266.27937787142;6283;6283.057541368831;6301.558890877778;6306.274778400542;5456.454354564512;6343.429091381798;6384.297727250092;6394.328595497405;6401.487880969418;6115.755369785336;6147.170132032297;6194.5354098443695;6232.688365581794;6243.313235543996;6180.536459765625;6259.436650701458;6291.182146321132;6291.528135389955;6327.240731112296;6202.85247229264;6220.440160385587;6230.7507699691505;6244.250689917239;6246.156768836331;5977.013792724152;6194.566380353332;6201.596896201732;6219.471344935731;6225.719842607185;5976.043832986701;6045.516358691382;6055.636661800306;6099;6127.311699317154;5450.672959622435;6197.318294987457;6205.720742566686;6244.063390491463;6247.531435142291;5814.825555233349;5911.290645122613;6052.394760523913;6064.241969753781;6074.088886667036 01:56:16 INFO - PROCESS | 1671 | |1;ext.html;474.2435814875277;489.36138339467004;520.6667732651102;529.594859932152;549.8020712543486;25953;43377.78311108444;44407.77796111019;44577.10845783082;44864.878378040565;43898;44277.11445771083;44416.55583444165;44443.77778111113;44448.77775611125;8750.343724220676;9629.662961796339;9800.705978820646;9803.852942205836;9809.313348065638;8734.301255899512;9261.95369023154;11802.645920622395;11850.7629847403;12023.338716370596;11812.291262524233;11889.464974076187;11899.167058305879;11899.524019039229;11940;11799.469023893946;11875;11878.227915185485;11884.108691848145;11892.762144757056;11749;11825.58093028842;11828.23116497425;11839.526418943233;11857.5849845255;41186.38220426696;41648;41664.375034374505;41698.79150604258;41822.74531764052;3396.8811091611924;3446.4313388290902;3474.8783792567137;3504.5969713482764;3548.733844961638;27412.725872741215;32482;32529.51205731916;32790.06519217709;32986.83506582452;3270.787398819093;3347.7688193502163;3353.4634458486526;3388.5594872666643;3422.7775194612273;507693;508151;512475;514586;523905;62416;62806.371936280964;62897;62947;63003;66101.34746631373;66102.3474413134;66131.66934165299;66134;66195;16558.254878530493;16770.916145419196;16780.58048548796;16804;16810.747838782183;11511.251768635011;11843.644690659294;11862.466189021514;12423;12470.189437686702;14844.851551484562;15243.932924695388;15341.846581534264;15389.461368852037;15755.212239387985;5911.586188966817;7398.223186565441;7432.58441006675;7505.710758218686;7558.811029724301;931.6878845586805;989.2284018465608;1067.9137293222593;1081.145894743144;1100.2683215661496;28366.031905327094;30640.54039189414;30711.8464407681;31219;31679.20801979969;1051.8948105189572;1082.3343643659093;1093.2893619147458;1115.1970581181536;1164.2025212729307;15780.368785248462;16411.1794410279;16580.336786528645;16654.666906661798;16704.415345463094;693908;698638;699253;706233;941648;60547.39452605417;61109;61212;61227.38772612306;61310.77378452495;1358.9660258493418;1390.6801435669852;1410.4358256697403;1415.9504417345343;1418.9499770170207;23059.6541051881;23690.407739806644;27069.593956091067;27115.72884271132;27629.585556216272;52579.73710131425;54098.64753381197;54193.45806541884;54359.45640543544;54363.64090897759;618910;619648;620686.8965655143;621130;621897;26494;26899.731002690507;26967.190984270503;27029.459410812065;27057.053003144796;48820.511794883016;49143;50340.24489632585;51618.741906290226;52271.466066741654;39259.80370098131;40660;41000;42076.57923420727;42570;40298.395524066575;40480.1903961925;41088.58911410848;41383;41929.79035104927;38560.6143938557;39159.41260881146;39227.215455691294;39263;39588.60411395849;32654.836725816218;34949.951501455;35178.12054698653;36072.81963590165;36162.638373615926;25764.742352576235;25880;25962.22113336603;26128.216153515426;26254.949802007704 01:56:16 INFO - PROCESS | 1671 | |2;jquery.html;352.92941411717663;370.3777653542048;373.70290618957927;379.34752226170986;405.44858991771184;15604.921975390122;15987.600309992256;20255.189792408288;20735.792642073575;20891.582168356643;19481.70777438336;19979.800201997976;20308;20438.69341959868;20449.795502044974;5351.812686555972;5391.272178255944;5525.563353528071;5525.696086715229;6050.2134722486235;5899.557533185029;6091.695415229221;6101.298350689661;6102.145699602059;6107.847303817418;3864.671502922255;5769.451902069318;6022.187004754346;6066.878662426749;6137.079438084278;5865.4134586541;6074.058520929263;6110.541709371815;6122.602030867979;6134.110553969672;5923;5932.932072226998;5938.168656388109;5939.67331796751;5944.524438044946;13197.934010329984;15290.541283761506;20528.38414847557;25703.357416064562;26054;2030.3198428526462;2360.44529535559;2432.2946345559767;2622.1871219921886;2744.108164846433;10148.289619726622;11847.526098956032;15826.683466330609;16094.919525402414;16195.785316101339;1601.6786151425122;1874.18472964261;1895.2229585869727;1943.2906988949073;2029.989850050755;91599.54200228956;113600;121978;123798.38100809438;127882.36058819739;8182.345412366996;9474.810503789886;10087.546060427152;10088.74778130538;10118;12345.567905123278;12460.190087644274;12466.81299780504;12480.500779968881;12482.875171248354;7958.920410795934;8236.588170591447;8260.256576908107;8335.291500222427;8347.123552027071;8080;8163.551004694798;8218.671253149927;8345.833083338299;8508.532030738244;3856;3890.396988466792;3904.921901561953;3941.3693808990424;3954.228925359585;1746.7729195204543;1762.1453595006412;1912.3498010676437;1924.5381108533852;1924.6824273994634;691.9100516932766;729.5950747335173;811.6161943885661;816.7304789419477;883.1565854608833;19328.516787080436;20365.79634203639;20630.896845515676;20799.792002079786;20886.477838054172;902.201551626815;948.848184290524;956.3592393096642;966.1449617088787;991.1525645572931;10020.799584008424;10716.571337146583;10755.516001779939;10786.892131078588;10830.729231769268;528348;533023;534604;629882;633847;113720;152142.23928880284;152170.23914880355;156802;156880.21559892126;953.6423841059602;984.3650845204946;997.2620261006948;999.9300048996646;1017.8880323164447;18451.077446127907;18973.71539426882;19223.61552768909;19226;19476.4157075288;41562;55610.99501044925;55671.443285566624;56210;58832.99999999829;83323;85748.57125714581;87060.56469717865;87594.24811503862;88058;7732.8453430932195;7927.12801591836;7927.5243485391065;8372.706955256537;8376.874346884924;9256.72229833106;12132.332721700392;12658.493660253487;13010.54463093825;13026.348682565644;8945.776355591162;9591.280653950842;10905.618303359344;10935.945320273348;11236.83144752813;10781.568737250736;10970.890291096986;11088.667339979813;11161.665150045512;11426.714332141762;9677.70966870995;11199.888001119885;11384.886151138382;11416.972472477517;11698.532058717896;7925.405594580314;8098.83802323962;8127.390445716713;8150.470219435718;8202.09776924526;8455.873161902453;10784.083352914777;11116.722081948015;11340.09279257641;11348.602798901999 01:56:16 INFO - PROCESS | 1671 | |3;mootools.html;1499.1829452948139;1521.452277180215;1718.8538974187193;1863.692490739028;1890.8865468071926;8202.261796438319;8758.605862736176;8763.474191548512;8764.167404096617;8773.649054037847;7698.191689872567;7910.80222994424;8300.211479909414;8493.49039057657;8512.276456501204;2293.575688497633;2328.1734984080663;2329.196427232602;2330.417395651087;2335.6613291072786;2277;2299.4251437140715;2330.149495434163;2334.323046316566;2335.4161459635093;2311.3297143828268;2328.639060945556;2329.3594261578032;2334.8365614407;2341.672165896776;1969.6750036244002;2290.7022087128735;2294.908203671843;2297.368223738477;2303.9654405183937;2292.7363353214428;2299.6895419118373;2304.147465437799;2304.3778179891337;2309.515001849614;8491.532965686885;8677.826443471095;8684.348673849487;8693.913060869374;8694.21752042313;5100.056489549445;5153.896922061538;5172.974135129338;5175.585953123741;5182.53357197854;3306.768526203167;3352.8994130176134;3499.422595271777;3514.7012503937194;3519.982400087983;1067.6263307842194;1082.1775450657558;1094.9726256843562;1096.3202814255133;1096.446294621219;11113.388763617997;11261;11270.09839212861;11271.380074095921;11280.605178818783;4429.889252768642;4472.686911916199;4664.090502352076;4670.486246512881;4690.718556886598;9720.951395242979;9731.464769437607;9735.026497350209;9739.344311467068;9747;5169.612279079084;5174.482551744795;5176.120059589879;5181.507756763177;5187.896242075138;4261.893452663646;4285.635720963691;4424.513303536608;4441.333799929972;4767.95232047682;3883.9611603884164;3935.8819235422984;3966.186931678999;3973.2252210818615;4013.959860401417;1255.2468518888777;1291.1026836348647;1293.8318018657515;1301.264785396248;1303.928283944373;750.4296734481724;841.6044459104211;897.1028971028971;906.7687739626354;956.4691596164196;5466.316710411199;5493.560515158778;5819.301683797887;5845.795397161079;5888.851673923544;841.6843683618642;1006.225206590921;1010.8685870836745;1046.5918291866178;1074.425182527344;3045.1169160943523;3382.8308584570673;3699.500567423417;3712.8700495483067;3928.096537796323;10100.444475553915;10499.370037797757;10514.474276286155;10532.420716860493;10563.049325560736;10439.112675422522;10448.791024179474;10452.477376131163;10460.215483838743;10466.267361284637;7650.502717323468;7980.880286795703;8012.198780121941;8012.479188852706;8103.432759706882;5847.473727364558;5861.912071319019;5948.732307046107;5970.373110823301;5989.940100598938;9338.859917101114;9463.952680236831;9660.275479338938;9837.557309920927;9899.604015839286;9010.90989090127;9298.72103836886;9574.32979691415;9905.851412228967;9972.60109595637;7322.890156647761;7475.738349157971;7488.326050655467;7607.011088558452;7618.047744031996;8027.5584842834205;8241.134680858664;8284.627191776264;8320.292775113941;8327.500349978778;7335.669894854637;7388.778336649909;7389.704411823467;7445.664945077377;7456.96271518639;7296.343329100407;7297.817554560966;7313.23211062852;7353.522021068614;7377.299156580117;6542.803715888531;6571.934280657132;6647.510057219998;6809.38715515606;6872.347127022925;4767.165745994368;4863.954249836303;4888.388951381077;4925.261210818406;5012.6240531960975;4906.656534042583;4993.750312484434;4999.900002000012;5018.84943451697;5058.721770302669 01:56:16 INFO - PROCESS | 1671 | |4;prototype.html;298.20379586504043;300.76690564812276;310.2739589360895;315.5629453207307;318.36803944170833;4185.869815149916;5201.739913004353;5245.790168393264;5301;5307.73461326934;4662.717752618032;5043.823466178685;5112.923306150411;5179.119549676555;5269.552088072509;3180.9681903181017;3844.692424606025;4031.475908131939;4036.9798151009204;4044.119484439735;3365.444701624229;3781.981090094546;4033.294173519637;4064.5325787534516;4083.3262511685534;3945.960540394588;3954.7033972452036;3971.2454633619664;3982.761034337949;3990.620891015349;3972.708869617386;3975.8807235782974;3978.7413818101877;3982.780947047911;3985.442038114666;2956.49739544278;3177.682231776827;3288;3395.813230272334;3450.189205536697;4460.687751857371;5014.84955451337;5083.034223497561;5093.490650934877;5118.411382691001;3996.140829721624;4217.261979153666;4562.338460923148;4578.244589642738;4589.173948689235;5112.41207261166;5441.401445840955;5536.640118392332;5545.584081193886;5579.972100139514;3196.280836811722;3790.1472168762084;3791.4312853071983;3799.4680744695765;3817.8281977310808;5132.255822905695;5354.250404943311;5849.766009359663;5879.3826648202175;5947.583669143161;3609.8917032489067;3883.9319187223173;3895.552011518655;3896.7661940283106;3900.1419687668667;3890.599384221678;3908.882733517999;3922.8038598069984;3930.4890364252465;3938.6455219030427;4134.966258435391;4551.749653769075;4558.9742307981105;4560.977195114069;4591.9540804591525;4986.426560945465;5111.338814885103;5597.468240517144;5597.608167428241;5615.024037260258;1248.6878280429892;1328.554934097069;1331.287761047854;1333.9466421343038;1343.3887581150552;680.7923583307139;709.5104377979281;775.7789030126387;800.5556915911725;803.4857691077715;3705.740598158157;3842.634949679776;4399.436456470269;4408.647308215335;4442.555744425532;4022;4289.206496798102;4723.551262630044;4771.5923802478355;4789.353437285991;3485.3270430193647;4065.7763822989427;4125.360569111793;4377.60601545856;4389.034412429261;2255.590256089944;2316.8916286179497;2500.712418071909;2523.873806309677;2553.6424900513944;4534.221339098003;4856.004519073652;5006.374203224597;5042.621803364762;5054.620903432257;4382.663287697219;4477.00773155949;4608.377868987711;4907.386576677915;4954.777035033432;4159.625633692982;4261.957380426218;4671.5328467153695;4918.975405123095;4987.675801072919;3987.6610488108836;4018.7541862022867;4606.861794146181;4784.40194975628;4803.207470767424;4298.484181898067;4685.1654748876435;4725.149473094876;4746.5490778376;4753.031218932092;4263.722858014343;4406.074724307931;4872.780724867319;4947.77735001933;4968.0624556423745;2790.2884764384953;3312.4700047992205;3593.281343731212;3705.7776533408082;3733.757305775116;5669.376368599368;5693.572982026281;5700.230468886647;5713.971485132716;5768.423157684366;4640.350350950802;4837.782299796588;5173.715445650375;5449.727513624223;5516;5164.431912489548;5450.400455949922;5460.808871689472;5520.91718624229;5534.418886016911;5394.487523685244;5422.48486393792;5426.972865135807;5440.292761940922;5454.336427389684;4678.0586056787415;5242.5281724644965;5476.972615136899;5515.834524964257;5547.861303467445;5324.9467505326;5326.573874090141;5382.03123437785;5386.596005299697;5393.9730301348245 01:56:16 INFO - PROCESS | 1671 | |5;yui.html;682.1711620381237;722.4401089155907;733.3546479098394;775.0853992289096;776.425445170574;14741.11553306801;15958.76061859073;15965.281562329694;15980.121093339876;15998.040117592953;11904.345261010641;13602.591922242324;13708.931455342708;13947.790783138236;13983.440662373492;707.1655446573042;730.0071902213012;853.1638993786094;868.5874209750366;882.7042940614901;883.567052144451;901.8286525560122;903.1510380242584;903.7017784131253;906.4561263242068;947.6398968392001;950.0594411532568;951.5765484359463;952.8427809411439;956.3018996132793;731.4002517935295;748.4685873030155;752.9947520060725;949.981000379992;950.2920324358363;558.8435238133329;560.7112337146373;672.3209558346106;700.6391708270245;701.7158050989358;14841;14857.405703771836;14862.331195096247;14873.47942821996;14888;12133.393330333449;12282.263064216175;12295.200811947285;12446.875531244752;12677;12408.56570020045;12520.153665478934;12559.497620095186;12717.936410317981;12904.612861614167;4507.414036175309;4519.322101684741;4524.886877828048;4710.222813235812;4748.311494833264;123905;124206;124259;124539;124841.9999999991;10722.78554428907;10744.570217191382;10810.459477026117;10831.891681083089;11365;21085.578288434146;21309.36071917814;21352.14591416326;21364.465888352915;21398.679019814714;7758;7768.689252429953;7776.416768742367;7781.796173098539;8026.1572534883;4298.742075475481;4330.870073897788;4336.2845130553105;4432.224360736858;4500.3249512573375;3422.418188907842;3527.876524321636;3530.9293814123575;3533.063738109403;3533.6643018913164;691.4399336537421;729.9817504562322;730.2004305285703;730.8390270023751;734.6253410760551;598.4912824099481;684.1516519515864;697.2504557600599;702.3468174597571;704.4258928972973;9319.114684105;9359.766005849771;9686.564104615309;9687.273454490942;9946.502674866228;572.3503823160743;605.3250625552565;634.9142865713162;652.1261509577095;672;4202.432671589358;4522.909541809211;4572.154151481986;4609.700369475973;4643.210654188796;164911;169199.15400423165;170090;171085;172586;145671;148151.71762835555;149854.50145498622;150708;151466.06123996826;120363;121989;122259;123765;129232.70767292395;7611.3530349920875;7703.922960770321;7844.450888437755;8763.649454021768;8805;63759;64069.679651601444;65223;65783.34216657773;66818.66590667015;91982;94819.5259023728;98992.50503747436;100188;100265;10463.68608941733;11844.822327665264;11945.581904633296;12053.57812476559;12297.077719171277;13218.537351192663;13501.527446539323;13512.79730804019;13559;14034.438622454987;10651.733706657085;12263.762230750024;12465.439055242718;12469.937650311691;12621;8947.955260223658;11581.768364632828;13367.532136375568;13784.793228101385;14244.359003844645;13448.731025379633;13617.387217575035;13850.722985540435;14009.929950350182;14498.637534061732;9657.3239873211;9885.654002109892;10527.894721052999;11374.31754094757;11788;9620.470874101991;10058.396496210251;10245.74385640365;10259.333143345659;10316.123129534073 01:56:16 INFO - PROCESS | 1671 | __end_tp_report 01:56:16 INFO - PROCESS | 1671 | __start_cc_report 01:56:16 INFO - PROCESS | 1671 | _x_x_mozilla_cycle_collect,1283 01:56:16 INFO - PROCESS | 1671 | __end_cc_report 01:56:16 INFO - PROCESS | 1671 | __startTimestamp1470560176023__endTimestamp 01:56:16 INFO - PROCESS | 1671 | 01:56:16 INFO - PROCESS | 1671 | ------- Summary: start ------- 01:56:16 INFO - PROCESS | 1671 | Number of tests: 6 01:56:16 INFO - PROCESS | 1671 | 01:56:16 INFO - PROCESS | 1671 | [#0] dojo.html Cycles:165 Average:5782.84 Median:6045.52 stddev:665.45 (11.0%) stddev-sans-first:631.15 01:56:16 INFO - PROCESS | 1671 | Values: 3018.0 3378.7 3402.1 3404.6 3443.3 5650.4 5703.1 5772.3 5802.8 5815.7 4784.4 5757.6 5863.0 5904.8 5910.5 5166.3 5177.6 5239.7 5258.7 5270.6 5280.9 5282.7 5283.1 5290.7 5339.5 5183.4 5186.5 5189.6 5232.6 5247.2 5275.0 5275.7 5291.4 5299.0 5301.1 5189.1 5235.6 5248.2 5265.1 5281.7 5712.4 5798.7 5837.8 5866.4 5875.5 6261.4 6299.8 6318.9 6334.5 6336.8 5122.0 6249.0 6302.8 6320.8 6321.2 5866.5 5937.6 5940.9 5946.8 5952.2 6337.5 6351.6 6371.9 6373.0 6397.1 6084.5 6109.9 6111.3 6240.3 6266.8 6194.1 6286.9 6289.8 6294.6 6307.8 6139.8 6175.5 6194.9 6206.8 6210.5 6161.9 6228.5 6232.0 6242.3 6246.7 4882.8 4910.2 4928.0 4947.5 4958.7 3977.3 4395.2 4431.8 4435.4 4435.8 5808.5 5817.9 5826.9 5843.9 5892.2 6186.2 6203.4 6299.6 6302.6 6305.9 5814.6 5849.0 5856.4 5880.0 5900.3 5454.4 5501.9 5512.1 5515.0 5531.0 6227.1 6257.9 6415.3 6431.6 6439.0 6266.3 6283.0 6283.1 6301.6 6306.3 5456.5 6343.4 6384.3 6394.3 6401.5 6115.8 6147.2 6194.5 6232.7 6243.3 6180.5 6259.4 6291.2 6291.5 6327.2 6202.9 6220.4 6230.8 6244.3 6246.2 5977.0 6194.6 6201.6 6219.5 6225.7 5976.0 6045.5 6055.6 6099.0 6127.3 5450.7 6197.3 6205.7 6244.1 6247.5 5814.8 5911.3 6052.4 6064.2 6074.1 01:56:16 INFO - PROCESS | 1671 | 01:56:16 INFO - PROCESS | 1671 | [#1] ext.html Cycles:180 Average:75949.09 Median:36117.73 stddev:170799.00 (472.9%) stddev-sans-first:171184.13 01:56:16 INFO - PROCESS | 1671 | Values: 474.2 489.4 520.7 529.6 549.8 25953.0 43377.8 44407.8 44577.1 44864.9 43898.0 44277.1 44416.6 44443.8 44448.8 8750.3 9629.7 9800.7 9803.9 9809.3 8734.3 9262.0 11802.6 11850.8 12023.3 11812.3 11889.5 11899.2 11899.5 11940.0 11799.5 11875.0 11878.2 11884.1 11892.8 11749.0 11825.6 11828.2 11839.5 11857.6 41186.4 41648.0 41664.4 41698.8 41822.7 3396.9 3446.4 3474.9 3504.6 3548.7 27412.7 32482.0 32529.5 32790.1 32986.8 3270.8 3347.8 3353.5 3388.6 3422.8 507693.0 508151.0 512475.0 514586.0 523905.0 62416.0 62806.4 62897.0 62947.0 63003.0 66101.3 66102.3 66131.7 66134.0 66195.0 16558.3 16770.9 16780.6 16804.0 16810.7 11511.3 11843.6 11862.5 12423.0 12470.2 14844.9 15243.9 15341.8 15389.5 15755.2 5911.6 7398.2 7432.6 7505.7 7558.8 931.7 989.2 1067.9 1081.1 1100.3 28366.0 30640.5 30711.8 31219.0 31679.2 1051.9 1082.3 1093.3 1115.2 1164.2 15780.4 16411.2 16580.3 16654.7 16704.4 693908.0 698638.0 699253.0 706233.0 941648.0 60547.4 61109.0 61212.0 61227.4 61310.8 1359.0 1390.7 1410.4 1416.0 1418.9 23059.7 23690.4 27069.6 27115.7 27629.6 52579.7 54098.6 54193.5 54359.5 54363.6 618910.0 619648.0 620686.9 621130.0 621897.0 26494.0 26899.7 26967.2 27029.5 27057.1 48820.5 49143.0 50340.2 51618.7 52271.5 39259.8 40660.0 41000.0 42076.6 42570.0 40298.4 40480.2 41088.6 41383.0 41929.8 38560.6 39159.4 39227.2 39263.0 39588.6 32654.8 34950.0 35178.1 36072.8 36162.6 25764.7 25880.0 25962.2 26128.2 26254.9 01:56:16 INFO - PROCESS | 1671 | 01:56:16 INFO - PROCESS | 1671 | [#2] jquery.html Cycles:180 Average:34701.97 Median:376.53 stddev:96793.69 (25707.1%) stddev-sans-first:97030.86 01:56:16 INFO - PROCESS | 1671 | Values: 352.9 370.4 373.7 379.3 405.4 15604.9 15987.6 20255.2 20735.8 20891.6 19481.7 19979.8 20308.0 20438.7 20449.8 5351.8 5391.3 5525.6 5525.7 6050.2 5899.6 6091.7 6101.3 6102.1 6107.8 3864.7 5769.5 6022.2 6066.9 6137.1 5865.4 6074.1 6110.5 6122.6 6134.1 5923.0 5932.9 5938.2 5939.7 5944.5 13197.9 15290.5 20528.4 25703.4 26054.0 2030.3 2360.4 2432.3 2622.2 2744.1 10148.3 11847.5 15826.7 16094.9 16195.8 1601.7 1874.2 1895.2 1943.3 2030.0 91599.5 113600.0 121978.0 123798.4 127882.4 8182.3 9474.8 10087.5 10088.7 10118.0 12345.6 12460.2 12466.8 12480.5 12482.9 7958.9 8236.6 8260.3 8335.3 8347.1 8080.0 8163.6 8218.7 8345.8 8508.5 3856.0 3890.4 3904.9 3941.4 3954.2 1746.8 1762.1 1912.3 1924.5 1924.7 691.9 729.6 811.6 816.7 883.2 19328.5 20365.8 20630.9 20799.8 20886.5 902.2 948.8 956.4 966.1 991.2 10020.8 10716.6 10755.5 10786.9 10830.7 528348.0 533023.0 534604.0 629882.0 633847.0 113720.0 152142.2 152170.2 156802.0 156880.2 953.6 984.4 997.3 999.9 1017.9 18451.1 18973.7 19223.6 19226.0 19476.4 41562.0 55611.0 55671.4 56210.0 58833.0 83323.0 85748.6 87060.6 87594.2 88058.0 7732.8 7927.1 7927.5 8372.7 8376.9 9256.7 12132.3 12658.5 13010.5 13026.3 8945.8 9591.3 10905.6 10935.9 11236.8 10781.6 10970.9 11088.7 11161.7 11426.7 9677.7 11199.9 11384.9 11417.0 11698.5 7925.4 8098.8 8127.4 8150.5 8202.1 8455.9 10784.1 11116.7 11340.1 11348.6 01:56:16 INFO - PROCESS | 1671 | 01:56:16 INFO - PROCESS | 1671 | [#3] mootools.html Cycles:180 Average:5581.12 Median:5006.26 stddev:3103.59 (62.0%) stddev-sans-first:3097.14 01:56:16 INFO - PROCESS | 1671 | Values: 1499.2 1521.5 1718.9 1863.7 1890.9 8202.3 8758.6 8763.5 8764.2 8773.6 7698.2 7910.8 8300.2 8493.5 8512.3 2293.6 2328.2 2329.2 2330.4 2335.7 2277.0 2299.4 2330.1 2334.3 2335.4 2311.3 2328.6 2329.4 2334.8 2341.7 1969.7 2290.7 2294.9 2297.4 2304.0 2292.7 2299.7 2304.1 2304.4 2309.5 8491.5 8677.8 8684.3 8693.9 8694.2 5100.1 5153.9 5173.0 5175.6 5182.5 3306.8 3352.9 3499.4 3514.7 3520.0 1067.6 1082.2 1095.0 1096.3 1096.4 11113.4 11261.0 11270.1 11271.4 11280.6 4429.9 4472.7 4664.1 4670.5 4690.7 9721.0 9731.5 9735.0 9739.3 9747.0 5169.6 5174.5 5176.1 5181.5 5187.9 4261.9 4285.6 4424.5 4441.3 4768.0 3884.0 3935.9 3966.2 3973.2 4014.0 1255.2 1291.1 1293.8 1301.3 1303.9 750.4 841.6 897.1 906.8 956.5 5466.3 5493.6 5819.3 5845.8 5888.9 841.7 1006.2 1010.9 1046.6 1074.4 3045.1 3382.8 3699.5 3712.9 3928.1 10100.4 10499.4 10514.5 10532.4 10563.0 10439.1 10448.8 10452.5 10460.2 10466.3 7650.5 7980.9 8012.2 8012.5 8103.4 5847.5 5861.9 5948.7 5970.4 5989.9 9338.9 9464.0 9660.3 9837.6 9899.6 9010.9 9298.7 9574.3 9905.9 9972.6 7322.9 7475.7 7488.3 7607.0 7618.0 8027.6 8241.1 8284.6 8320.3 8327.5 7335.7 7388.8 7389.7 7445.7 7457.0 7296.3 7297.8 7313.2 7353.5 7377.3 6542.8 6571.9 6647.5 6809.4 6872.3 4767.2 4864.0 4888.4 4925.3 5012.6 4906.7 4993.8 4999.9 5018.8 5058.7 01:56:16 INFO - PROCESS | 1671 | 01:56:16 INFO - PROCESS | 1671 | [#4] prototype.html Cycles:180 Average:4222.12 Median:4570.29 stddev:1295.47 (28.3%) stddev-sans-first:1265.18 01:56:16 INFO - PROCESS | 1671 | Values: 298.2 300.8 310.3 315.6 318.4 4185.9 5201.7 5245.8 5301.0 5307.7 4662.7 5043.8 5112.9 5179.1 5269.6 3181.0 3844.7 4031.5 4037.0 4044.1 3365.4 3782.0 4033.3 4064.5 4083.3 3946.0 3954.7 3971.2 3982.8 3990.6 3972.7 3975.9 3978.7 3982.8 3985.4 2956.5 3177.7 3288.0 3395.8 3450.2 4460.7 5014.8 5083.0 5093.5 5118.4 3996.1 4217.3 4562.3 4578.2 4589.2 5112.4 5441.4 5536.6 5545.6 5580.0 3196.3 3790.1 3791.4 3799.5 3817.8 5132.3 5354.3 5849.8 5879.4 5947.6 3609.9 3883.9 3895.6 3896.8 3900.1 3890.6 3908.9 3922.8 3930.5 3938.6 4135.0 4551.7 4559.0 4561.0 4592.0 4986.4 5111.3 5597.5 5597.6 5615.0 1248.7 1328.6 1331.3 1333.9 1343.4 680.8 709.5 775.8 800.6 803.5 3705.7 3842.6 4399.4 4408.6 4442.6 4022.0 4289.2 4723.6 4771.6 4789.4 3485.3 4065.8 4125.4 4377.6 4389.0 2255.6 2316.9 2500.7 2523.9 2553.6 4534.2 4856.0 5006.4 5042.6 5054.6 4382.7 4477.0 4608.4 4907.4 4954.8 4159.6 4262.0 4671.5 4919.0 4987.7 3987.7 4018.8 4606.9 4784.4 4803.2 4298.5 4685.2 4725.1 4746.5 4753.0 4263.7 4406.1 4872.8 4947.8 4968.1 2790.3 3312.5 3593.3 3705.8 3733.8 5669.4 5693.6 5700.2 5714.0 5768.4 4640.4 4837.8 5173.7 5449.7 5516.0 5164.4 5450.4 5460.8 5520.9 5534.4 5394.5 5422.5 5427.0 5440.3 5454.3 4678.1 5242.5 5477.0 5515.8 5547.9 5324.9 5326.6 5382.0 5386.6 5394.0 01:56:16 INFO - PROCESS | 1671 | 01:56:16 INFO - PROCESS | 1671 | [#5] yui.html Cycles:180 Average:26779.53 Median:3532.00 stddev:45004.79 (1274.2%) stddev-sans-first:45088.38 01:56:16 INFO - PROCESS | 1671 | Values: 682.2 722.4 733.4 775.1 776.4 14741.1 15958.8 15965.3 15980.1 15998.0 11904.3 13602.6 13708.9 13947.8 13983.4 707.2 730.0 853.2 868.6 882.7 883.6 901.8 903.2 903.7 906.5 947.6 950.1 951.6 952.8 956.3 731.4 748.5 753.0 950.0 950.3 558.8 560.7 672.3 700.6 701.7 14841.0 14857.4 14862.3 14873.5 14888.0 12133.4 12282.3 12295.2 12446.9 12677.0 12408.6 12520.2 12559.5 12717.9 12904.6 4507.4 4519.3 4524.9 4710.2 4748.3 123905.0 124206.0 124259.0 124539.0 124842.0 10722.8 10744.6 10810.5 10831.9 11365.0 21085.6 21309.4 21352.1 21364.5 21398.7 7758.0 7768.7 7776.4 7781.8 8026.2 4298.7 4330.9 4336.3 4432.2 4500.3 3422.4 3527.9 3530.9 3533.1 3533.7 691.4 730.0 730.2 730.8 734.6 598.5 684.2 697.3 702.3 704.4 9319.1 9359.8 9686.6 9687.3 9946.5 572.4 605.3 634.9 652.1 672.0 4202.4 4522.9 4572.2 4609.7 4643.2 164911.0 169199.2 170090.0 171085.0 172586.0 145671.0 148151.7 149854.5 150708.0 151466.1 120363.0 121989.0 122259.0 123765.0 129232.7 7611.4 7703.9 7844.5 8763.6 8805.0 63759.0 64069.7 65223.0 65783.3 66818.7 91982.0 94819.5 98992.5 100188.0 100265.0 10463.7 11844.8 11945.6 12053.6 12297.1 13218.5 13501.5 13512.8 13559.0 14034.4 10651.7 12263.8 12465.4 12469.9 12621.0 8948.0 11581.8 13367.5 13784.8 14244.4 13448.7 13617.4 13850.7 14009.9 14498.6 9657.3 9885.7 10527.9 11374.3 11788.0 9620.5 10058.4 10245.7 10259.3 10316.1 01:56:16 INFO - PROCESS | 1671 | -------- Summary: end -------- 01:56:16 INFO - PROCESS | 1671 | 01:56:16 INFO - TEST-INFO | 1671: exit 0 01:56:16 INFO - TEST-OK | dromaeo_css | took 1116937ms 01:56:16 INFO - TEST-START | kraken 01:56:16 INFO - operating with platform_type : mac_ 01:56:16 INFO - Initialising browser for kraken test... 01:56:16 INFO - TEST-INFO | started process 1676 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/tmpr3MzTp/profile http://localhost:49274/getInfo.html) 01:56:19 INFO - PROCESS | 1676 | __metrics Screen width/height:1600/1200 01:56:19 INFO - PROCESS | 1676 | colorDepth:24 01:56:19 INFO - PROCESS | 1676 | Browser inner width/height: 1024/689 01:56:19 INFO - PROCESS | 1676 | __metrics 01:56:19 INFO - PROCESS | 1676 | 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" 01:56:19 INFO - PROCESS | 1676 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 01:56:19 INFO - TEST-INFO | 1676: exit 0 01:56:19 INFO - Browser initialized. 01:56:19 INFO - Running cycle 1/1 for kraken test... 01:56:19 INFO - TEST-INFO | started process 1677 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/tmpr3MzTp/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:56:31 INFO - PROCESS | 1677 | RSS: Main: 243576832 01:56:31 INFO - PROCESS | 1677 | 01:56:34 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-beat-detection) 01:56:35 INFO - PROCESS | 1677 | RSS: Main: 294510592 01:56:35 INFO - PROCESS | 1677 | 01:56:37 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-dft) 01:56:38 INFO - PROCESS | 1677 | RSS: Main: 304578560 01:56:38 INFO - PROCESS | 1677 | 01:56:42 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-fft) 01:56:42 INFO - PROCESS | 1677 | RSS: Main: 395505664 01:56:42 INFO - PROCESS | 1677 | 01:56:44 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-oscillator) 01:56:45 INFO - PROCESS | 1677 | RSS: Main: 298819584 01:56:45 INFO - PROCESS | 1677 | 01:56:47 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49274/tests/kraken/driver.html?testName=imaging-gaussian-blur) 01:56:47 INFO - PROCESS | 1677 | RSS: Main: 302415872 01:56:47 INFO - PROCESS | 1677 | 01:56:50 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49274/tests/kraken/driver.html?testName=imaging-darkroom) 01:56:51 INFO - PROCESS | 1677 | RSS: Main: 338960384 01:56:51 INFO - PROCESS | 1677 | 01:56:54 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49274/tests/kraken/driver.html?testName=imaging-desaturate) 01:56:54 INFO - PROCESS | 1677 | RSS: Main: 342056960 01:56:54 INFO - PROCESS | 1677 | 01:56:57 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49274/tests/kraken/driver.html?testName=json-parse-financial) 01:56:58 INFO - PROCESS | 1677 | RSS: Main: 341651456 01:56:58 INFO - PROCESS | 1677 | 01:56:59 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49274/tests/kraken/driver.html?testName=json-stringify-tinderbox) 01:57:00 INFO - PROCESS | 1677 | RSS: Main: 314589184 01:57:00 INFO - PROCESS | 1677 | 01:57:02 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-aes) 01:57:03 INFO - PROCESS | 1677 | RSS: Main: 319143936 01:57:03 INFO - PROCESS | 1677 | 01:57:05 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-ccm) 01:57:05 INFO - PROCESS | 1677 | RSS: Main: 327032832 01:57:05 INFO - PROCESS | 1677 | 01:57:08 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 01:57:09 INFO - PROCESS | 1677 | RSS: Main: 333631488 01:57:09 INFO - PROCESS | 1677 | 01:57:12 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 01:57:13 INFO - PROCESS | 1677 | RSS: Main: 335118336 01:57:13 INFO - PROCESS | 1677 | 01:57:14 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49274/tests/kraken/driver.html?testName=ai-astar) 01:57:15 INFO - PROCESS | 1677 | RSS: Main: 378552320 01:57:15 INFO - PROCESS | 1677 | 01:57:15 INFO - PROCESS | 1677 | __start_tp_report 01:57:15 INFO - PROCESS | 1677 | _x_x_mozilla_page_load 01:57:15 INFO - PROCESS | 1677 | _x_x_mozilla_page_load_details 01:57:15 INFO - PROCESS | 1677 | |i|pagename|runs| 01:57:15 INFO - PROCESS | 1677 | |0;ai-astar;101;113;115;113;114;115;113;113;113;114 01:57:15 INFO - PROCESS | 1677 | |1;audio-beat-detection;143;107;106;166;108;108;128;106;139;106 01:57:15 INFO - PROCESS | 1677 | |2;audio-dft;183;183;185;182;184;181;183;183;182;184 01:57:15 INFO - PROCESS | 1677 | |3;audio-fft;80;58;72;129;76;64;65;63;83;56 01:57:15 INFO - PROCESS | 1677 | |4;audio-oscillator;81;68;90;68;74;68;98;70;67;97 01:57:15 INFO - PROCESS | 1677 | |5;imaging-gaussian-blur;89;85;87;85;93;129;88;85;88;84 01:57:15 INFO - PROCESS | 1677 | |6;imaging-darkroom;96;93;93;92;93;93;94;96;93;92 01:57:15 INFO - PROCESS | 1677 | |7;imaging-desaturate;85;84;86;83;84;100;133;133;84;86 01:57:15 INFO - PROCESS | 1677 | |8;json-parse-financial;54;52;52;52;51;53;52;50;52;51 01:57:15 INFO - PROCESS | 1677 | |9;json-stringify-tinderbox;65;67;74;80;72;72;71;71;70;71 01:57:15 INFO - PROCESS | 1677 | |10;stanford-crypto-aes;82;85;83;86;85;85;86;84;83;79 01:57:15 INFO - PROCESS | 1677 | |11;stanford-crypto-ccm;139;137;139;136;138;120;158;144;153;138 01:57:15 INFO - PROCESS | 1677 | |12;stanford-crypto-pbkdf2;162;223;220;166;163;167;168;163;181;224 01:57:15 INFO - PROCESS | 1677 | |13;stanford-crypto-sha256-iterative;67;67;67;66;67;66;65;66;66;66 01:57:15 INFO - PROCESS | 1677 | __end_tp_report 01:57:15 INFO - PROCESS | 1677 | __start_cc_report 01:57:15 INFO - PROCESS | 1677 | _x_x_mozilla_cycle_collect,2013 01:57:15 INFO - PROCESS | 1677 | __end_cc_report 01:57:15 INFO - PROCESS | 1677 | __startTimestamp1470560235120__endTimestamp 01:57:15 INFO - PROCESS | 1677 | 01:57:15 INFO - PROCESS | 1677 | ------- Summary: start ------- 01:57:15 INFO - PROCESS | 1677 | Number of tests: 14 01:57:15 INFO - PROCESS | 1677 | 01:57:15 INFO - PROCESS | 1677 | [#0] ai-astar Cycles:10 Average:112.40 Median:113.50 stddev:4.09 (3.6%) stddev-sans-first:0.87 01:57:15 INFO - PROCESS | 1677 | Values: 101.0 113.0 115.0 113.0 114.0 115.0 113.0 113.0 113.0 114.0 01:57:15 INFO - PROCESS | 1677 | 01:57:15 INFO - PROCESS | 1677 | [#1] audio-beat-detection Cycles:10 Average:121.70 Median:118.00 stddev:21.31 (18.1%) stddev-sans-first:21.16 01:57:15 INFO - PROCESS | 1677 | Values: 143.0 107.0 106.0 166.0 108.0 108.0 128.0 106.0 139.0 106.0 01:57:15 INFO - PROCESS | 1677 | 01:57:15 INFO - PROCESS | 1677 | [#2] audio-dft Cycles:10 Average:183.00 Median:183.00 stddev:1.15 (0.6%) stddev-sans-first:1.22 01:57:15 INFO - PROCESS | 1677 | Values: 183.0 183.0 185.0 182.0 184.0 181.0 183.0 183.0 182.0 184.0 01:57:15 INFO - PROCESS | 1677 | 01:57:15 INFO - PROCESS | 1677 | [#3] audio-fft Cycles:10 Average:74.60 Median:68.50 stddev:21.16 (30.9%) stddev-sans-first:22.35 01:57:15 INFO - PROCESS | 1677 | Values: 80.0 58.0 72.0 129.0 76.0 64.0 65.0 63.0 83.0 56.0 01:57:15 INFO - PROCESS | 1677 | 01:57:15 INFO - PROCESS | 1677 | [#4] audio-oscillator Cycles:10 Average:78.10 Median:77.50 stddev:12.54 (16.2%) stddev-sans-first:13.25 01:57:15 INFO - PROCESS | 1677 | Values: 81.0 68.0 90.0 68.0 74.0 68.0 98.0 70.0 67.0 97.0 01:57:15 INFO - PROCESS | 1677 | 01:57:15 INFO - PROCESS | 1677 | [#5] imaging-gaussian-blur Cycles:10 Average:91.30 Median:87.50 stddev:13.51 (15.4%) stddev-sans-first:14.30 01:57:15 INFO - PROCESS | 1677 | Values: 89.0 85.0 87.0 85.0 93.0 129.0 88.0 85.0 88.0 84.0 01:57:15 INFO - PROCESS | 1677 | 01:57:15 INFO - PROCESS | 1677 | [#6] imaging-darkroom Cycles:10 Average:93.50 Median:93.00 stddev:1.43 (1.5%) stddev-sans-first:1.20 01:57:15 INFO - PROCESS | 1677 | Values: 96.0 93.0 93.0 92.0 93.0 93.0 94.0 96.0 93.0 92.0 01:57:15 INFO - PROCESS | 1677 | 01:57:15 INFO - PROCESS | 1677 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:84.00 stddev:20.21 (24.1%) stddev-sans-first:21.05 01:57:15 INFO - PROCESS | 1677 | Values: 85.0 84.0 86.0 83.0 84.0 100.0 133.0 133.0 84.0 86.0 01:57:15 INFO - PROCESS | 1677 | 01:57:15 INFO - PROCESS | 1677 | [#8] json-parse-financial Cycles:10 Average:51.90 Median:52.00 stddev:1.10 (2.1%) stddev-sans-first:0.87 01:57:15 INFO - PROCESS | 1677 | Values: 54.0 52.0 52.0 52.0 51.0 53.0 52.0 50.0 52.0 51.0 01:57:15 INFO - PROCESS | 1677 | 01:57:15 INFO - PROCESS | 1677 | [#9] json-stringify-tinderbox Cycles:10 Average:71.30 Median:71.50 stddev:4.00 (5.6%) stddev-sans-first:3.54 01:57:15 INFO - PROCESS | 1677 | Values: 65.0 67.0 74.0 80.0 72.0 72.0 71.0 71.0 70.0 71.0 01:57:15 INFO - PROCESS | 1677 | 01:57:15 INFO - PROCESS | 1677 | [#10] stanford-crypto-aes Cycles:10 Average:83.80 Median:85.00 stddev:2.15 (2.5%) stddev-sans-first:2.18 01:57:15 INFO - PROCESS | 1677 | Values: 82.0 85.0 83.0 86.0 85.0 85.0 86.0 84.0 83.0 79.0 01:57:15 INFO - PROCESS | 1677 | 01:57:15 INFO - PROCESS | 1677 | [#11] stanford-crypto-ccm Cycles:10 Average:140.20 Median:139.00 stddev:10.24 (7.4%) stddev-sans-first:10.85 01:57:15 INFO - PROCESS | 1677 | Values: 139.0 137.0 139.0 136.0 138.0 120.0 158.0 144.0 153.0 138.0 01:57:15 INFO - PROCESS | 1677 | 01:57:15 INFO - PROCESS | 1677 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:183.70 Median:174.50 stddev:27.20 (15.6%) stddev-sans-first:27.70 01:57:15 INFO - PROCESS | 1677 | Values: 162.0 223.0 220.0 166.0 163.0 167.0 168.0 163.0 181.0 224.0 01:57:15 INFO - PROCESS | 1677 | 01:57:15 INFO - PROCESS | 1677 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.30 Median:66.50 stddev:0.67 (1.0%) stddev-sans-first:0.67 01:57:15 INFO - PROCESS | 1677 | Values: 67.0 67.0 67.0 66.0 67.0 66.0 65.0 66.0 66.0 66.0 01:57:15 INFO - PROCESS | 1677 | -------- Summary: end -------- 01:57:15 INFO - PROCESS | 1677 | 01:57:15 INFO - TEST-INFO | 1677: exit 0 01:57:15 INFO - TEST-OK | kraken | took 59349ms 01:57:15 INFO - SUITE-END | took 1176s 01:57:16 INFO - Completed test suite (00:19:36) 01:57:16 INFO - javascript benchmark 01:57:16 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3017.95473067904, 3378.729701623869, 3402.098443912362, 3404.55740753702, 3443.328550932569, 5650.434956504348, 5703.087505999041, 5772.3361813391475, 5802.767889284423, 5815.709214539272, 4784.378030855993, 5757.596968212227, 5862.970685146579, 5904.763809447628, 5910.497607703351, 5166.328377310944, 5177.58579313654, 5239.659422137549, 5258.710770907599, 5270.604704647148, 5280.920786188191, 5282.656627319212, 5283.101872681634, 5290.656107353029, 5339.519443250107, 5183.429822719498, 5186.533212010918, 5189.574880578819, 5232.58139348855, 5247.23915032322, 5274.97362513185, 5275.736213189325, 5291.417944026154, 5299.046171689094, 5301.098813201765, 5189.143791274435, 5235.58115350771, 5248.21276808478, 5265.131253343232, 5281.656692314988, 5712.400197979194, 5798.652080875118, 5837.766489340422, 5866.354700982888, 5875.471207591338, 6261.436470717612, 6299.811005669837, 6318.873622527523, 6334.461570766491, 6336.841578960517, 5121.974390128063, 6249.031400132987, 6302.810915672491, 6320.841978950563, 6321.24145102586, 5866.472017518401, 5937.643741375531, 5940.8811823764145, 5946.791862284843, 5952.196453478811, 6337.4613157882095, 6351.555391122577, 6371.936280637227, 6373.012183111625, 6397.10440538325, 6084.452399283997, 6109.908351374733, 6111.266648002179, 6240.344763799826, 6266.843328916722, 6194.101855230966, 6286.874262514815, 6289.842753931189, 6294.622322660655, 6307.810765677037, 6139.846503837351, 6175.505959523227, 6194.938050619527, 6206.782762603287, 6210.534209934273, 6161.907571386433, 6228.5017198624, 6232.0, 6242.344553821783, 6246.718897649616, 4882.7558622068755, 4910.189818679949, 4928.0, 4947.529984651453, 4958.677685950402, 3977.2642061218767, 4395.1868904252815, 4431.778411079433, 4435.379046933432, 4435.844745433894, 5808.535317174616, 5817.941820581825, 5826.854328641818, 5843.883122337529, 5892.175095486636, 6186.1648677428875, 6203.4416902479, 6299.590526615755, 6302.590331628429, 6305.873882522415, 5814.622049566765, 5848.970755146197, 5856.443637854397, 5880.0, 5900.321463031806, 5454.427285135083, 5501.889962200814, 5512.118061110203, 5514.972425137928, 5531.0, 6227.128202051807, 6257.937420625735, 6415.326390728999, 6431.5819471734185, 6439.034144878212, 6266.27937787142, 6283.0, 6283.057541368831, 6301.558890877778, 6306.274778400542, 5456.454354564512, 6343.429091381798, 6384.297727250092, 6394.328595497405, 6401.487880969418, 6115.755369785336, 6147.170132032297, 6194.5354098443695, 6232.688365581794, 6243.313235543996, 6180.536459765625, 6259.436650701458, 6291.182146321132, 6291.528135389955, 6327.240731112296, 6202.85247229264, 6220.440160385587, 6230.7507699691505, 6244.250689917239, 6246.156768836331, 5977.013792724152, 6194.566380353332, 6201.596896201732, 6219.471344935731, 6225.719842607185, 5976.043832986701, 6045.516358691382, 6055.636661800306, 6099.0, 6127.311699317154, 5450.672959622435, 6197.318294987457, 6205.720742566686, 6244.063390491463, 6247.531435142291, 5814.825555233349, 5911.290645122613, 6052.394760523913, 6064.241969753781, 6074.088886667036], "value": 5739.1722052841515, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [474.2435814875277, 489.36138339467004, 520.6667732651102, 529.594859932152, 549.8020712543486, 25953.0, 43377.78311108444, 44407.77796111019, 44577.10845783082, 44864.878378040565, 43898.0, 44277.11445771083, 44416.55583444165, 44443.77778111113, 44448.77775611125, 8750.343724220676, 9629.662961796339, 9800.705978820646, 9803.852942205836, 9809.313348065638, 8734.301255899512, 9261.95369023154, 11802.645920622395, 11850.7629847403, 12023.338716370596, 11812.291262524233, 11889.464974076187, 11899.167058305879, 11899.524019039229, 11940.0, 11799.469023893946, 11875.0, 11878.227915185485, 11884.108691848145, 11892.762144757056, 11749.0, 11825.58093028842, 11828.23116497425, 11839.526418943233, 11857.5849845255, 41186.38220426696, 41648.0, 41664.375034374505, 41698.79150604258, 41822.74531764052, 3396.8811091611924, 3446.4313388290902, 3474.8783792567137, 3504.5969713482764, 3548.733844961638, 27412.725872741215, 32482.0, 32529.51205731916, 32790.06519217709, 32986.83506582452, 3270.787398819093, 3347.7688193502163, 3353.4634458486526, 3388.5594872666643, 3422.7775194612273, 507693.0, 508151.0, 512475.0, 514586.0, 523905.0, 62416.0, 62806.371936280964, 62897.0, 62947.0, 63003.0, 66101.34746631373, 66102.3474413134, 66131.66934165299, 66134.0, 66195.0, 16558.254878530493, 16770.916145419196, 16780.58048548796, 16804.0, 16810.747838782183, 11511.251768635011, 11843.644690659294, 11862.466189021514, 12423.0, 12470.189437686702, 14844.851551484562, 15243.932924695388, 15341.846581534264, 15389.461368852037, 15755.212239387985, 5911.586188966817, 7398.223186565441, 7432.58441006675, 7505.710758218686, 7558.811029724301, 931.6878845586805, 989.2284018465608, 1067.9137293222593, 1081.145894743144, 1100.2683215661496, 28366.031905327094, 30640.54039189414, 30711.8464407681, 31219.0, 31679.20801979969, 1051.8948105189572, 1082.3343643659093, 1093.2893619147458, 1115.1970581181536, 1164.2025212729307, 15780.368785248462, 16411.1794410279, 16580.336786528645, 16654.666906661798, 16704.415345463094, 693908.0, 698638.0, 699253.0, 706233.0, 941648.0, 60547.39452605417, 61109.0, 61212.0, 61227.38772612306, 61310.77378452495, 1358.9660258493418, 1390.6801435669852, 1410.4358256697403, 1415.9504417345343, 1418.9499770170207, 23059.6541051881, 23690.407739806644, 27069.593956091067, 27115.72884271132, 27629.585556216272, 52579.73710131425, 54098.64753381197, 54193.45806541884, 54359.45640543544, 54363.64090897759, 618910.0, 619648.0, 620686.8965655143, 621130.0, 621897.0, 26494.0, 26899.731002690507, 26967.190984270503, 27029.459410812065, 27057.053003144796, 48820.511794883016, 49143.0, 50340.24489632585, 51618.741906290226, 52271.466066741654, 39259.80370098131, 40660.0, 41000.0, 42076.57923420727, 42570.0, 40298.395524066575, 40480.1903961925, 41088.58911410848, 41383.0, 41929.79035104927, 38560.6143938557, 39159.41260881146, 39227.215455691294, 39263.0, 39588.60411395849, 32654.836725816218, 34949.951501455, 35178.12054698653, 36072.81963590165, 36162.638373615926, 25764.742352576235, 25880.0, 25962.22113336603, 26128.216153515426, 26254.949802007704], "value": 20823.17883431607, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [352.92941411717663, 370.3777653542048, 373.70290618957927, 379.34752226170986, 405.44858991771184, 15604.921975390122, 15987.600309992256, 20255.189792408288, 20735.792642073575, 20891.582168356643, 19481.70777438336, 19979.800201997976, 20308.0, 20438.69341959868, 20449.795502044974, 5351.812686555972, 5391.272178255944, 5525.563353528071, 5525.696086715229, 6050.2134722486235, 5899.557533185029, 6091.695415229221, 6101.298350689661, 6102.145699602059, 6107.847303817418, 3864.671502922255, 5769.451902069318, 6022.187004754346, 6066.878662426749, 6137.079438084278, 5865.4134586541, 6074.058520929263, 6110.541709371815, 6122.602030867979, 6134.110553969672, 5923.0, 5932.932072226998, 5938.168656388109, 5939.67331796751, 5944.524438044946, 13197.934010329984, 15290.541283761506, 20528.38414847557, 25703.357416064562, 26054.0, 2030.3198428526462, 2360.44529535559, 2432.2946345559767, 2622.1871219921886, 2744.108164846433, 10148.289619726622, 11847.526098956032, 15826.683466330609, 16094.919525402414, 16195.785316101339, 1601.6786151425122, 1874.18472964261, 1895.2229585869727, 1943.2906988949073, 2029.989850050755, 91599.54200228956, 113600.0, 121978.0, 123798.38100809438, 127882.36058819739, 8182.345412366996, 9474.810503789886, 10087.546060427152, 10088.74778130538, 10118.0, 12345.567905123278, 12460.190087644274, 12466.81299780504, 12480.500779968881, 12482.875171248354, 7958.920410795934, 8236.588170591447, 8260.256576908107, 8335.291500222427, 8347.123552027071, 8080.0, 8163.551004694798, 8218.671253149927, 8345.833083338299, 8508.532030738244, 3856.0, 3890.396988466792, 3904.921901561953, 3941.3693808990424, 3954.228925359585, 1746.7729195204543, 1762.1453595006412, 1912.3498010676437, 1924.5381108533852, 1924.6824273994634, 691.9100516932766, 729.5950747335173, 811.6161943885661, 816.7304789419477, 883.1565854608833, 19328.516787080436, 20365.79634203639, 20630.896845515676, 20799.792002079786, 20886.477838054172, 902.201551626815, 948.848184290524, 956.3592393096642, 966.1449617088787, 991.1525645572931, 10020.799584008424, 10716.571337146583, 10755.516001779939, 10786.892131078588, 10830.729231769268, 528348.0, 533023.0, 534604.0, 629882.0, 633847.0, 113720.0, 152142.23928880284, 152170.23914880355, 156802.0, 156880.21559892126, 953.6423841059602, 984.3650845204946, 997.2620261006948, 999.9300048996646, 1017.8880323164447, 18451.077446127907, 18973.71539426882, 19223.61552768909, 19226.0, 19476.4157075288, 41562.0, 55610.99501044925, 55671.443285566624, 56210.0, 58832.99999999829, 83323.0, 85748.57125714581, 87060.56469717865, 87594.24811503862, 88058.0, 7732.8453430932195, 7927.12801591836, 7927.5243485391065, 8372.706955256537, 8376.874346884924, 9256.72229833106, 12132.332721700392, 12658.493660253487, 13010.54463093825, 13026.348682565644, 8945.776355591162, 9591.280653950842, 10905.618303359344, 10935.945320273348, 11236.83144752813, 10781.568737250736, 10970.890291096986, 11088.667339979813, 11161.665150045512, 11426.714332141762, 9677.70966870995, 11199.888001119885, 11384.886151138382, 11416.972472477517, 11698.532058717896, 7925.405594580314, 8098.83802323962, 8127.390445716713, 8150.470219435718, 8202.09776924526, 8455.873161902453, 10784.083352914777, 11116.722081948015, 11340.09279257641, 11348.602798901999], "value": 9395.987624221641, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1499.1829452948139, 1521.452277180215, 1718.8538974187193, 1863.692490739028, 1890.8865468071926, 8202.261796438319, 8758.605862736176, 8763.474191548512, 8764.167404096617, 8773.649054037847, 7698.191689872567, 7910.80222994424, 8300.211479909414, 8493.49039057657, 8512.276456501204, 2293.575688497633, 2328.1734984080663, 2329.196427232602, 2330.417395651087, 2335.6613291072786, 2277.0, 2299.4251437140715, 2330.149495434163, 2334.323046316566, 2335.4161459635093, 2311.3297143828268, 2328.639060945556, 2329.3594261578032, 2334.8365614407, 2341.672165896776, 1969.6750036244002, 2290.7022087128735, 2294.908203671843, 2297.368223738477, 2303.9654405183937, 2292.7363353214428, 2299.6895419118373, 2304.147465437799, 2304.3778179891337, 2309.515001849614, 8491.532965686885, 8677.826443471095, 8684.348673849487, 8693.913060869374, 8694.21752042313, 5100.056489549445, 5153.896922061538, 5172.974135129338, 5175.585953123741, 5182.53357197854, 3306.768526203167, 3352.8994130176134, 3499.422595271777, 3514.7012503937194, 3519.982400087983, 1067.6263307842194, 1082.1775450657558, 1094.9726256843562, 1096.3202814255133, 1096.446294621219, 11113.388763617997, 11261.0, 11270.09839212861, 11271.380074095921, 11280.605178818783, 4429.889252768642, 4472.686911916199, 4664.090502352076, 4670.486246512881, 4690.718556886598, 9720.951395242979, 9731.464769437607, 9735.026497350209, 9739.344311467068, 9747.0, 5169.612279079084, 5174.482551744795, 5176.120059589879, 5181.507756763177, 5187.896242075138, 4261.893452663646, 4285.635720963691, 4424.513303536608, 4441.333799929972, 4767.95232047682, 3883.9611603884164, 3935.8819235422984, 3966.186931678999, 3973.2252210818615, 4013.959860401417, 1255.2468518888777, 1291.1026836348647, 1293.8318018657515, 1301.264785396248, 1303.928283944373, 750.4296734481724, 841.6044459104211, 897.1028971028971, 906.7687739626354, 956.4691596164196, 5466.316710411199, 5493.560515158778, 5819.301683797887, 5845.795397161079, 5888.851673923544, 841.6843683618642, 1006.225206590921, 1010.8685870836745, 1046.5918291866178, 1074.425182527344, 3045.1169160943523, 3382.8308584570673, 3699.500567423417, 3712.8700495483067, 3928.096537796323, 10100.444475553915, 10499.370037797757, 10514.474276286155, 10532.420716860493, 10563.049325560736, 10439.112675422522, 10448.791024179474, 10452.477376131163, 10460.215483838743, 10466.267361284637, 7650.502717323468, 7980.880286795703, 8012.198780121941, 8012.479188852706, 8103.432759706882, 5847.473727364558, 5861.912071319019, 5948.732307046107, 5970.373110823301, 5989.940100598938, 9338.859917101114, 9463.952680236831, 9660.275479338938, 9837.557309920927, 9899.604015839286, 9010.90989090127, 9298.72103836886, 9574.32979691415, 9905.851412228967, 9972.60109595637, 7322.890156647761, 7475.738349157971, 7488.326050655467, 7607.011088558452, 7618.047744031996, 8027.5584842834205, 8241.134680858664, 8284.627191776264, 8320.292775113941, 8327.500349978778, 7335.669894854637, 7388.778336649909, 7389.704411823467, 7445.664945077377, 7456.96271518639, 7296.343329100407, 7297.817554560966, 7313.23211062852, 7353.522021068614, 7377.299156580117, 6542.803715888531, 6571.934280657132, 6647.510057219998, 6809.38715515606, 6872.347127022925, 4767.165745994368, 4863.954249836303, 4888.388951381077, 4925.261210818406, 5012.6240531960975, 4906.656534042583, 4993.750312484434, 4999.900002000012, 5018.84943451697, 5058.721770302669], "value": 4507.059514137645, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [298.20379586504043, 300.76690564812276, 310.2739589360895, 315.5629453207307, 318.36803944170833, 4185.869815149916, 5201.739913004353, 5245.790168393264, 5301.0, 5307.73461326934, 4662.717752618032, 5043.823466178685, 5112.923306150411, 5179.119549676555, 5269.552088072509, 3180.9681903181017, 3844.692424606025, 4031.475908131939, 4036.9798151009204, 4044.119484439735, 3365.444701624229, 3781.981090094546, 4033.294173519637, 4064.5325787534516, 4083.3262511685534, 3945.960540394588, 3954.7033972452036, 3971.2454633619664, 3982.761034337949, 3990.620891015349, 3972.708869617386, 3975.8807235782974, 3978.7413818101877, 3982.780947047911, 3985.442038114666, 2956.49739544278, 3177.682231776827, 3288.0, 3395.813230272334, 3450.189205536697, 4460.687751857371, 5014.84955451337, 5083.034223497561, 5093.490650934877, 5118.411382691001, 3996.140829721624, 4217.261979153666, 4562.338460923148, 4578.244589642738, 4589.173948689235, 5112.41207261166, 5441.401445840955, 5536.640118392332, 5545.584081193886, 5579.972100139514, 3196.280836811722, 3790.1472168762084, 3791.4312853071983, 3799.4680744695765, 3817.8281977310808, 5132.255822905695, 5354.250404943311, 5849.766009359663, 5879.3826648202175, 5947.583669143161, 3609.8917032489067, 3883.9319187223173, 3895.552011518655, 3896.7661940283106, 3900.1419687668667, 3890.599384221678, 3908.882733517999, 3922.8038598069984, 3930.4890364252465, 3938.6455219030427, 4134.966258435391, 4551.749653769075, 4558.9742307981105, 4560.977195114069, 4591.9540804591525, 4986.426560945465, 5111.338814885103, 5597.468240517144, 5597.608167428241, 5615.024037260258, 1248.6878280429892, 1328.554934097069, 1331.287761047854, 1333.9466421343038, 1343.3887581150552, 680.7923583307139, 709.5104377979281, 775.7789030126387, 800.5556915911725, 803.4857691077715, 3705.740598158157, 3842.634949679776, 4399.436456470269, 4408.647308215335, 4442.555744425532, 4022.0, 4289.206496798102, 4723.551262630044, 4771.5923802478355, 4789.353437285991, 3485.3270430193647, 4065.7763822989427, 4125.360569111793, 4377.60601545856, 4389.034412429261, 2255.590256089944, 2316.8916286179497, 2500.712418071909, 2523.873806309677, 2553.6424900513944, 4534.221339098003, 4856.004519073652, 5006.374203224597, 5042.621803364762, 5054.620903432257, 4382.663287697219, 4477.00773155949, 4608.377868987711, 4907.386576677915, 4954.777035033432, 4159.625633692982, 4261.957380426218, 4671.5328467153695, 4918.975405123095, 4987.675801072919, 3987.6610488108836, 4018.7541862022867, 4606.861794146181, 4784.40194975628, 4803.207470767424, 4298.484181898067, 4685.1654748876435, 4725.149473094876, 4746.5490778376, 4753.031218932092, 4263.722858014343, 4406.074724307931, 4872.780724867319, 4947.77735001933, 4968.0624556423745, 2790.2884764384953, 3312.4700047992205, 3593.281343731212, 3705.7776533408082, 3733.757305775116, 5669.376368599368, 5693.572982026281, 5700.230468886647, 5713.971485132716, 5768.423157684366, 4640.350350950802, 4837.782299796588, 5173.715445650375, 5449.727513624223, 5516.0, 5164.431912489548, 5450.400455949922, 5460.808871689472, 5520.91718624229, 5534.418886016911, 5394.487523685244, 5422.48486393792, 5426.972865135807, 5440.292761940922, 5454.336427389684, 4678.0586056787415, 5242.5281724644965, 5476.972615136899, 5515.834524964257, 5547.861303467445, 5324.9467505326, 5326.573874090141, 5382.03123437785, 5386.596005299697, 5393.9730301348245], "value": 3813.1767947858434, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [682.1711620381237, 722.4401089155907, 733.3546479098394, 775.0853992289096, 776.425445170574, 14741.11553306801, 15958.76061859073, 15965.281562329694, 15980.121093339876, 15998.040117592953, 11904.345261010641, 13602.591922242324, 13708.931455342708, 13947.790783138236, 13983.440662373492, 707.1655446573042, 730.0071902213012, 853.1638993786094, 868.5874209750366, 882.7042940614901, 883.567052144451, 901.8286525560122, 903.1510380242584, 903.7017784131253, 906.4561263242068, 947.6398968392001, 950.0594411532568, 951.5765484359463, 952.8427809411439, 956.3018996132793, 731.4002517935295, 748.4685873030155, 752.9947520060725, 949.981000379992, 950.2920324358363, 558.8435238133329, 560.7112337146373, 672.3209558346106, 700.6391708270245, 701.7158050989358, 14841.0, 14857.405703771836, 14862.331195096247, 14873.47942821996, 14888.0, 12133.393330333449, 12282.263064216175, 12295.200811947285, 12446.875531244752, 12677.0, 12408.56570020045, 12520.153665478934, 12559.497620095186, 12717.936410317981, 12904.612861614167, 4507.414036175309, 4519.322101684741, 4524.886877828048, 4710.222813235812, 4748.311494833264, 123905.0, 124206.0, 124259.0, 124539.0, 124841.9999999991, 10722.78554428907, 10744.570217191382, 10810.459477026117, 10831.891681083089, 11365.0, 21085.578288434146, 21309.36071917814, 21352.14591416326, 21364.465888352915, 21398.679019814714, 7758.0, 7768.689252429953, 7776.416768742367, 7781.796173098539, 8026.1572534883, 4298.742075475481, 4330.870073897788, 4336.2845130553105, 4432.224360736858, 4500.3249512573375, 3422.418188907842, 3527.876524321636, 3530.9293814123575, 3533.063738109403, 3533.6643018913164, 691.4399336537421, 729.9817504562322, 730.2004305285703, 730.8390270023751, 734.6253410760551, 598.4912824099481, 684.1516519515864, 697.2504557600599, 702.3468174597571, 704.4258928972973, 9319.114684105, 9359.766005849771, 9686.564104615309, 9687.273454490942, 9946.502674866228, 572.3503823160743, 605.3250625552565, 634.9142865713162, 652.1261509577095, 672.0, 4202.432671589358, 4522.909541809211, 4572.154151481986, 4609.700369475973, 4643.210654188796, 164911.0, 169199.15400423165, 170090.0, 171085.0, 172586.0, 145671.0, 148151.71762835555, 149854.50145498622, 150708.0, 151466.06123996826, 120363.0, 121989.0, 122259.0, 123765.0, 129232.70767292395, 7611.3530349920875, 7703.922960770321, 7844.450888437755, 8763.649454021768, 8805.0, 63759.0, 64069.679651601444, 65223.0, 65783.34216657773, 66818.66590667015, 91982.0, 94819.5259023728, 98992.50503747436, 100188.0, 100265.0, 10463.68608941733, 11844.822327665264, 11945.581904633296, 12053.57812476559, 12297.077719171277, 13218.537351192663, 13501.527446539323, 13512.79730804019, 13559.0, 14034.438622454987, 10651.733706657085, 12263.762230750024, 12465.439055242718, 12469.937650311691, 12621.0, 8947.955260223658, 11581.768364632828, 13367.532136375568, 13784.793228101385, 14244.359003844645, 13448.731025379633, 13617.387217575035, 13850.722985540435, 14009.929950350182, 14498.637534061732, 9657.3239873211, 9885.654002109892, 10527.894721052999, 11374.31754094757, 11788.0, 9620.470874101991, 10058.396496210251, 10245.74385640365, 10259.333143345659, 10316.123129534073], "value": 7847.95286193684, "unit": "score"}], "name": "dromaeo_css", "value": 7301.091551985036, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 113.0, 115.0, 113.0, 114.0, 115.0, 113.0, 113.0, 113.0, 114.0], "value": 112.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 107.0, 106.0, 166.0, 108.0, 108.0, 128.0, 106.0, 139.0, 106.0], "value": 121.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 183.0, 185.0, 182.0, 184.0, 181.0, 183.0, 183.0, 182.0, 184.0], "value": 183.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 58.0, 72.0, 129.0, 76.0, 64.0, 65.0, 63.0, 83.0, 56.0], "value": 74.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 68.0, 90.0, 68.0, 74.0, 68.0, 98.0, 70.0, 67.0, 97.0], "value": 78.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 85.0, 87.0, 85.0, 93.0, 129.0, 88.0, 85.0, 88.0, 84.0], "value": 91.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 93.0, 93.0, 92.0, 93.0, 93.0, 94.0, 96.0, 93.0, 92.0], "value": 93.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 86.0, 83.0, 84.0, 100.0, 133.0, 133.0, 84.0, 86.0], "value": 95.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 52.0, 52.0, 52.0, 51.0, 53.0, 52.0, 50.0, 52.0, 51.0], "value": 51.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 67.0, 74.0, 80.0, 72.0, 72.0, 71.0, 71.0, 70.0, 71.0], "value": 71.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 85.0, 83.0, 86.0, 85.0, 85.0, 86.0, 84.0, 83.0, 79.0], "value": 83.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 137.0, 139.0, 136.0, 138.0, 120.0, 158.0, 144.0, 153.0, 138.0], "value": 140.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 223.0, 220.0, 166.0, 163.0, 167.0, 168.0, 163.0, 181.0, 224.0], "value": 183.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 67.0, 66.0, 67.0, 66.0, 65.0, 66.0, 66.0, 66.0], "value": 66.3, "unit": "score"}], "name": "kraken", "value": 1447.6, "alertThreshold": 2.0}]} 01:57:16 INFO - Return code: 0 01:57:16 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 01:57:16 INFO - # TBPL SUCCESS # 01:57:16 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 01:57:16 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 01:57:16 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 01:57:16 INFO - 2016-08-07 01:57:16.446 screenresolution[1681:15886] starting screenresolution argv=screenresolution get 01:57:16 INFO - 2016-08-07 01:57:16.449 screenresolution[1681:15886] Display 0: 1600x1200x32@60 01:57:16 INFO - 2016-08-07 01:57:16.455 screenresolution[1682:15889] starting screenresolution argv=screenresolution list 01:57:16 INFO - Available Modes on Display 0 01:57:16 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 01:57:16 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 01:57:16 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 01:57:16 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 01:57:16 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 01:57:16 INFO - Intel Iris: 01:57:16 INFO - Chipset Model: Intel Iris 01:57:16 INFO - Type: GPU 01:57:16 INFO - Bus: Built-In 01:57:16 INFO - VRAM (Dynamic, Max): 1536 MB 01:57:16 INFO - Vendor: Intel (0x8086) 01:57:16 INFO - Device ID: 0x0a2e 01:57:16 INFO - Revision ID: 0x0009 01:57:16 INFO - Displays: 01:57:16 INFO - Display: 01:57:16 INFO - Resolution: 1600 x 1200 @ 60 Hz 01:57:16 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 01:57:16 INFO - Display Serial Number: 1600x1200 60 01:57:16 INFO - Main Display: Yes 01:57:16 INFO - Mirror: Off 01:57:16 INFO - Online: Yes 01:57:16 INFO - Rotation: Supported 01:57:16 INFO - Return code: 0 01:57:16 INFO - Running post-action listener: _resource_record_post_action 01:57:16 INFO - [mozharness: 2016-08-07 08:57:16.692899Z] Finished run-tests step (success) 01:57:16 INFO - Running post-run listener: _resource_record_post_run 01:57:16 INFO - Total resource usage - Wall time: 1211s; CPU: 54.0%; Read bytes: 31652864; Write bytes: 706422272; Read time: 191; Write time: 1927 01:57:16 INFO - TinderboxPrint: CPU usage
53.8% 01:57:16 INFO - TinderboxPrint: I/O read bytes / time
31,652,864 / 191 01:57:16 INFO - TinderboxPrint: I/O write bytes / time
706,422,272 / 1,927 01:57:16 INFO - TinderboxPrint: CPU idle
2,237.3 (46.2%) 01:57:16 INFO - TinderboxPrint: CPU system
968.9 (20.0%) 01:57:16 INFO - TinderboxPrint: CPU user
1,639.4 (33.8%) 01:57:16 INFO - TinderboxPrint: Swap in / out
434,323,456 / 0 01:57:16 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 402549248; Write bytes: 398386688; Read time: 29733; Write time: 811 01:57:16 INFO - run-tests - Wall time: 1178s; CPU: 54.0%; Read bytes: 29559808; Write bytes: 294076416; Read time: 172; Write time: 1076 01:57:17 INFO - Running post-run listener: _upload_blobber_files 01:57:17 INFO - Blob upload gear active. 01:57:17 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 01:57:17 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 01:57:17 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', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 01:57:17 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 Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 01:57:17 INFO - (blobuploader) - INFO - Open directory for files ... 01:57:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 01:57:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:57:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:57:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 01:57:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:57:18 INFO - (blobuploader) - INFO - Done attempting. 01:57:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 01:57:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:57:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:57:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 01:57:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:57:19 INFO - (blobuploader) - INFO - Done attempting. 01:57:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 01:57:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:57:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:57:22 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 01:57:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:57:22 INFO - (blobuploader) - INFO - Done attempting. 01:57:22 INFO - (blobuploader) - INFO - Iteration through files over. 01:57:22 INFO - Return code: 0 01:57:22 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 01:57:22 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 01:57:22 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8d15b33be73108d93b19444025f6da3f73ead15b704c44811c45fcc6d483511fd8ecc449141f2c8c045987870b99f44a0a88d31508f5455995665d7cccfb6c27", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/aaa15ff0a558371eb5eb8d1a77f79aa26e37b1f70a4a80e4c27ffdec97ad95dfe1c13e7b95a040dfb3b56b84e1bcd5d15b878343a3380eeb0fdffd19e6328327", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/11fecd1ff6259ec74514eef32652c7b45366ee204d3677e06538d28c8ce33c84409a13e19dfa4daae501346c45873bf1eafcd29414056ea6597f8a77c081779e"} 01:57:22 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 01:57:22 INFO - Writing to file /builds/slave/test/properties/blobber_files 01:57:22 INFO - Contents: 01:57:22 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8d15b33be73108d93b19444025f6da3f73ead15b704c44811c45fcc6d483511fd8ecc449141f2c8c045987870b99f44a0a88d31508f5455995665d7cccfb6c27", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/aaa15ff0a558371eb5eb8d1a77f79aa26e37b1f70a4a80e4c27ffdec97ad95dfe1c13e7b95a040dfb3b56b84e1bcd5d15b878343a3380eeb0fdffd19e6328327", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/11fecd1ff6259ec74514eef32652c7b45366ee204d3677e06538d28c8ce33c84409a13e19dfa4daae501346c45873bf1eafcd29414056ea6597f8a77c081779e"} 01:57:22 INFO - Running post-run listener: copy_logs_to_upload_dir 01:57:22 INFO - Copying logs to upload dir... 01:57:22 INFO - mkdir: /builds/slave/test/build/upload/logs 01:57:22 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1269.412481 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2016-08-07 01:57:22.401768) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-07 01:57:22.405668) ========= 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.gY66FdXvaA/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.FJCgzeNOmZ/Listeners TMPDIR=/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/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/Firefox/sha512/8d15b33be73108d93b19444025f6da3f73ead15b704c44811c45fcc6d483511fd8ecc449141f2c8c045987870b99f44a0a88d31508f5455995665d7cccfb6c27", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/aaa15ff0a558371eb5eb8d1a77f79aa26e37b1f70a4a80e4c27ffdec97ad95dfe1c13e7b95a040dfb3b56b84e1bcd5d15b878343a3380eeb0fdffd19e6328327", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/11fecd1ff6259ec74514eef32652c7b45366ee204d3677e06538d28c8ce33c84409a13e19dfa4daae501346c45873bf1eafcd29414056ea6597f8a77c081779e"} build_url:https://queue.taskcluster.net/v1/task/etJiaP1fT4KB_u8S9ZEPdg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010891 build_url: 'https://queue.taskcluster.net/v1/task/etJiaP1fT4KB_u8S9ZEPdg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8d15b33be73108d93b19444025f6da3f73ead15b704c44811c45fcc6d483511fd8ecc449141f2c8c045987870b99f44a0a88d31508f5455995665d7cccfb6c27", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/aaa15ff0a558371eb5eb8d1a77f79aa26e37b1f70a4a80e4c27ffdec97ad95dfe1c13e7b95a040dfb3b56b84e1bcd5d15b878343a3380eeb0fdffd19e6328327", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/11fecd1ff6259ec74514eef32652c7b45366ee204d3677e06538d28c8ce33c84409a13e19dfa4daae501346c45873bf1eafcd29414056ea6597f8a77c081779e"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-07 01:57:22.437715) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-07 01:57:22.438001) ========= 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.gY66FdXvaA/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.FJCgzeNOmZ/Listeners TMPDIR=/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/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.005080 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-07 01:57:22.485914) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-07 01:57:22.486196) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-07 01:57:22.486502) ========= ========= Total master_lag: 0.17 =========