builder: autoland_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0336 starttime: 1470444332.51 results: success (0) buildid: 20160805145221 builduid: 48e28ee07c5b44499c068cabd91624bf revision: ca2b685228c1a86d90e205033d266c37c58d9c9b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-05 17:45:32.512110) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-05 17:45:32.512641) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-05 17:45:32.512930) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-05 17:45:32.537657) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-05 17:45:32.538031) ========= 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.q1KuuMK0Aa/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.xwUu34LewB/Listeners TMPDIR=/var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/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-05 17:45:32-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 29.9M=0s 2016-08-05 17:45:32 (29.9 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.126681 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-05 17:45:32.687339) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-05 17:45:32.687655) ========= 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.q1KuuMK0Aa/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.xwUu34LewB/Listeners TMPDIR=/var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/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.026050 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-05 17:45:32.736063) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-05 17:45:32.736435) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev ca2b685228c1a86d90e205033d266c37c58d9c9b --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/autoland --rev ca2b685228c1a86d90e205033d266c37c58d9c9b --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.q1KuuMK0Aa/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.xwUu34LewB/Listeners TMPDIR=/var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/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-05 17:45:32,817 truncating revision to first 12 chars 2016-08-05 17:45:32,818 Setting DEBUG logging. 2016-08-05 17:45:32,818 attempt 1/10 2016-08-05 17:45:32,818 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/ca2b685228c1?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-05 17:45:33,525 unpacking tar archive at: autoland-ca2b685228c1/testing/mozharness/ program finished with exit code 0 elapsedTime=0.985853 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-05 17:45:33.745388) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-05 17:45:33.745899) ========= script_repo_revision: ca2b685228c1a86d90e205033d266c37c58d9c9b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-05 17:45:33.746380) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-05 17:45:33.746676) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-05 17:45:33.765954) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2016-08-05 17:45:33.766443) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Autoland --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Autoland', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.q1KuuMK0Aa/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.xwUu34LewB/Listeners TMPDIR=/var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/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 17:45:33 INFO - MultiFileLogger online at 20160805 17:45:33 in /builds/slave/test 17:45:33 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Autoland --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland 17:45:33 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:45:33 INFO - {'append_to_log': False, 17:45:33 INFO - 'base_work_dir': '/builds/slave/test', 17:45:33 INFO - 'blob_upload_branch': 'Autoland', 17:45:33 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:45:33 INFO - 'branch': 'Autoland', 17:45:33 INFO - 'buildbot_json_path': 'buildprops.json', 17:45:33 INFO - 'config_files': ('talos/mac_config.py',), 17:45:33 INFO - 'default_actions': ('clobber', 17:45:33 INFO - 'read-buildbot-config', 17:45:33 INFO - 'download-and-extract', 17:45:33 INFO - 'populate-webroot', 17:45:33 INFO - 'create-virtualenv', 17:45:33 INFO - 'install', 17:45:33 INFO - 'run-tests'), 17:45:33 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:45:33 INFO - 'download_minidump_stackwalk': True, 17:45:33 INFO - 'download_symbols': 'ondemand', 17:45:33 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:45:33 INFO - 'tooltool.py': '/tools/tooltool.py', 17:45:33 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:45:33 INFO - '/tools/misc-python/virtualenv.py')}, 17:45:33 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:45:33 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:45:33 INFO - 'installer_path': 'installer.exe', 17:45:33 INFO - 'log_level': 'info', 17:45:33 INFO - 'log_name': 'talos', 17:45:33 INFO - 'log_to_console': True, 17:45:33 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 17:45:33 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 17:45:33 INFO - 'opt_config_files': (), 17:45:33 INFO - 'pip_index': False, 17:45:33 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 17:45:33 INFO - 'cmd': ('bash', 17:45:33 INFO - '-c', 17:45:33 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 17:45:33 INFO - 'enabled': True, 17:45:33 INFO - 'halt_on_failure': False, 17:45:33 INFO - 'name': 'check_screen_resolution'},), 17:45:33 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 17:45:33 INFO - 'cmd': ('bash', 17:45:33 INFO - '-c', 17:45:33 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 17:45:33 INFO - 'enabled': True, 17:45:33 INFO - 'halt_on_failure': False, 17:45:33 INFO - 'name': 'check_screen_resolution'},), 17:45:33 INFO - 'run_cmd_checks_enabled': True, 17:45:33 INFO - 'sps_profile': False, 17:45:33 INFO - 'sps_profile_interval': 0, 17:45:33 INFO - 'suite': 'dromaeojs-e10s', 17:45:33 INFO - 'system_bits': '32', 17:45:33 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:45:33 INFO - 'title': 't-yosemite-r7-0336', 17:45:33 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:45:33 INFO - 'use_talos_json': True, 17:45:33 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:45:33 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:45:33 INFO - 'work_dir': 'build'} 17:45:33 INFO - [mozharness: 2016-08-06 00:45:33.971254Z] Running clobber step. 17:45:33 INFO - Running pre-action listener: _resource_record_pre_action 17:45:33 INFO - Running main action method: clobber 17:45:33 INFO - rmtree: /builds/slave/test/build 17:45:33 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:45:36 INFO - Running post-action listener: _resource_record_post_action 17:45:36 INFO - [mozharness: 2016-08-06 00:45:36.393254Z] Finished clobber step (success) 17:45:36 INFO - [mozharness: 2016-08-06 00:45:36.393417Z] Running read-buildbot-config step. 17:45:36 INFO - Running pre-action listener: _resource_record_pre_action 17:45:36 INFO - Running main action method: read_buildbot_config 17:45:36 INFO - Using buildbot properties: 17:45:36 INFO - { 17:45:36 INFO - "project": "", 17:45:36 INFO - "product": "firefox", 17:45:36 INFO - "script_repo_revision": "production", 17:45:36 INFO - "builddir": "autoland_yosemite_r7_test-dromaeojs-e10s", 17:45:36 INFO - "repository": "", 17:45:36 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 autoland talos dromaeojs-e10s", 17:45:36 INFO - "buildid": "20160805145221", 17:45:36 INFO - "pgo_build": "False", 17:45:36 INFO - "basedir": "/builds/slave/test", 17:45:36 INFO - "buildnumber": 112, 17:45:36 INFO - "slavename": "t-yosemite-r7-0336", 17:45:36 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 17:45:36 INFO - "platform": "yosemite_r7", 17:45:36 INFO - "scheduler": "tests-autoland-macosx64-talos", 17:45:36 INFO - "branch": "autoland", 17:45:36 INFO - "repo_path": "integration/autoland", 17:45:36 INFO - "revision": "ca2b685228c1a86d90e205033d266c37c58d9c9b", 17:45:36 INFO - "stage_platform": "macosx64", 17:45:36 INFO - "builduid": "48e28ee07c5b44499c068cabd91624bf", 17:45:36 INFO - "slavebuilddir": "test" 17:45:36 INFO - } 17:45:36 INFO - Found installer url https://queue.taskcluster.net/v1/task/UyzA1WRmSp2igr7llMdS3Q/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg. 17:45:36 INFO - Running post-action listener: _resource_record_post_action 17:45:36 INFO - [mozharness: 2016-08-06 00:45:36.396689Z] Finished read-buildbot-config step (success) 17:45:36 INFO - [mozharness: 2016-08-06 00:45:36.396831Z] Running download-and-extract step. 17:45:36 INFO - Running pre-action listener: _resource_record_pre_action 17:45:36 INFO - Running main action method: download_and_extract 17:45:36 INFO - mkdir: /builds/slave/test/build/tests 17:45:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:45:36 INFO - trying https://queue.taskcluster.net/v1/task/UyzA1WRmSp2igr7llMdS3Q/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json 17:45:36 INFO - Downloading https://queue.taskcluster.net/v1/task/UyzA1WRmSp2igr7llMdS3Q/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 17:45:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/UyzA1WRmSp2igr7llMdS3Q/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 17:45:37 INFO - Downloaded 1199 bytes. 17:45:37 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 17:45:37 INFO - Using the following test package requirements: 17:45:37 INFO - {u'common': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 17:45:37 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 17:45:37 INFO - u'firefox-51.0a1.en-US.mac.cppunittest.tests.zip'], 17:45:37 INFO - u'gtest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 17:45:37 INFO - u'firefox-51.0a1.en-US.mac.gtest.tests.zip'], 17:45:37 INFO - u'jittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 17:45:37 INFO - u'jsshell-mac.zip'], 17:45:37 INFO - u'mochitest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 17:45:37 INFO - u'firefox-51.0a1.en-US.mac.mochitest.tests.zip'], 17:45:37 INFO - u'mozbase': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 17:45:37 INFO - u'reftest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 17:45:37 INFO - u'firefox-51.0a1.en-US.mac.reftest.tests.zip'], 17:45:37 INFO - u'talos': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 17:45:37 INFO - u'firefox-51.0a1.en-US.mac.talos.tests.zip'], 17:45:37 INFO - u'web-platform': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 17:45:37 INFO - u'firefox-51.0a1.en-US.mac.web-platform.tests.zip'], 17:45:37 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 17:45:37 INFO - u'firefox-51.0a1.en-US.mac.xpcshell.tests.zip']} 17:45:37 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip'] for test suite category: common 17:45: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')]} 17:45:37 INFO - trying https://queue.taskcluster.net/v1/task/UyzA1WRmSp2igr7llMdS3Q/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 17:45:37 INFO - Downloading https://queue.taskcluster.net/v1/task/UyzA1WRmSp2igr7llMdS3Q/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 17:45:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/UyzA1WRmSp2igr7llMdS3Q/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 17:45:39 INFO - Downloaded 16320976 bytes. 17:45:39 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'] 17:45:39 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 17:45:42 INFO - Return code: 0 17:45:42 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 17:45: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')]} 17:45:42 INFO - trying https://queue.taskcluster.net/v1/task/UyzA1WRmSp2igr7llMdS3Q/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 17:45:42 INFO - Downloading https://queue.taskcluster.net/v1/task/UyzA1WRmSp2igr7llMdS3Q/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 17:45:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/UyzA1WRmSp2igr7llMdS3Q/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 17:45:43 INFO - Downloaded 16320976 bytes. 17:45:43 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'] 17:45:43 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 17:45:46 INFO - Return code: 0 17:45:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:45:46 INFO - trying https://queue.taskcluster.net/v1/task/UyzA1WRmSp2igr7llMdS3Q/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip 17:45:46 INFO - Downloading https://queue.taskcluster.net/v1/task/UyzA1WRmSp2igr7llMdS3Q/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 17:45:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/UyzA1WRmSp2igr7llMdS3Q/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 17:45:47 INFO - Downloaded 14413723 bytes. 17:45:47 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'] 17:45:47 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 17:45:48 INFO - Return code: 0 17:45:48 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')]} 17:45:48 INFO - trying https://queue.taskcluster.net/v1/task/UyzA1WRmSp2igr7llMdS3Q/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 17:45:48 INFO - Downloading https://queue.taskcluster.net/v1/task/UyzA1WRmSp2igr7llMdS3Q/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg 17:45:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/UyzA1WRmSp2igr7llMdS3Q/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 17:45:50 INFO - Downloaded 111814363 bytes. 17:45:50 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/UyzA1WRmSp2igr7llMdS3Q/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 17:45:50 INFO - mkdir: /builds/slave/test/properties 17:45:50 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:45:50 INFO - Writing to file /builds/slave/test/properties/build_url 17:45:50 INFO - Contents: 17:45:50 INFO - build_url:https://queue.taskcluster.net/v1/task/UyzA1WRmSp2igr7llMdS3Q/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 17:45:51 INFO - Running post-action listener: _resource_record_post_action 17:45:51 INFO - Running post-action listener: set_extra_try_arguments 17:45:51 INFO - [mozharness: 2016-08-06 00:45:51.549668Z] Finished download-and-extract step (success) 17:45:51 INFO - [mozharness: 2016-08-06 00:45:51.549817Z] Running populate-webroot step. 17:45:51 INFO - Running pre-action listener: _resource_record_pre_action 17:45:51 INFO - Running main action method: populate_webroot 17:45:51 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:45:51 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:45:51 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:45:51 INFO - '--tppagecycles', 17:45:51 INFO - '7'], 17:45:51 INFO - 'tests': ['tsvgm']}}, 17:45:51 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:45:51 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:45:51 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:45:51 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:45:51 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:45:51 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:45:51 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:45:51 INFO - 'talos_options': ['--disable-e10s'], 17:45:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:45:51 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:45:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:45:51 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:45:51 INFO - 'talos_options': ['--disable-e10s'], 17:45:51 INFO - 'tests': ['damp', 'tps']}, 17:45:51 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:45:51 INFO - 'tests': ['damp', 'tps']}, 17:45:51 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:45:51 INFO - 'tests': ['dromaeo_dom']}, 17:45:51 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:45:51 INFO - 'g4': {'talos_options': ['--disable-e10s'], 17:45:51 INFO - 'tests': ['basic_compositor_video']}, 17:45:51 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 17:45:51 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:45:51 INFO - 'tests': ['a11yr', 17:45:51 INFO - 'ts_paint', 17:45:51 INFO - 'tpaint', 17:45:51 INFO - 'sessionrestore', 17:45:51 INFO - 'sessionrestore_no_auto_restore', 17:45:51 INFO - 'tabpaint']}, 17:45:51 INFO - 'other-e10s': {'tests': ['a11yr', 17:45:51 INFO - 'ts_paint', 17:45:51 INFO - 'tpaint', 17:45:51 INFO - 'sessionrestore', 17:45:51 INFO - 'sessionrestore_no_auto_restore', 17:45:51 INFO - 'tabpaint']}, 17:45:51 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:45:51 INFO - 'ts_paint', 17:45:51 INFO - 'tpaint', 17:45:51 INFO - 'sessionrestore', 17:45:51 INFO - 'sessionrestore_no_auto_restore', 17:45:51 INFO - 'tabpaint']}, 17:45:51 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:45:51 INFO - 'ts_paint', 17:45:51 INFO - 'tpaint', 17:45:51 INFO - 'sessionrestore', 17:45:51 INFO - 'sessionrestore_no_auto_restore', 17:45:51 INFO - 'tabpaint']}, 17:45:51 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:45:51 INFO - 'tests': ['a11yr', 17:45:51 INFO - 'ts_paint', 17:45:51 INFO - 'tpaint', 17:45:51 INFO - 'sessionrestore', 17:45:51 INFO - 'sessionrestore_no_auto_restore', 17:45:51 INFO - 'tabpaint']}, 17:45:51 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:45:51 INFO - 'tests': ['a11yr', 17:45:51 INFO - 'ts_paint', 17:45:51 INFO - 'tpaint', 17:45:51 INFO - 'sessionrestore', 17:45:51 INFO - 'sessionrestore_no_auto_restore', 17:45:51 INFO - 'tabpaint']}, 17:45:51 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:45:51 INFO - 'tests': ['tsvgx', 17:45:51 INFO - 'tsvgr_opacity', 17:45:51 INFO - 'tart', 17:45:51 INFO - 'tscrollx', 17:45:51 INFO - 'cart']}, 17:45:51 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:45:51 INFO - 'tsvgr_opacity', 17:45:51 INFO - 'tart', 17:45:51 INFO - 'tscrollx', 17:45:51 INFO - 'cart']}, 17:45:51 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:45:51 INFO - 'talos_options': ['--disable-e10s'], 17:45:51 INFO - 'tests': ['tp5o']}, 17:45:51 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:45:51 INFO - 'tests': ['tp5o']}, 17:45:51 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:45:51 INFO - 'talos_options': ['--disable-e10s', 17:45:51 INFO - '--xperf_path', 17:45:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:45:51 INFO - 'tests': ['tp5n']}, 17:45:51 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:45:51 INFO - 'talos_options': ['--xperf_path', 17:45:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:45:51 INFO - 'tests': ['tp5n']}}, 17:45:51 INFO - 'talos.zip': {'path': '', 17:45:51 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:45:51 INFO - Running post-action listener: _resource_record_post_action 17:45:51 INFO - [mozharness: 2016-08-06 00:45:51.568594Z] Finished populate-webroot step (success) 17:45:51 INFO - [mozharness: 2016-08-06 00:45:51.568713Z] Running create-virtualenv step. 17:45:51 INFO - Running pre-action listener: _resource_record_pre_action 17:45:51 INFO - Running main action method: create_virtualenv 17:45:51 INFO - Creating virtualenv /builds/slave/test/build/venv 17:45:51 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 17:45:51 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:45:51 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:45:51 INFO - Using real prefix '/tools/python27' 17:45:51 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:45:52 INFO - Installing distribute.............................................................................................................................................................................................done. 17:45:55 INFO - Installing pip.................done. 17:45:55 INFO - Return code: 0 17:45:55 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:45:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:45:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:45:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:45:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:45:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:45:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:45:55 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 0x105c28a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105cbd618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f909a49e310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105b8cd30>, '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 0x1058f1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105b84b20>, '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.q1KuuMK0Aa/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.xwUu34LewB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/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 17:45:55 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 17:45:55 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 17:45:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.q1KuuMK0Aa/Render', 17:45:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:45:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:45:55 INFO - 'HOME': '/Users/cltbld', 17:45:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:45:55 INFO - 'LOGNAME': 'cltbld', 17:45:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:45:55 INFO - 'MOZ_NO_REMOTE': '1', 17:45:55 INFO - 'NO_EM_RESTART': '1', 17:45:55 INFO - 'PAGER': '/bin/cat', 17:45:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:45:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:45:55 INFO - 'PWD': '/builds/slave/test', 17:45:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:45:55 INFO - 'SHELL': '/bin/bash', 17:45:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xwUu34LewB/Listeners', 17:45:55 INFO - 'TMPDIR': '/var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/T/', 17:45:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:45:55 INFO - 'USER': 'cltbld', 17:45:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:45:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:45:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:45:55 INFO - 'XPC_FLAGS': '0x0', 17:45:55 INFO - 'XPC_SERVICE_NAME': '0', 17:45:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:45:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:45:55 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 17:45:55 INFO - Cleaning up... 17:45:55 INFO - Return code: 0 17:45:55 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:45:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:45:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:45:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:45:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:45:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:45:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:45:55 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 0x105c28a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105cbd618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f909a49e310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105b8cd30>, '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 0x1058f1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105b84b20>, '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.q1KuuMK0Aa/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.xwUu34LewB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/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 17:45:55 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 17:45:55 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 17:45:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.q1KuuMK0Aa/Render', 17:45:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:45:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:45:55 INFO - 'HOME': '/Users/cltbld', 17:45:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:45:55 INFO - 'LOGNAME': 'cltbld', 17:45:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:45:55 INFO - 'MOZ_NO_REMOTE': '1', 17:45:55 INFO - 'NO_EM_RESTART': '1', 17:45:55 INFO - 'PAGER': '/bin/cat', 17:45:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:45:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:45:55 INFO - 'PWD': '/builds/slave/test', 17:45:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:45:55 INFO - 'SHELL': '/bin/bash', 17:45:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xwUu34LewB/Listeners', 17:45:55 INFO - 'TMPDIR': '/var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/T/', 17:45:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:45:55 INFO - 'USER': 'cltbld', 17:45:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:45:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:45:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:45:55 INFO - 'XPC_FLAGS': '0x0', 17:45:55 INFO - 'XPC_SERVICE_NAME': '0', 17:45:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:45:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:45:55 INFO - Downloading/unpacking psutil>=3.1.1 17:45:55 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 17:45:55 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 17:45:55 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 17:45:55 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 17:45:55 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 17:45:55 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 17:45:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:45:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:45:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:45:59 INFO - Installing collected packages: psutil 17:45:59 INFO - Running setup.py install for psutil 17:45:59 INFO - building 'psutil._psutil_osx' extension 17:45:59 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 17:45:59 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 17:45:59 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 17:45:59 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 17:46:00 INFO - building 'psutil._psutil_posix' extension 17:46:00 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 17:46:00 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 17:46:00 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 17:46:00 INFO - ^ 17:46:00 INFO - 1 warning generated. 17:46:00 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 17:46:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:46:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:46:00 INFO - Successfully installed psutil 17:46:00 INFO - Cleaning up... 17:46:00 INFO - Return code: 0 17:46:00 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:46:00 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')]} 17:46:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:46:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:46:00 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')]} 17:46:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:46:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:46:00 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 0x105c28a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105cbd618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f909a49e310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105b8cd30>, '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 0x1058f1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105b84b20>, '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.q1KuuMK0Aa/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.xwUu34LewB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/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 17:46:00 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 17:46:00 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 17:46:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.q1KuuMK0Aa/Render', 17:46:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:46:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:46:00 INFO - 'HOME': '/Users/cltbld', 17:46:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:46:00 INFO - 'LOGNAME': 'cltbld', 17:46:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:46:00 INFO - 'MOZ_NO_REMOTE': '1', 17:46:00 INFO - 'NO_EM_RESTART': '1', 17:46:00 INFO - 'PAGER': '/bin/cat', 17:46:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:46:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:46:00 INFO - 'PWD': '/builds/slave/test', 17:46:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:46:00 INFO - 'SHELL': '/bin/bash', 17:46:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xwUu34LewB/Listeners', 17:46:00 INFO - 'TMPDIR': '/var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/T/', 17:46:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:46:00 INFO - 'USER': 'cltbld', 17:46:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:46:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:46:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:46:00 INFO - 'XPC_FLAGS': '0x0', 17:46:00 INFO - 'XPC_SERVICE_NAME': '0', 17:46:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:46:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:46:00 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:46:00 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 17:46:00 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 17:46:00 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 17:46:00 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 17:46:00 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 17:46:00 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 17:46:02 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:46:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:46:03 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:46:03 INFO - Installing collected packages: mozsystemmonitor 17:46:03 INFO - Running setup.py install for mozsystemmonitor 17:46:03 INFO - Successfully installed mozsystemmonitor 17:46:03 INFO - Cleaning up... 17:46:03 INFO - Return code: 0 17:46:03 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 17:46:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:46:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:46:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:46:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:46:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:46:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:46:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x105c28a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105cbd618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f909a49e310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105b8cd30>, '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 0x1058f1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105b84b20>, '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.q1KuuMK0Aa/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.xwUu34LewB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/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 17:46:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 17:46:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 17:46:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.q1KuuMK0Aa/Render', 17:46:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:46:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:46:03 INFO - 'HOME': '/Users/cltbld', 17:46:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:46:03 INFO - 'LOGNAME': 'cltbld', 17:46:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:46:03 INFO - 'MOZ_NO_REMOTE': '1', 17:46:03 INFO - 'NO_EM_RESTART': '1', 17:46:03 INFO - 'PAGER': '/bin/cat', 17:46:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:46:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:46:03 INFO - 'PWD': '/builds/slave/test', 17:46:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:46:03 INFO - 'SHELL': '/bin/bash', 17:46:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xwUu34LewB/Listeners', 17:46:03 INFO - 'TMPDIR': '/var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/T/', 17:46:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:46:03 INFO - 'USER': 'cltbld', 17:46:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:46:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:46:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:46:03 INFO - 'XPC_FLAGS': '0x0', 17:46:03 INFO - 'XPC_SERVICE_NAME': '0', 17:46:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:46:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:46:03 INFO - Downloading/unpacking jsonschema==2.5.1 17:46:03 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 17:46:03 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 17:46:03 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 17:46:03 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 17:46:03 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 17:46:03 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 17:46:06 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:46:06 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 17:46:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:46:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:46:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:46:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:46:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:46:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:46:06 INFO - Downloading functools32-3.2.3-2.tar.gz 17:46:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:46:06 INFO - warning: no files found matching '*.txt' 17:46:06 INFO - no previously-included directories found matching 'build' 17:46:06 INFO - no previously-included directories found matching 'dist' 17:46:06 INFO - no previously-included directories found matching '.git*' 17:46:06 INFO - Installing collected packages: jsonschema, functools32 17:46:06 INFO - Running setup.py install for functools32 17:46:06 INFO - warning: no files found matching '*.txt' 17:46:06 INFO - no previously-included directories found matching 'build' 17:46:06 INFO - no previously-included directories found matching 'dist' 17:46:06 INFO - no previously-included directories found matching '.git*' 17:46:06 INFO - Successfully installed jsonschema functools32 17:46:06 INFO - Cleaning up... 17:46:06 INFO - Return code: 0 17:46:06 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 17:46:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:46:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:46:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:46:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:46:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:46:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:46:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x105c28a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105cbd618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f909a49e310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105b8cd30>, '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 0x1058f1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105b84b20>, '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.q1KuuMK0Aa/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.xwUu34LewB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/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 17:46:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 17:46:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 17:46:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.q1KuuMK0Aa/Render', 17:46:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:46:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:46:06 INFO - 'HOME': '/Users/cltbld', 17:46:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:46:06 INFO - 'LOGNAME': 'cltbld', 17:46:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:46:06 INFO - 'MOZ_NO_REMOTE': '1', 17:46:06 INFO - 'NO_EM_RESTART': '1', 17:46:06 INFO - 'PAGER': '/bin/cat', 17:46:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:46:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:46:06 INFO - 'PWD': '/builds/slave/test', 17:46:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:46:06 INFO - 'SHELL': '/bin/bash', 17:46:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xwUu34LewB/Listeners', 17:46:06 INFO - 'TMPDIR': '/var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/T/', 17:46:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:46:06 INFO - 'USER': 'cltbld', 17:46:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:46:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:46:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:46:06 INFO - 'XPC_FLAGS': '0x0', 17:46:06 INFO - 'XPC_SERVICE_NAME': '0', 17:46:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:46:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:46:07 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 17:46:07 INFO - Cleaning up... 17:46:07 INFO - Return code: 0 17:46:07 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:46:07 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')]} 17:46:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:46:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:46:07 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')]} 17:46:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:46:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:46:07 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 0x105c28a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105cbd618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f909a49e310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105b8cd30>, '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 0x1058f1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105b84b20>, '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.q1KuuMK0Aa/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.xwUu34LewB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/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 17:46:07 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 17:46:07 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 17:46:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.q1KuuMK0Aa/Render', 17:46:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:46:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:46:07 INFO - 'HOME': '/Users/cltbld', 17:46:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:46:07 INFO - 'LOGNAME': 'cltbld', 17:46:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:46:07 INFO - 'MOZ_NO_REMOTE': '1', 17:46:07 INFO - 'NO_EM_RESTART': '1', 17:46:07 INFO - 'PAGER': '/bin/cat', 17:46:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:46:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:46:07 INFO - 'PWD': '/builds/slave/test', 17:46:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:46:07 INFO - 'SHELL': '/bin/bash', 17:46:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xwUu34LewB/Listeners', 17:46:07 INFO - 'TMPDIR': '/var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/T/', 17:46:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:46:07 INFO - 'USER': 'cltbld', 17:46:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:46:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:46:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:46:07 INFO - 'XPC_FLAGS': '0x0', 17:46:07 INFO - 'XPC_SERVICE_NAME': '0', 17:46:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:46:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:46:07 INFO - Downloading/unpacking blobuploader==1.2.4 17:46:07 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 17:46:07 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 17:46:07 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 17:46:07 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 17:46:07 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 17:46:07 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 17:46:09 INFO - Downloading blobuploader-1.2.4.tar.gz 17:46:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:46:09 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:46:09 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 17:46:09 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 17:46:09 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 17:46:09 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 17:46:09 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 17:46:09 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 17:46:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:46:10 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:46:10 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 17:46:10 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 17:46:10 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 17:46:10 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 17:46:10 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 17:46:10 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 17:46:10 INFO - Downloading docopt-0.6.1.tar.gz 17:46:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:46:11 INFO - Installing collected packages: blobuploader, requests, docopt 17:46:11 INFO - Running setup.py install for blobuploader 17:46:11 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:46:11 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:46:11 INFO - Running setup.py install for requests 17:46:11 INFO - Running setup.py install for docopt 17:46:11 INFO - Successfully installed blobuploader requests docopt 17:46:11 INFO - Cleaning up... 17:46:11 INFO - Return code: 0 17:46:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:46:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:46:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:46:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:46:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:46:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:46:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:46:11 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 0x105c28a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105cbd618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f909a49e310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105b8cd30>, '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 0x1058f1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105b84b20>, '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.q1KuuMK0Aa/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.xwUu34LewB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/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 17:46:11 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 17:46:11 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 17:46:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.q1KuuMK0Aa/Render', 17:46:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:46:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:46:11 INFO - 'HOME': '/Users/cltbld', 17:46:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:46:11 INFO - 'LOGNAME': 'cltbld', 17:46:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:46:11 INFO - 'MOZ_NO_REMOTE': '1', 17:46:11 INFO - 'NO_EM_RESTART': '1', 17:46:11 INFO - 'PAGER': '/bin/cat', 17:46:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:46:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:46:11 INFO - 'PWD': '/builds/slave/test', 17:46:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:46:11 INFO - 'SHELL': '/bin/bash', 17:46:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xwUu34LewB/Listeners', 17:46:11 INFO - 'TMPDIR': '/var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/T/', 17:46:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:46:11 INFO - 'USER': 'cltbld', 17:46:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:46:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:46:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:46:11 INFO - 'XPC_FLAGS': '0x0', 17:46:11 INFO - 'XPC_SERVICE_NAME': '0', 17:46:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:46:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:46:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:46:12 INFO - Running setup.py (path:/var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/T/pip-lRGjNg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:46:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:46:12 INFO - Running setup.py (path:/var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/T/pip-Y1EJpH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:46:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:46:12 INFO - Running setup.py (path:/var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/T/pip-sTRPGt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:46:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:46:12 INFO - Running setup.py (path:/var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/T/pip-NV0LZ_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:46:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:46:12 INFO - Running setup.py (path:/var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/T/pip-i7Wc94-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:46:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:46:12 INFO - Running setup.py (path:/var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/T/pip-MIusLG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:46:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:46:12 INFO - Running setup.py (path:/var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/T/pip-Ej6HNc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:46:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:46:12 INFO - Running setup.py (path:/var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/T/pip-jT6yzj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:46:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:46:13 INFO - Running setup.py (path:/var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/T/pip-NOtLnP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:46:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:46:13 INFO - Running setup.py (path:/var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/T/pip-bNUsTa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:46:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:46:13 INFO - Running setup.py (path:/var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/T/pip-cp13le-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:46:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:46:13 INFO - Running setup.py (path:/var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/T/pip-OjCldl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:46:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:46:13 INFO - Running setup.py (path:/var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/T/pip-vg98hk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:46:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:46:13 INFO - Running setup.py (path:/var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/T/pip-JpO4Yt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:46:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:46:13 INFO - Running setup.py (path:/var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/T/pip-744vvi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:46:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:46:13 INFO - Running setup.py (path:/var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/T/pip-Pye0j7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:46:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:46:13 INFO - Running setup.py (path:/var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/T/pip-9MJ6oM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:46:13 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:46:13 INFO - Running setup.py install for manifestparser 17:46:14 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:46:14 INFO - Running setup.py install for mozcrash 17:46:14 INFO - Running setup.py install for mozdebug 17:46:14 INFO - Running setup.py install for mozdevice 17:46:14 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:46:14 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:46:14 INFO - Running setup.py install for mozfile 17:46:14 INFO - Running setup.py install for mozhttpd 17:46:14 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:46:14 INFO - Running setup.py install for mozinfo 17:46:15 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:46:15 INFO - Running setup.py install for mozInstall 17:46:15 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:46:15 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:46:15 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:46:15 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:46:15 INFO - Running setup.py install for mozleak 17:46:15 INFO - Running setup.py install for mozlog 17:46:15 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:46:15 INFO - Running setup.py install for moznetwork 17:46:15 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:46:15 INFO - Running setup.py install for mozprocess 17:46:15 INFO - Running setup.py install for mozprofile 17:46:15 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:46:15 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:46:15 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:46:15 INFO - Running setup.py install for mozrunner 17:46:16 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:46:16 INFO - Running setup.py install for mozscreenshot 17:46:16 INFO - Running setup.py install for moztest 17:46:16 INFO - Running setup.py install for mozversion 17:46:16 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:46:16 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:46:16 INFO - Cleaning up... 17:46:16 INFO - Return code: 0 17:46:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:46: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')]} 17:46:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:46:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:46: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')]} 17:46:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:46:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:46:16 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 0x105c28a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105cbd618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f909a49e310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105b8cd30>, '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 0x1058f1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105b84b20>, '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.q1KuuMK0Aa/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.xwUu34LewB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/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 17:46:16 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 17:46:16 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 17:46:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.q1KuuMK0Aa/Render', 17:46:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:46:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:46:16 INFO - 'HOME': '/Users/cltbld', 17:46:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:46:16 INFO - 'LOGNAME': 'cltbld', 17:46:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:46:16 INFO - 'MOZ_NO_REMOTE': '1', 17:46:16 INFO - 'NO_EM_RESTART': '1', 17:46:16 INFO - 'PAGER': '/bin/cat', 17:46:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:46:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:46:16 INFO - 'PWD': '/builds/slave/test', 17:46:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:46:16 INFO - 'SHELL': '/bin/bash', 17:46:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xwUu34LewB/Listeners', 17:46:16 INFO - 'TMPDIR': '/var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/T/', 17:46:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:46:16 INFO - 'USER': 'cltbld', 17:46:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:46:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:46:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:46:16 INFO - 'XPC_FLAGS': '0x0', 17:46:16 INFO - 'XPC_SERVICE_NAME': '0', 17:46:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:46:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:46:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:46:16 INFO - Running setup.py (path:/var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/T/pip-PTtucp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:46:16 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)) 17:46:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:46:16 INFO - Running setup.py (path:/var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/T/pip-jAGs_C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:46:17 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)) 17:46:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:46:17 INFO - Running setup.py (path:/var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/T/pip-uCN1hO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:46:17 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)) 17:46:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:46:17 INFO - Running setup.py (path:/var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/T/pip-0Pluxk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:46:17 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)) 17:46:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:46:17 INFO - Running setup.py (path:/var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/T/pip-wy8zXG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:46:17 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)) 17:46:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:46:17 INFO - Running setup.py (path:/var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/T/pip-NY2mLy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:46:17 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)) 17:46:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:46:17 INFO - Running setup.py (path:/var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/T/pip-iXBY_i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:46:17 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)) 17:46:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:46:17 INFO - Running setup.py (path:/var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/T/pip-OM41KM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:46:17 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)) 17:46:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:46:17 INFO - Running setup.py (path:/var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/T/pip-dyySqP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:46:17 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)) 17:46:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:46:17 INFO - Running setup.py (path:/var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/T/pip-BYJLrR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:46:17 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)) 17:46:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:46:17 INFO - Running setup.py (path:/var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/T/pip-qQLRrr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:46:17 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)) 17:46:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:46:18 INFO - Running setup.py (path:/var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/T/pip-Rc91jD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:46:18 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)) 17:46:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:46:18 INFO - Running setup.py (path:/var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/T/pip-phP__b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:46:18 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)) 17:46:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:46:18 INFO - Running setup.py (path:/var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/T/pip-qJCSYZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:46:18 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)) 17:46:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:46:18 INFO - Running setup.py (path:/var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/T/pip-FrjrDg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:46:18 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)) 17:46:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:46:18 INFO - Running setup.py (path:/var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/T/pip-skmtWc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:46:18 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)) 17:46:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:46:18 INFO - Running setup.py (path:/var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/T/pip-A4wP_I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:46:18 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)) 17:46:18 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)) 17:46:18 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)) 17:46:18 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)) 17:46:18 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)) 17:46:18 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)) 17:46:18 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:46:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:46:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:46:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:46:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:46:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:46:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:46:21 INFO - Downloading blessings-1.6.tar.gz 17:46:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:46:21 INFO - Installing collected packages: blessings 17:46:21 INFO - Running setup.py install for blessings 17:46:21 INFO - Successfully installed blessings 17:46:21 INFO - Cleaning up... 17:46:21 INFO - Return code: 0 17:46:21 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:46:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:46:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:46:21 INFO - Reading from file tmpfile_stdout 17:46:21 INFO - Current package versions: 17:46:21 INFO - blessings == 1.6 17:46:21 INFO - blobuploader == 1.2.4 17:46:21 INFO - docopt == 0.6.1 17:46:21 INFO - functools32 == 3.2.3-2 17:46:21 INFO - jsonschema == 2.5.1 17:46:21 INFO - manifestparser == 1.1 17:46:21 INFO - mozInstall == 1.12 17:46:21 INFO - mozcrash == 0.17 17:46:21 INFO - mozdebug == 0.1 17:46:21 INFO - mozdevice == 0.48 17:46:21 INFO - mozfile == 1.2 17:46:21 INFO - mozhttpd == 0.7 17:46:21 INFO - mozinfo == 0.9 17:46:21 INFO - mozleak == 0.1 17:46:21 INFO - mozlog == 3.3 17:46:21 INFO - moznetwork == 0.27 17:46:21 INFO - mozprocess == 0.23 17:46:21 INFO - mozprofile == 0.28 17:46:21 INFO - mozrunner == 6.12 17:46:21 INFO - mozscreenshot == 0.1 17:46:21 INFO - mozsystemmonitor == 0.3 17:46:21 INFO - moztest == 0.7 17:46:21 INFO - mozversion == 1.4 17:46:21 INFO - psutil == 3.1.1 17:46:21 INFO - requests == 1.2.3 17:46:21 INFO - wsgiref == 0.1.2 17:46:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:46:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:46:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:46:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:46:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:46:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:46:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:46:21 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 0x105c28a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105cbd618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f909a49e310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105b8cd30>, '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 0x1058f1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105b84b20>, '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.q1KuuMK0Aa/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.xwUu34LewB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/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 17:46:21 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 17:46:21 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 17:46:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.q1KuuMK0Aa/Render', 17:46:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:46:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:46:21 INFO - 'HOME': '/Users/cltbld', 17:46:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:46:21 INFO - 'LOGNAME': 'cltbld', 17:46:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:46:21 INFO - 'MOZ_NO_REMOTE': '1', 17:46:21 INFO - 'NO_EM_RESTART': '1', 17:46:21 INFO - 'PAGER': '/bin/cat', 17:46:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:46:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:46:21 INFO - 'PWD': '/builds/slave/test', 17:46:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:46:21 INFO - 'SHELL': '/bin/bash', 17:46:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xwUu34LewB/Listeners', 17:46:21 INFO - 'TMPDIR': '/var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/T/', 17:46:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:46:21 INFO - 'USER': 'cltbld', 17:46:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:46:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:46:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:46:21 INFO - 'XPC_FLAGS': '0x0', 17:46:21 INFO - 'XPC_SERVICE_NAME': '0', 17:46:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:46:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:46:21 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)) 17:46:21 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)) 17:46:21 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)) 17:46:21 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)) 17:46:21 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)) 17:46:21 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)) 17:46:21 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)) 17:46:21 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)) 17:46:21 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)) 17:46:21 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)) 17:46:21 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)) 17:46:21 INFO - Cleaning up... 17:46:21 INFO - Return code: 0 17:46:21 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:46:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:46:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:46:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:46:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:46:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:46:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:46:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x105c28a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105cbd618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f909a49e310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105b8cd30>, '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 0x1058f1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105b84b20>, '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.q1KuuMK0Aa/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.xwUu34LewB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/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 17:46:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 17:46:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 17:46:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.q1KuuMK0Aa/Render', 17:46:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:46:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:46:21 INFO - 'HOME': '/Users/cltbld', 17:46:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:46:21 INFO - 'LOGNAME': 'cltbld', 17:46:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:46:21 INFO - 'MOZ_NO_REMOTE': '1', 17:46:21 INFO - 'NO_EM_RESTART': '1', 17:46:21 INFO - 'PAGER': '/bin/cat', 17:46:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:46:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:46:21 INFO - 'PWD': '/builds/slave/test', 17:46:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:46:21 INFO - 'SHELL': '/bin/bash', 17:46:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xwUu34LewB/Listeners', 17:46:21 INFO - 'TMPDIR': '/var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/T/', 17:46:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:46:21 INFO - 'USER': 'cltbld', 17:46:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:46:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:46:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:46:21 INFO - 'XPC_FLAGS': '0x0', 17:46:21 INFO - 'XPC_SERVICE_NAME': '0', 17:46:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:46:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:46:22 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 17:46:22 INFO - Cleaning up... 17:46:22 INFO - Return code: 0 17:46:22 INFO - Running post-action listener: _resource_record_post_action 17:46:22 INFO - Running post-action listener: _start_resource_monitoring 17:46:22 INFO - Starting resource monitoring. 17:46:22 INFO - [mozharness: 2016-08-06 00:46:22.209951Z] Finished create-virtualenv step (success) 17:46:22 INFO - [mozharness: 2016-08-06 00:46:22.210926Z] Running install step. 17:46:22 INFO - Running pre-action listener: _resource_record_pre_action 17:46:22 INFO - Running main action method: install 17:46:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:46:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:46:22 INFO - Reading from file tmpfile_stdout 17:46:22 INFO - Detecting whether we're running mozinstall >=1.0... 17:46:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:46:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:46:22 INFO - Reading from file tmpfile_stdout 17:46:22 INFO - Output received: 17:46:22 INFO - Usage: mozinstall [options] installer 17:46:22 INFO - Options: 17:46:22 INFO - -h, --help show this help message and exit 17:46:22 INFO - -d DEST, --destination=DEST 17:46:22 INFO - Directory to install application into. [default: 17:46:22 INFO - "/builds/slave/test"] 17:46:22 INFO - --app=APP Application being installed. [default: firefox] 17:46:22 INFO - mkdir: /builds/slave/test/build/application 17:46:22 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'] 17:46:22 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 17:46:56 INFO - Reading from file tmpfile_stdout 17:46:56 INFO - Output received: 17:46:56 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 17:46:56 INFO - Running post-action listener: _resource_record_post_action 17:46:56 INFO - [mozharness: 2016-08-06 00:46:56.255801Z] Finished install step (success) 17:46:56 INFO - [mozharness: 2016-08-06 00:46:56.255928Z] Running run-tests step. 17:46:56 INFO - Running pre-action listener: _resource_record_pre_action 17:46:56 INFO - Running main action method: run_tests 17:46:56 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 17:46:56 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 17:46:56 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 17:46:56 INFO - 2016-08-05 17:46:56.270 screenresolution[1648:7511] starting screenresolution argv=screenresolution get 17:46:56 INFO - 2016-08-05 17:46:56.272 screenresolution[1648:7511] Display 0: 1600x1200x32@60 17:46:56 INFO - 2016-08-05 17:46:56.278 screenresolution[1649:7513] starting screenresolution argv=screenresolution list 17:46:56 INFO - Available Modes on Display 0 17:46:56 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 17:46:56 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 17:46:56 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 17:46:56 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 17:46:56 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 17:46:56 INFO - Intel Iris: 17:46:56 INFO - Chipset Model: Intel Iris 17:46:56 INFO - Type: GPU 17:46:56 INFO - Bus: Built-In 17:46:56 INFO - VRAM (Dynamic, Max): 1536 MB 17:46:56 INFO - Vendor: Intel (0x8086) 17:46:56 INFO - Device ID: 0x0a2e 17:46:56 INFO - Revision ID: 0x0009 17:46:56 INFO - Displays: 17:46:56 INFO - Display: 17:46:56 INFO - Resolution: 1600 x 1200 @ 60 Hz 17:46:56 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 17:46:56 INFO - Display Serial Number: 1600x1200 60 17:46:56 INFO - Main Display: Yes 17:46:56 INFO - Mirror: Off 17:46:56 INFO - Online: Yes 17:46:56 INFO - Rotation: Supported 17:46:56 INFO - Return code: 0 17:46:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:46:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:46:56 INFO - Python 2.7.3 17:46:56 INFO - Return code: 0 17:46:56 INFO - grabbing minidump binary from tooltool 17:46:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:46:56 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 0x105b8cd30>, '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 0x1058f1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105b84b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:46:56 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 17:46:56 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 17:46:56 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 17:46:56 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:46:56 INFO - Return code: 0 17:46:56 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 17:46:56 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:46:56 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:46:56 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 17:46:56 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:46:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/UyzA1WRmSp2igr7llMdS3Q/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0336', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 17:46:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/UyzA1WRmSp2igr7llMdS3Q/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0336 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 17:46:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.q1KuuMK0Aa/Render', 17:46:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:46:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:46:56 INFO - 'HOME': '/Users/cltbld', 17:46:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:46:56 INFO - 'LOGNAME': 'cltbld', 17:46:56 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:46:56 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 17:46:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:46:56 INFO - 'MOZ_NO_REMOTE': '1', 17:46:56 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:46:56 INFO - 'NO_EM_RESTART': '1', 17:46:56 INFO - 'PAGER': '/bin/cat', 17:46:56 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:46:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:46:56 INFO - 'PWD': '/builds/slave/test', 17:46:56 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:46:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:46:56 INFO - 'SHELL': '/bin/bash', 17:46:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xwUu34LewB/Listeners', 17:46:56 INFO - 'TMPDIR': '/var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/T/', 17:46:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:46:56 INFO - 'USER': 'cltbld', 17:46:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:46:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:46:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:46:56 INFO - 'XPC_FLAGS': '0x0', 17:46:56 INFO - 'XPC_SERVICE_NAME': '0', 17:46:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:46:56 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/UyzA1WRmSp2igr7llMdS3Q/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0336', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 17:46:56 INFO - mozversion application_buildid: 20160805145221 17:46:56 INFO - mozversion application_changeset: ca2b685228c1a86d90e205033d266c37c58d9c9b 17:46:56 INFO - mozversion application_display_name: Nightly 17:46:56 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:46:56 INFO - mozversion application_name: Firefox 17:46:56 INFO - mozversion application_remotingname: firefox 17:46:56 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 17:46:56 INFO - mozversion application_vendor: Mozilla 17:46:56 INFO - mozversion application_version: 51.0a1 17:46:56 INFO - mozversion platform_buildid: 20160805145221 17:46:56 INFO - mozversion platform_changeset: ca2b685228c1a86d90e205033d266c37c58d9c9b 17:46:56 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 17:46:56 INFO - mozversion platform_version: 51.0a1 17:46:56 INFO - using testdate: 1470444416 17:46:56 INFO - actual date: 1470444416 17:46:56 INFO - starting webserver on 'localhost:49273' 17:46:56 INFO - SUITE-START | Running 2 tests 17:46:56 INFO - TEST-START | dromaeo_css 17:46:56 INFO - operating with platform_type : mac_ 17:46:56 INFO - Initialising browser for dromaeo_css test... 17:46:56 INFO - TEST-INFO | started process 1659 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/T/tmpqueds6/profile http://localhost:49273/getInfo.html) 17:46:59 INFO - PROCESS | 1659 | __metrics Screen width/height:1600/1200 17:46:59 INFO - PROCESS | 1659 | colorDepth:24 17:46:59 INFO - PROCESS | 1659 | Browser inner width/height: 1024/689 17:46:59 INFO - PROCESS | 1659 | __metrics 17:46:59 ERROR - PROCESS | 1659 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 17:47:00 INFO - TEST-INFO | 1659: exit 0 17:47:00 INFO - Browser initialized. 17:47:00 INFO - Running cycle 1/1 for dromaeo_css test... 17:47:00 INFO - TEST-INFO | started process 1662 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/T/tmpqueds6/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:47:12 INFO - PROCESS | 1662 | RSS: Main: 254623744 17:47:12 INFO - PROCESS | 1662 | 17:48:02 INFO - PROCESS | 1662 | 1470444482121 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] 17:50:14 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49273/tests/dromaeo/cssquery-ext.html) 17:50:16 INFO - PROCESS | 1662 | RSS: Main: 269934592 17:50:16 INFO - PROCESS | 1662 | 17:53:18 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-ext.html (next: http://localhost:49273/tests/dromaeo/cssquery-jquery.html) 17:53:19 INFO - PROCESS | 1662 | RSS: Main: 280494080 17:53:19 INFO - PROCESS | 1662 | 17:56:20 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49273/tests/dromaeo/cssquery-mootools.html) 17:56:21 INFO - PROCESS | 1662 | RSS: Main: 287514624 17:56:21 INFO - PROCESS | 1662 | 17:59:23 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49273/tests/dromaeo/cssquery-prototype.html) 17:59:23 INFO - PROCESS | 1662 | RSS: Main: 287219712 17:59:23 INFO - PROCESS | 1662 | 18:02:26 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49273/tests/dromaeo/cssquery-yui.html) 18:02:27 INFO - PROCESS | 1662 | RSS: Main: 292630528 18:02:27 INFO - PROCESS | 1662 | 18:05:29 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-yui.html (next: http://localhost:49273/tests/dromaeo/cssquery-dojo.html) 18:05:30 INFO - PROCESS | 1662 | RSS: Main: 291921920 18:05:30 INFO - PROCESS | 1662 | 18:05:30 INFO - PROCESS | 1662 | __start_tp_report 18:05:30 INFO - PROCESS | 1662 | _x_x_mozilla_page_load 18:05:30 INFO - PROCESS | 1662 | _x_x_mozilla_page_load_details 18:05:30 INFO - PROCESS | 1662 | |i|pagename|runs| 18:05:30 INFO - PROCESS | 1662 | |0;dojo.html;3380.3070370574037;3402.625711171771;3408.539847120638;3430.656934306569;3432.365012472694;5676.375598684152;5699.7150142492865;5707.714614269291;5710.5717071219615;5792.82621521355;5725.513331366838;5732.627379220347;5821.126830975356;5835.241418615585;5836.2996440427105;5162.354705661793;5254.21186821976;5285.762140703659;5334;5385.946140538584;5399.595030372718;5400.405955344929;5441.755121019544;5448.155535891943;5461.1535212042;5168.069747445458;5197.974010129963;5293.57651387888;5308.071087559701;5333.280007199037;4237.4915010198665;4363.956360436387;5262.526372626482;5276.234945932857;5281.943611277759;5184.351956005499;5219.791208351699;5238.188080847474;5247.950409918031;5251.527362537352;5547.833564993057;5620.4098569650005;5659.320881494205;5699.715014249271;5738.77044918207;6284.2458904931245;6307.243130824285;6315.052742088677;6327.525435592349;6331.905021424683;6298.779542715983;6299.5275354348605;6314.179156709644;6316.1788967434395;6331.2719037310835;4787.257975013878;5782.971085144632;5800.24596802413;5908.645481271137;5965.940340596582;6317.14718513004;6328.557001009977;6336.081268216083;6344.080108384258;6347.650879201688;6167.506599472121;6228.065790131516;6232.065190221412;6237.688115594202;6252.499800015988;6154.846128846814;6200.627962322275;6221.626702397871;6247.656378899113;6363.109164716943;6295.811125666238;6324.43080122782;6335.68321583919;6338.524610654127;6340.587861788969;5677.659340439587;5828.941710582924;6279.7488100476385;6312.368763123651;6324.747010119636;4928.802847886116;4958.454569997298;4972.030454061495;5020.623453240948;5081.618878584121;4410.095930334273;4479.193745125908;4496.348029535764;4513.661475389359;4560.384348113029;5660.830175094754;5762.798302059407;5781.132830075522;5786.94213057864;5846.356900740915;5258;6177.135201071854;6287.245530536274;6341.4292713656;6344.524160687967;4868.342773725572;5800.564957628195;5815.069588865761;5818.389069147678;5851.268591426072;4667.836625718083;4738.8341408050555;4775.856724298276;5319.749858783183;5518.834434966958;5521.69630670317;6082.197745648207;6219.906701399392;6366.140571022853;6389.808305750835;6313.210848643919;6324.083007963727;6325.114483972339;6329.367063293634;6330.303666596763;6331.05034244867;6384.7446102157255;6394.936050639434;6396;6450.580712253689;6122.15420935445;6125.693715314127;6164.691765411621;6189.04069869171;6198.783042593668;5566.554675625859;6153.969230153821;6202.968985155046;6211.068339748893;6224.315325314121;6003.0695242237525;6139.2325959255095;6213.689315534115;6220.098085777447;6223.439890409885;6117.3270940197435;6127.264728232641;6152.600080994721;6211.223597050369;6244.812655620157;5943.970280148572;6086.056661217518;6129.754809807558;6131.77428366204;6131.901258721728;6146.416090471398;6189.967982924248;6193.690315484298;6228.657423841551;6264.937350626436;5895.557833162616;5990.7903223386975;6029.969850150721;6126.66303353302;6133.080037994337 18:05:30 INFO - PROCESS | 1662 | |1;ext.html;502.5878779400891;515.4948150812206;540.3299908113938;549.3819453115243;569.1235497334106;38403.03992400188;41520.37719434207;41649.583504164984;41658.58341416585;41729;42398.15203695932;42807.78596107023;42840.78579607105;42901.7854910725;42908;9598.520073996324;9816.754581135494;9819.36174148678;9820;9829.754256143582;9699.854502182437;9721.465319407429;9758.707238782812;9784.168345690625;9796.265280103986;9609.231261499099;9729.805403891918;9755.170810481117;9777.755556111082;9788.853167202462;9654.806903861883;9713.95143024284;9767.755806104833;9783.36408133469;9787.608495660164;9573.664921727775;9613.759656008586;9683.370580912218;9779.951100244452;9795.314327997043;40202.39696404556;40211.39682904759;40265.79867100646;40420;40602.59397406047;2633.591793272046;3351.095204294851;3372.853229901845;3427.1089516725583;3429.4855771634207;29116.708832911612;29769.553456698166;30734.846325768453;30789.230269243224;31430.528542071886;3105.9534106988413;3160.478521044025;3163.9209019774457;3203.1511649412923;3257.071734555664;535119.3244033793;538859;538887;541684;547580;62775.6861215691;63024.684876575324;63038.68480657659;63247;63253;35243.29513409718;36019.63980360215;66107.33892661011;66834.66582667055;67126.98619041436;16286.26711797972;16572.419965301397;16793;16806.15969201535;16827.74758378625;12742.235465872078;12781.041421893395;12814.295213763333;12822.935885320514;12838.29389383593;15253.161076140697;18785.436436906915;19482;19544.72959257672;19550.608987820164;8014.438989270695;8137.715179968791;8140.947144820692;8171.591420428955;8206.466579672302;885.2475395913422;1030.5156576409076;1042.0257059649252;1070.7644318249972;1076.311160857052;23264.836758162364;26133.738662613512;30427.391452170832;30488.08535743931;31102.68897311043;943.4480828715141;1060.7719340341864;1070.208046045936;1088.2219213262556;1162.2851946053286;12470.875291247154;12797.168184068007;13417.798733019012;15598.844011559966;16148.35406583747;624848;727590;729861;734996;735733;59273.40726592679;59454.40545594575;59839.70080149572;59897.70051149716;59938.40061599328;1378.1248906944163;1402.2077526197666;1448.7030158817417;1580.7707882356995;1634.2890842483557;28439.293642381523;29532.409351812414;29744.405111898075;30029.5495567571;30553.847230763702;50868.23697644464;51114.74442627912;51194.23208651948;51204.74397627988;51216.74391628018;605954;607153;607901;608743;610072;26923.057692980652;26985.460290793682;27292.31769205786;27409.451810964067;27717.861410692818;47191.76404117957;47518.52481475141;47563.52436475591;47735.761321193175;48070.5192948066;37374.439383409815;38578.228435431694;38876;39276.803615981735;39592.208155837296;38531.80734096312;38786;38859;39629;40052.399214012396;37676.05809854666;38235;38315;38575.61424385833;38888.611113888495;24968.500629986935;33077.338453231285;33866.153346166546;34327;34618.65381346154;23558;25377.492450150523;25686.8715656428;25830.87084564565;25851 18:05:30 INFO - PROCESS | 1662 | |2;jquery.html;379.4213823918524;385.80131232415306;389.0150041609832;390.9765414075156;415.21731536054546;14691.412343506247;20893.686594701074;21011.159553617876;21726.91365431728;21744.89127554362;20102.396928092145;20443.591128177428;20954.790452095476;21518.462038449048;21525;5829.504492118164;6108.297545782225;6150.753969841201;6161.599496032743;6181.6600086995195;5969.373215812342;6009.09863520471;6058.545609079315;6101.145839582462;6104.603200791934;5918.112283157518;6029.427204415595;6032.487238584726;6042.395760423967;6045.425684559959;5679.062954612505;5935.317438494563;5970.223870896777;5991.940080599182;6048.123022161806;5849.327327357366;5962.791302304398;5965.194698715662;5972.880542389172;5978.013627751416;24175.637365439532;24179.91190396419;25477.235682929542;25908.74091259082;26346.077887273852;2281.7490076091617;2401.3396316013063;2876.6260386149665;3002.6697063323018;3032.5147976323683;10180.949095254551;10332.58669653213;10917;12566.560170394083;12956.48174073036;1773.3084097201972;1801.1534578747967;1855.202263026898;1899.3067530351461;1943.523836660013;124921;125667;126063.10905336335;128775;130000.34999825036;9649.649049132986;11165.609203677996;11457.026152777107;11490.482928268248;11660.183787134989;14214.289285535682;14608.926955365156;14613.26933653313;14642.633934151732;14651.853481465261;7240.818979525554;8304.501729896225;8573.828523429496;8591.44155629882;8717.084706105768;8442.620082096197;8518;8559.786005349915;8636.22273995331;8701.47791132534;4482.843100491467;4501.639868810487;4570.428696412949;4574.817007319736;4624.745638989821;1907.6947688369794;1970.6452838488922;1973.4375702924597;1977.8318842898227;1978.7130866024345;851.82537579796;881.7619242804407;912.8630705394244;945.669015844449;971.7764914069662;20512.487187820425;20640.27759028427;21876.45308867259;21923.561528769336;22000.33998980033;921.9673965159064;939.178219058324;957.8802649668792;967.2552134856121;1007.5919252702668;10996.460495530631;11323.716907077223;11596.01433878113;11642.708932276591;11723.589674361527;617501;618953;621913;635910;637409;139529;142147.28926355302;145779.27110364594;148653.25673371565;150598;974.4396971741277;975.7414285214423;992.5434300221834;993.3940296419179;1009.1674368645896;18543.165557549673;19441.222351106364;19442.319518816774;19534.511637209183;19581.902090490028;56377.43622563722;58638.70680646569;59060;59239.40760592512;59305.70347148237;55601.77592896239;83500.58249708713;84487;85645;86597.56701216454;6983.406410455168;8021.398395120273;8286.295664868554;8311.95844020776;8380.95809520973;11653.359065251492;11941.104417168573;13097.214167150001;13160.934195328962;13493.865061349261;8798.868016979879;9398.20115290208;10983.780324393307;11270.380129092979;11769.882301177222;8843.717660939257;9361.4383137012;11096.389698566656;11283.153763467608;11507.482163302504;11434.770219807058;11612.245204062046;11665.533378664759;11791.351475668578;11960.282383057045;7979.162187970412;8030.919690803017;8297.336213103057;8370.246677799027;8375.706850260212;8944.284457243535;9058.864117038118;11609.5356185755;11610.477528511406;11618.593349232737 18:05:30 INFO - PROCESS | 1662 | |3;mootools.html;1527.5188315680557;1583.2479572203206;1771.291483406637;1867.3930972433961;1871.6911709567914;7287.8542429151385;7829.491083079596;8254.91745082549;8850.159234872694;8855.778605534864;8366.07973122956;8559.400841941067;8561.101084386128;8571.871421928676;8593.742187734379;2339.2163625185585;2372.4306166519996;2376.66726658268;2378.8334816562847;2385.3678775124604;1897.487678326851;1952.4728323352685;2366.503034362786;2373.774491423312;2376.869272190029;2341.613633750429;2377.8929948152377;2378.3935096550354;2380.595298799208;2384.3085505203558;2335.7664233576675;2354.458474550854;2364.18435639704;2366.3610825077217;2385.9642105368434;2361.397843549901;2362.055177928825;2362.4212068043266;2362.6337917622795;2366.1363602285214;8633.913660863436;8711.520866352348;8725.476471411735;8735.475871447734;8863.955680221623;5202.92195617066;5328.413874473805;5362.195670649395;5368.651037682577;5378.650387724785;3489.5638045244345;3597.442396428558;3684.7840212729734;3692.593814680383;3739.6447337502896;972.2610815779988;1075.3386667199616;1102.9503672334765;1118.3401792942202;1126.4086354663784;11340.603078892282;11382.97553220206;11488.310701357945;11554.94222528882;11564.90133437322;4524.09518096382;4594.931076033862;4738.407699037621;4776.95223047772;4795.760211989456;9745.269104817167;9874.160696340892;9887.950560247296;9901.60393584263;9903.702888913343;5256.369235691742;5280.6303558750515;5288.709120998382;5289.418164001957;5308.495692909168;3794.430835374716;4666.719996800203;4763.118823017753;4804.111239420718;4849.830255941025;3915.784631845219;3919.2161567686007;4017.2568074906235;4034.495688038995;4035.475388199574;1293.2369901758009;1301.3493253373313;1302.3813688497887;1311.1608570514877;1317.1965101288206;894.6645008121955;935.3639525122845;937.9249660027182;949.7957939043139;963.8650588917557;5663.122216056436;5847.122931560215;5895.793647222326;5896.056630939029;5973.1936188614845;433.741923555484;434.433064850367;444.7968245894847;451.43119669216367;452.0236289614417;3484.77348972316;3550.680438760524;3821.560520540118;3915.432262322004;3936.15372694872;10099.343542669703;10480.423576703355;10544.420056896945;10555.894441055645;10557.788844223072;10219.437930913722;10424.739381515523;10503.159747220205;10520.368777873353;10529;7135.607541585263;7375.704971801175;7990.520568765893;8117.756467305991;8168.714095006765;4554.360430245175;5080.568151706999;5405.243265942692;5731.455511726379;5871.706414679335;9861.915189329025;9914.454704991007;9934.503274836374;9954.153896918842;9967.40195588267;9493.0981556752;9741.172000380047;9870.161036311707;9870.555824987749;9893.208543316661;7448.404127669665;7891.960540197492;7936.246056624612;7971.043474783063;8171.060328062111;8207.261346478846;8376.958115209629;8382.664693412195;8388.664453421794;8397.992240931128;7298.56208627484;7379.151397589346;7498.737544185928;7499.400047996038;7568.091828980558;7238.710451581877;7338.853222935618;7358.558486490828;7391.186969433251;7453.664585093792;6988.965055174895;7004.474664400089;7023.403010744144;7083.114610673666;7097.25478824716;4896.804127834846;4910.386201724785;5007.47421520735;5008.874778130576;5129.79480820763;4920.015996800583;4985.775640096132;5103.10695628271;5181.35233095863;5201.193814958688 18:05:30 INFO - PROCESS | 1662 | |4;prototype.html;256.6304521489056;294.70382265822843;316.0408161230665;317.7108830963822;318.3839271010594;4516.616087632547;4567.794449249784;5332.520073193412;5571;5657.0948648216345;5003.599712023039;5274.4198138204765;5326.520613144816;5557.194206840006;5580.720963951807;4014.678825693952;4294;4310.97844510777;4312.116016216683;4312.404410368168;3740.9812950935207;4258.041940563379;4319.524852266264;4340.804663790122;4350.825966961318;3567.7859328440245;3672.9081772955624;4078.388241763744;4252.170826688797;4263.4031235627035;3565.0374398912277;3707.94438083429;3780.8298626561595;4257.787110644455;4266.146770645883;3722.1253005543676;3726.7018638508853;3739.196072844324;3740.9438858417147;3753.6434038766274;5083.237514372837;5166.475889612573;5308.283381743454;5397;5422.129365368942;4945.208766597327;4957.3059771632;4962.3548938638105;4969.503049695038;4998.150314446553;5404.83785486436;5761.855953601152;5920.319163296233;5947.910781338283;5959.40405959405;3252.8861489847977;4058.8376464941366;4086.9386959195635;4092.7135100542973;4094.508658960914;4895.971845912362;6126.877462450726;6148.6618235997;6189.288231853305;6248.125262463259;3645.5078564393466;3831.4635950966886;4149.751014939114;4166.562510936369;4186.539480657125;4112.712110152321;4134.37984302357;4205.002623753692;4222.725522841067;4234.597713217239;4877.975610121997;4880.048390563877;4886.828960986349;4907.944791869693;4913.385826771653;5838.283138823409;5923.696786706918;5924.437178468039;6004.489618382487;6006.729697163638;1410.4851729118798;1431.591996281055;1446.3491428857055;1449.6593300574357;1454.8254209494928;867.6139118092389;885.274075258282;895.583553647557;903.3089686389917;904.9819003620022;4094.8566800161852;4496.6177874881005;4519.638428925678;4639.608117564784;4688.835890743808;5128.3076784633595;5169.663971841894;5177.870553236124;5178.974105129526;5185.714785686748;4204.978975105166;4316.611504964569;4364.432623758891;4502.842400515966;4657.510961349078;2624.5827253283396;2898.550724637681;3182.347618738153;3246.9837650811596;3251.6260630027377;5462.8361149165585;5654.547636189095;6086.908696369558;6316.336784637547;6345.238571371465;5334.986352592995;5862.648241105548;6187.257529096537;6283.8114856554375;6312.74893429884;6295.811125666329;6320.71556779946;6376.362363763679;6405.743770249231;6433.806985790434;5956.711167959063;6181.381861813783;6195.349488303663;6206.293269350965;6210.546834000635;5399;6090.878182436415;6096.512279017757;6103.42017508336;6124.785632503019;5503.2114562766465;5791.942080579141;6414.518911081781;6415.262244841716;6421.486281097407;3888.5806680560827;3949.881503554898;3991.2217117661776;4010.9744578987425;4029.758214507022;5324.707141107277;5605.467480589337;6131.130005348412;6175.59858609189;6193.597416167935;4486.91026179468;5581.10702287632;5641.871625674799;5770.538004673894;5979.624686322083;5844.649321040752;5903.527717782481;5974.522038236843;5989.023622204749;6015.819525414245;5003.123204157697;5882.352941176553;5883.35283118848;5894.823155305347;5897.587168898136;5186;5670.234518340137;5906.940930590639;5975.193348897843;5986.491148252448;5520.006398848246;5529.529989950899;5834.970825146017;5838.474537291664;5861.479563787442 18:05:30 INFO - PROCESS | 1662 | |5;yui.html;726.8280072384514;742.9814254643636;771.8147644565306;803.1526739290049;809.8299357135003;15153.39386424543;15504.612384690388;15791;15849.603759906007;15883.602909927258;14421.63945901353;14487.203203823785;14487.275636218174;14500;14505.564833055025;701.0885848397089;732.8351120997786;853.9444936079151;895.2882458445519;895.6327905558722;901.8016036471965;902.5171533229724;903.2954295649404;904.2043002158125;905.0316161706976;935.3592788939565;939.9013103624123;941.1247539787994;942.8632848237002;950.3775027357092;920.5443305563755;943.4009404028423;943.6414162618161;945.2910317262019;946.0728486083608;675.1526833823569;707.7063018847173;708.2881703887612;709.904162938002;710.254233055295;13231.801522977163;14839;14849.812015038771;15225.923870380577;15242.390304387922;14880.851191488055;14923.403063877431;14937.701245975128;14938.775918361232;14998.62503437412;11855.94072029643;12052.457639406248;12191.833781064433;12350.38248087592;12571.874281257162;3855.6722678572355;3861.716053790311;3952.980235098806;4060.7360521566;4085.162541678949;123269.38365308206;124155;127907;128483.35758321149;128569.35715321457;11159.888401116048;11472.655820325404;11595.652130436101;11755.529778808752;11939.223950443193;23984.52030959371;24048.87975560146;24234.515309693707;24478.877605612215;24548.895299711556;7857.921420785833;8136.715214967566;8202.38482113844;8330.250277475056;8382.58087095655;4456.131054444417;4503.659035771671;4542.517125160373;4548.4541854977615;4559.156556037144;3590.3716849551224;3644.1800594865945;3665.9633403666157;3698.260347930425;3722.236941427001;629.9055141728686;655.5509476008949;661.272600139852;666.7299743603849;672.5695554844904;641.2881701311541;667.7896462614261;692.4287462843074;707.6037419045351;722.5339655922006;9289.674861379819;9713.61145554184;9770.462624555576;9942.751431214132;10095.192384609214;620.7672122953892;620.7672122953892;624.3382015063955;655.6557807151188;667.89981502774;4060.519463708762;4388.210122177975;4453.933191002137;4483.789376868227;4718.292256161603;131288.3435582835;133649;135630;147748.261258693;179492;130384.348078259;130496;132031.33984330017;133981.66018339692;134639.98040029407;89847.55076224708;111474;111554;111686.88313116765;120047;9144.222741067084;10118.13995810335;10139.695809125738;10163.44101074448;10175.389476631426;52607.73696131495;56173.595660108826;62638;64411;65887.67056164688;86346.81919084875;88143;88350;89538.55230723805;91185.63221551549;13639.931800340935;13871.930640346734;13918;13926.58220253394;14440.566782996528;15207.5667893141;15273.539560023153;15412.229388530304;15448;15582.844171558592;13903.304834758424;14031.649208769863;14095.788563171765;14398.352074156479;14432.639184020483;14069.296535173406;14073.507427240407;14168.645783855485;14290.857091428952;14644.633884152556;13659.658508536968;13783.379747911167;14024.649383765487;14185.290735463392;14333.990006004187;10265.640702575374;10971.506282217479;11589.594364197214;11757.62699221754;11798.941005294919;9933.304668673123;11514.88485115138;11629.253296335906;11639.47622357013;11748.941255293668 18:05:30 INFO - PROCESS | 1662 | __end_tp_report 18:05:30 INFO - PROCESS | 1662 | __start_cc_report 18:05:30 INFO - PROCESS | 1662 | _x_x_mozilla_cycle_collect,411 18:05:30 INFO - PROCESS | 1662 | __end_cc_report 18:05:30 INFO - PROCESS | 1662 | __startTimestamp1470445530085__endTimestamp 18:05:30 INFO - PROCESS | 1662 | 18:05:30 INFO - PROCESS | 1662 | ------- Summary: start ------- 18:05:30 INFO - PROCESS | 1662 | Number of tests: 6 18:05:30 INFO - PROCESS | 1662 | 18:05:30 INFO - PROCESS | 1662 | [#0] dojo.html Cycles:165 Average:5752.38 Median:5990.79 stddev:672.77 (11.2%) stddev-sans-first:648.59 18:05:30 INFO - PROCESS | 1662 | Values: 3380.3 3402.6 3408.5 3430.7 3432.4 5676.4 5699.7 5707.7 5710.6 5792.8 5725.5 5732.6 5821.1 5835.2 5836.3 5162.4 5254.2 5285.8 5334.0 5385.9 5399.6 5400.4 5441.8 5448.2 5461.2 5168.1 5198.0 5293.6 5308.1 5333.3 4237.5 4364.0 5262.5 5276.2 5281.9 5184.4 5219.8 5238.2 5248.0 5251.5 5547.8 5620.4 5659.3 5699.7 5738.8 6284.2 6307.2 6315.1 6327.5 6331.9 6298.8 6299.5 6314.2 6316.2 6331.3 4787.3 5783.0 5800.2 5908.6 5965.9 6317.1 6328.6 6336.1 6344.1 6347.7 6167.5 6228.1 6232.1 6237.7 6252.5 6154.8 6200.6 6221.6 6247.7 6363.1 6295.8 6324.4 6335.7 6338.5 6340.6 5677.7 5828.9 6279.7 6312.4 6324.7 4928.8 4958.5 4972.0 5020.6 5081.6 4410.1 4479.2 4496.3 4513.7 4560.4 5660.8 5762.8 5781.1 5786.9 5846.4 5258.0 6177.1 6287.2 6341.4 6344.5 4868.3 5800.6 5815.1 5818.4 5851.3 4667.8 4738.8 4775.9 5319.7 5518.8 5521.7 6082.2 6219.9 6366.1 6389.8 6313.2 6324.1 6325.1 6329.4 6330.3 6331.1 6384.7 6394.9 6396.0 6450.6 6122.2 6125.7 6164.7 6189.0 6198.8 5566.6 6154.0 6203.0 6211.1 6224.3 6003.1 6139.2 6213.7 6220.1 6223.4 6117.3 6127.3 6152.6 6211.2 6244.8 5944.0 6086.1 6129.8 6131.8 6131.9 6146.4 6190.0 6193.7 6228.7 6264.9 5895.6 5990.8 6030.0 6126.7 6133.1 18:05:30 INFO - PROCESS | 1662 | 18:05:30 INFO - PROCESS | 1662 | [#1] ext.html Cycles:180 Average:74375.92 Median:40127.40 stddev:167232.04 (416.8%) stddev-sans-first:167609.19 18:05:30 INFO - PROCESS | 1662 | Values: 502.6 515.5 540.3 549.4 569.1 38403.0 41520.4 41649.6 41658.6 41729.0 42398.2 42807.8 42840.8 42901.8 42908.0 9598.5 9816.8 9819.4 9820.0 9829.8 9699.9 9721.5 9758.7 9784.2 9796.3 9609.2 9729.8 9755.2 9777.8 9788.9 9654.8 9714.0 9767.8 9783.4 9787.6 9573.7 9613.8 9683.4 9780.0 9795.3 40202.4 40211.4 40265.8 40420.0 40602.6 2633.6 3351.1 3372.9 3427.1 3429.5 29116.7 29769.6 30734.8 30789.2 31430.5 3106.0 3160.5 3163.9 3203.2 3257.1 535119.3 538859.0 538887.0 541684.0 547580.0 62775.7 63024.7 63038.7 63247.0 63253.0 35243.3 36019.6 66107.3 66834.7 67127.0 16286.3 16572.4 16793.0 16806.2 16827.7 12742.2 12781.0 12814.3 12822.9 12838.3 15253.2 18785.4 19482.0 19544.7 19550.6 8014.4 8137.7 8140.9 8171.6 8206.5 885.2 1030.5 1042.0 1070.8 1076.3 23264.8 26133.7 30427.4 30488.1 31102.7 943.4 1060.8 1070.2 1088.2 1162.3 12470.9 12797.2 13417.8 15598.8 16148.4 624848.0 727590.0 729861.0 734996.0 735733.0 59273.4 59454.4 59839.7 59897.7 59938.4 1378.1 1402.2 1448.7 1580.8 1634.3 28439.3 29532.4 29744.4 30029.5 30553.8 50868.2 51114.7 51194.2 51204.7 51216.7 605954.0 607153.0 607901.0 608743.0 610072.0 26923.1 26985.5 27292.3 27409.5 27717.9 47191.8 47518.5 47563.5 47735.8 48070.5 37374.4 38578.2 38876.0 39276.8 39592.2 38531.8 38786.0 38859.0 39629.0 40052.4 37676.1 38235.0 38315.0 38575.6 38888.6 24968.5 33077.3 33866.2 34327.0 34618.7 23558.0 25377.5 25686.9 25830.9 25851.0 18:05:30 INFO - PROCESS | 1662 | 18:05:30 INFO - PROCESS | 1662 | [#2] jquery.html Cycles:180 Average:36805.20 Median:382.61 stddev:105009.74 (27445.5%) stddev-sans-first:105268.70 18:05:30 INFO - PROCESS | 1662 | Values: 379.4 385.8 389.0 391.0 415.2 14691.4 20893.7 21011.2 21726.9 21744.9 20102.4 20443.6 20954.8 21518.5 21525.0 5829.5 6108.3 6150.8 6161.6 6181.7 5969.4 6009.1 6058.5 6101.1 6104.6 5918.1 6029.4 6032.5 6042.4 6045.4 5679.1 5935.3 5970.2 5991.9 6048.1 5849.3 5962.8 5965.2 5972.9 5978.0 24175.6 24179.9 25477.2 25908.7 26346.1 2281.7 2401.3 2876.6 3002.7 3032.5 10180.9 10332.6 10917.0 12566.6 12956.5 1773.3 1801.2 1855.2 1899.3 1943.5 124921.0 125667.0 126063.1 128775.0 130000.3 9649.6 11165.6 11457.0 11490.5 11660.2 14214.3 14608.9 14613.3 14642.6 14651.9 7240.8 8304.5 8573.8 8591.4 8717.1 8442.6 8518.0 8559.8 8636.2 8701.5 4482.8 4501.6 4570.4 4574.8 4624.7 1907.7 1970.6 1973.4 1977.8 1978.7 851.8 881.8 912.9 945.7 971.8 20512.5 20640.3 21876.5 21923.6 22000.3 922.0 939.2 957.9 967.3 1007.6 10996.5 11323.7 11596.0 11642.7 11723.6 617501.0 618953.0 621913.0 635910.0 637409.0 139529.0 142147.3 145779.3 148653.3 150598.0 974.4 975.7 992.5 993.4 1009.2 18543.2 19441.2 19442.3 19534.5 19581.9 56377.4 58638.7 59060.0 59239.4 59305.7 55601.8 83500.6 84487.0 85645.0 86597.6 6983.4 8021.4 8286.3 8312.0 8381.0 11653.4 11941.1 13097.2 13160.9 13493.9 8798.9 9398.2 10983.8 11270.4 11769.9 8843.7 9361.4 11096.4 11283.2 11507.5 11434.8 11612.2 11665.5 11791.4 11960.3 7979.2 8030.9 8297.3 8370.2 8375.7 8944.3 9058.9 11609.5 11610.5 11618.6 18:05:30 INFO - PROCESS | 1662 | 18:05:30 INFO - PROCESS | 1662 | [#3] mootools.html Cycles:180 Average:5635.43 Median:5044.72 stddev:3155.76 (62.6%) stddev-sans-first:3149.51 18:05:30 INFO - PROCESS | 1662 | Values: 1527.5 1583.2 1771.3 1867.4 1871.7 7287.9 7829.5 8254.9 8850.2 8855.8 8366.1 8559.4 8561.1 8571.9 8593.7 2339.2 2372.4 2376.7 2378.8 2385.4 1897.5 1952.5 2366.5 2373.8 2376.9 2341.6 2377.9 2378.4 2380.6 2384.3 2335.8 2354.5 2364.2 2366.4 2386.0 2361.4 2362.1 2362.4 2362.6 2366.1 8633.9 8711.5 8725.5 8735.5 8864.0 5202.9 5328.4 5362.2 5368.7 5378.7 3489.6 3597.4 3684.8 3692.6 3739.6 972.3 1075.3 1103.0 1118.3 1126.4 11340.6 11383.0 11488.3 11554.9 11564.9 4524.1 4594.9 4738.4 4777.0 4795.8 9745.3 9874.2 9888.0 9901.6 9903.7 5256.4 5280.6 5288.7 5289.4 5308.5 3794.4 4666.7 4763.1 4804.1 4849.8 3915.8 3919.2 4017.3 4034.5 4035.5 1293.2 1301.3 1302.4 1311.2 1317.2 894.7 935.4 937.9 949.8 963.9 5663.1 5847.1 5895.8 5896.1 5973.2 433.7 434.4 444.8 451.4 452.0 3484.8 3550.7 3821.6 3915.4 3936.2 10099.3 10480.4 10544.4 10555.9 10557.8 10219.4 10424.7 10503.2 10520.4 10529.0 7135.6 7375.7 7990.5 8117.8 8168.7 4554.4 5080.6 5405.2 5731.5 5871.7 9861.9 9914.5 9934.5 9954.2 9967.4 9493.1 9741.2 9870.2 9870.6 9893.2 7448.4 7892.0 7936.2 7971.0 8171.1 8207.3 8377.0 8382.7 8388.7 8398.0 7298.6 7379.2 7498.7 7499.4 7568.1 7238.7 7338.9 7358.6 7391.2 7453.7 6989.0 7004.5 7023.4 7083.1 7097.3 4896.8 4910.4 5007.5 5008.9 5129.8 4920.0 4985.8 5103.1 5181.4 5201.2 18:05:30 INFO - PROCESS | 1662 | 18:05:30 INFO - PROCESS | 1662 | [#4] prototype.html Cycles:180 Average:4727.90 Median:5178.42 stddev:1476.82 (28.5%) stddev-sans-first:1442.32 18:05:30 INFO - PROCESS | 1662 | Values: 256.6 294.7 316.0 317.7 318.4 4516.6 4567.8 5332.5 5571.0 5657.1 5003.6 5274.4 5326.5 5557.2 5580.7 4014.7 4294.0 4311.0 4312.1 4312.4 3741.0 4258.0 4319.5 4340.8 4350.8 3567.8 3672.9 4078.4 4252.2 4263.4 3565.0 3707.9 3780.8 4257.8 4266.1 3722.1 3726.7 3739.2 3740.9 3753.6 5083.2 5166.5 5308.3 5397.0 5422.1 4945.2 4957.3 4962.4 4969.5 4998.2 5404.8 5761.9 5920.3 5947.9 5959.4 3252.9 4058.8 4086.9 4092.7 4094.5 4896.0 6126.9 6148.7 6189.3 6248.1 3645.5 3831.5 4149.8 4166.6 4186.5 4112.7 4134.4 4205.0 4222.7 4234.6 4878.0 4880.0 4886.8 4907.9 4913.4 5838.3 5923.7 5924.4 6004.5 6006.7 1410.5 1431.6 1446.3 1449.7 1454.8 867.6 885.3 895.6 903.3 905.0 4094.9 4496.6 4519.6 4639.6 4688.8 5128.3 5169.7 5177.9 5179.0 5185.7 4205.0 4316.6 4364.4 4502.8 4657.5 2624.6 2898.6 3182.3 3247.0 3251.6 5462.8 5654.5 6086.9 6316.3 6345.2 5335.0 5862.6 6187.3 6283.8 6312.7 6295.8 6320.7 6376.4 6405.7 6433.8 5956.7 6181.4 6195.3 6206.3 6210.5 5399.0 6090.9 6096.5 6103.4 6124.8 5503.2 5791.9 6414.5 6415.3 6421.5 3888.6 3949.9 3991.2 4011.0 4029.8 5324.7 5605.5 6131.1 6175.6 6193.6 4486.9 5581.1 5641.9 5770.5 5979.6 5844.6 5903.5 5974.5 5989.0 6015.8 5003.1 5882.4 5883.4 5894.8 5897.6 5186.0 5670.2 5906.9 5975.2 5986.5 5520.0 5529.5 5835.0 5838.5 5861.5 18:05:30 INFO - PROCESS | 1662 | 18:05:30 INFO - PROCESS | 1662 | [#5] yui.html Cycles:180 Average:25443.15 Median:24356.70 stddev:40460.82 (166.1%) stddev-sans-first:40531.76 18:05:30 INFO - PROCESS | 1662 | Values: 726.8 743.0 771.8 803.2 809.8 15153.4 15504.6 15791.0 15849.6 15883.6 14421.6 14487.2 14487.3 14500.0 14505.6 701.1 732.8 853.9 895.3 895.6 901.8 902.5 903.3 904.2 905.0 935.4 939.9 941.1 942.9 950.4 920.5 943.4 943.6 945.3 946.1 675.2 707.7 708.3 709.9 710.3 13231.8 14839.0 14849.8 15225.9 15242.4 14880.9 14923.4 14937.7 14938.8 14998.6 11855.9 12052.5 12191.8 12350.4 12571.9 3855.7 3861.7 3953.0 4060.7 4085.2 123269.4 124155.0 127907.0 128483.4 128569.4 11159.9 11472.7 11595.7 11755.5 11939.2 23984.5 24048.9 24234.5 24478.9 24548.9 7857.9 8136.7 8202.4 8330.3 8382.6 4456.1 4503.7 4542.5 4548.5 4559.2 3590.4 3644.2 3666.0 3698.3 3722.2 629.9 655.6 661.3 666.7 672.6 641.3 667.8 692.4 707.6 722.5 9289.7 9713.6 9770.5 9942.8 10095.2 620.8 620.8 624.3 655.7 667.9 4060.5 4388.2 4453.9 4483.8 4718.3 131288.3 133649.0 135630.0 147748.3 179492.0 130384.3 130496.0 132031.3 133981.7 134640.0 89847.6 111474.0 111554.0 111686.9 120047.0 9144.2 10118.1 10139.7 10163.4 10175.4 52607.7 56173.6 62638.0 64411.0 65887.7 86346.8 88143.0 88350.0 89538.6 91185.6 13639.9 13871.9 13918.0 13926.6 14440.6 15207.6 15273.5 15412.2 15448.0 15582.8 13903.3 14031.6 14095.8 14398.4 14432.6 14069.3 14073.5 14168.6 14290.9 14644.6 13659.7 13783.4 14024.6 14185.3 14334.0 10265.6 10971.5 11589.6 11757.6 11798.9 9933.3 11514.9 11629.3 11639.5 11748.9 18:05:30 INFO - PROCESS | 1662 | -------- Summary: end -------- 18:05:30 INFO - PROCESS | 1662 | 18:05:30 INFO - TEST-INFO | 1662: exit 0 18:05:30 INFO - TEST-OK | dromaeo_css | took 1113858ms 18:05:30 INFO - TEST-START | kraken 18:05:30 INFO - operating with platform_type : mac_ 18:05:30 INFO - Initialising browser for kraken test... 18:05:30 INFO - TEST-INFO | started process 1674 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/T/tmpNgM4Hi/profile http://localhost:49273/getInfo.html) 18:05:33 INFO - PROCESS | 1674 | __metrics Screen width/height:1600/1200 18:05:33 INFO - PROCESS | 1674 | colorDepth:24 18:05:33 INFO - PROCESS | 1674 | Browser inner width/height: 1024/689 18:05:33 INFO - PROCESS | 1674 | __metrics 18:05:33 ERROR - PROCESS | 1674 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 18:05:34 INFO - TEST-INFO | 1674: exit 0 18:05:34 INFO - Browser initialized. 18:05:34 INFO - Running cycle 1/1 for kraken test... 18:05:34 INFO - TEST-INFO | started process 1676 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/T/tmpNgM4Hi/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:05:46 INFO - PROCESS | 1676 | RSS: Main: 254906368 18:05:46 INFO - PROCESS | 1676 | 18:05:48 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-beat-detection) 18:05:49 INFO - PROCESS | 1676 | RSS: Main: 267661312 18:05:49 INFO - PROCESS | 1676 | 18:05:52 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-dft) 18:05:52 INFO - PROCESS | 1676 | RSS: Main: 276480000 18:05:52 INFO - PROCESS | 1676 | 18:05:56 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-fft) 18:05:57 INFO - PROCESS | 1676 | RSS: Main: 279343104 18:05:57 INFO - PROCESS | 1676 | 18:05:59 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-oscillator) 18:05:59 INFO - PROCESS | 1676 | RSS: Main: 280743936 18:05:59 INFO - PROCESS | 1676 | 18:06:01 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49273/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:06:02 INFO - PROCESS | 1676 | RSS: Main: 281210880 18:06:02 INFO - PROCESS | 1676 | 18:06:05 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49273/tests/kraken/driver.html?testName=imaging-darkroom) 18:06:06 INFO - PROCESS | 1676 | RSS: Main: 281214976 18:06:06 INFO - PROCESS | 1676 | 18:06:09 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49273/tests/kraken/driver.html?testName=imaging-desaturate) 18:06:09 INFO - PROCESS | 1676 | RSS: Main: 280346624 18:06:09 INFO - PROCESS | 1676 | 18:06:12 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49273/tests/kraken/driver.html?testName=json-parse-financial) 18:06:13 INFO - PROCESS | 1676 | RSS: Main: 281616384 18:06:13 INFO - PROCESS | 1676 | 18:06:14 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49273/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:06:15 INFO - PROCESS | 1676 | RSS: Main: 282636288 18:06:15 INFO - PROCESS | 1676 | 18:06:17 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:06:18 INFO - PROCESS | 1676 | RSS: Main: 283119616 18:06:18 INFO - PROCESS | 1676 | 18:06:20 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:06:21 INFO - PROCESS | 1676 | RSS: Main: 283041792 18:06:21 INFO - PROCESS | 1676 | 18:06:23 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:06:24 INFO - PROCESS | 1676 | RSS: Main: 282595328 18:06:24 INFO - PROCESS | 1676 | 18:06:27 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:06:28 INFO - PROCESS | 1676 | RSS: Main: 283250688 18:06:28 INFO - PROCESS | 1676 | 18:06:29 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49273/tests/kraken/driver.html?testName=ai-astar) 18:06:30 INFO - PROCESS | 1676 | RSS: Main: 284241920 18:06:30 INFO - PROCESS | 1676 | 18:06:30 INFO - PROCESS | 1676 | __start_tp_report 18:06:30 INFO - PROCESS | 1676 | _x_x_mozilla_page_load 18:06:30 INFO - PROCESS | 1676 | _x_x_mozilla_page_load_details 18:06:30 INFO - PROCESS | 1676 | |i|pagename|runs| 18:06:30 INFO - PROCESS | 1676 | |0;ai-astar;105;118;107;116;119;117;115;117;117;116 18:06:30 INFO - PROCESS | 1676 | |1;audio-beat-detection;143;110;134;156;115;127;152;145;154;116 18:06:30 INFO - PROCESS | 1676 | |2;audio-dft;192;195;192;224;270;268;271;201;192;206 18:06:30 INFO - PROCESS | 1676 | |3;audio-fft;67;103;94;175;83;53;59;79;153;83 18:06:30 INFO - PROCESS | 1676 | |4;audio-oscillator;70;71;126;71;67;70;108;69;74;112 18:06:30 INFO - PROCESS | 1676 | |5;imaging-gaussian-blur;88;125;87;85;127;103;135;86;122;127 18:06:30 INFO - PROCESS | 1676 | |6;imaging-darkroom;149;147;95;94;95;95;104;95;95;96 18:06:30 INFO - PROCESS | 1676 | |7;imaging-desaturate;147;142;92;92;92;94;95;92;76;149 18:06:30 INFO - PROCESS | 1676 | |8;json-parse-financial;56;56;57;54;57;56;58;54;54;54 18:06:30 INFO - PROCESS | 1676 | |9;json-stringify-tinderbox;58;88;98;97;79;78;75;74;71;71 18:06:30 INFO - PROCESS | 1676 | |10;stanford-crypto-aes;88;84;89;82;85;87;87;84;87;83 18:06:30 INFO - PROCESS | 1676 | |11;stanford-crypto-ccm;144;161;145;135;136;173;157;157;138;153 18:06:30 INFO - PROCESS | 1676 | |12;stanford-crypto-pbkdf2;188;199;166;166;166;176;166;164;163;163 18:06:30 INFO - PROCESS | 1676 | |13;stanford-crypto-sha256-iterative;68;68;67;67;74;82;87;88;86;78 18:06:30 INFO - PROCESS | 1676 | __end_tp_report 18:06:30 INFO - PROCESS | 1676 | __start_cc_report 18:06:30 INFO - PROCESS | 1676 | _x_x_mozilla_cycle_collect,1039 18:06:30 INFO - PROCESS | 1676 | __end_cc_report 18:06:30 INFO - PROCESS | 1676 | __startTimestamp1470445590170__endTimestamp 18:06:30 INFO - PROCESS | 1676 | 18:06:30 INFO - PROCESS | 1676 | ------- Summary: start ------- 18:06:30 INFO - PROCESS | 1676 | Number of tests: 14 18:06:30 INFO - PROCESS | 1676 | 18:06:30 INFO - PROCESS | 1676 | [#0] ai-astar Cycles:10 Average:114.70 Median:117.00 stddev:4.74 (4.1%) stddev-sans-first:3.49 18:06:30 INFO - PROCESS | 1676 | Values: 105.0 118.0 107.0 116.0 119.0 117.0 115.0 117.0 117.0 116.0 18:06:30 INFO - PROCESS | 1676 | 18:06:30 INFO - PROCESS | 1676 | [#1] audio-beat-detection Cycles:10 Average:135.20 Median:144.00 stddev:17.34 (12.0%) stddev-sans-first:18.16 18:06:30 INFO - PROCESS | 1676 | Values: 143.0 110.0 134.0 156.0 115.0 127.0 152.0 145.0 154.0 116.0 18:06:30 INFO - PROCESS | 1676 | 18:06:30 INFO - PROCESS | 1676 | [#2] audio-dft Cycles:10 Average:221.10 Median:215.00 stddev:34.87 (16.2%) stddev-sans-first:35.36 18:06:30 INFO - PROCESS | 1676 | Values: 192.0 195.0 192.0 224.0 270.0 268.0 271.0 201.0 192.0 206.0 18:06:30 INFO - PROCESS | 1676 | 18:06:30 INFO - PROCESS | 1676 | [#3] audio-fft Cycles:10 Average:94.90 Median:73.00 stddev:39.74 (54.4%) stddev-sans-first:40.85 18:06:30 INFO - PROCESS | 1676 | Values: 67.0 103.0 94.0 175.0 83.0 53.0 59.0 79.0 153.0 83.0 18:06:30 INFO - PROCESS | 1676 | 18:06:30 INFO - PROCESS | 1676 | [#4] audio-oscillator Cycles:10 Average:83.80 Median:70.00 stddev:22.28 (31.8%) stddev-sans-first:23.07 18:06:30 INFO - PROCESS | 1676 | Values: 70.0 71.0 126.0 71.0 67.0 70.0 108.0 69.0 74.0 112.0 18:06:30 INFO - PROCESS | 1676 | 18:06:30 INFO - PROCESS | 1676 | [#5] imaging-gaussian-blur Cycles:10 Average:108.50 Median:110.00 stddev:20.58 (18.7%) stddev-sans-first:20.45 18:06:30 INFO - PROCESS | 1676 | Values: 88.0 125.0 87.0 85.0 127.0 103.0 135.0 86.0 122.0 127.0 18:06:30 INFO - PROCESS | 1676 | 18:06:30 INFO - PROCESS | 1676 | [#6] imaging-darkroom Cycles:10 Average:106.50 Median:95.00 stddev:22.06 (23.2%) stddev-sans-first:17.22 18:06:30 INFO - PROCESS | 1676 | Values: 149.0 147.0 95.0 94.0 95.0 95.0 104.0 95.0 95.0 96.0 18:06:30 INFO - PROCESS | 1676 | 18:06:30 INFO - PROCESS | 1676 | [#7] imaging-desaturate Cycles:10 Average:107.10 Median:92.00 stddev:27.41 (29.8%) stddev-sans-first:24.98 18:06:30 INFO - PROCESS | 1676 | Values: 147.0 142.0 92.0 92.0 92.0 94.0 95.0 92.0 76.0 149.0 18:06:30 INFO - PROCESS | 1676 | 18:06:30 INFO - PROCESS | 1676 | [#8] json-parse-financial Cycles:10 Average:55.60 Median:56.00 stddev:1.51 (2.7%) stddev-sans-first:1.59 18:06:30 INFO - PROCESS | 1676 | Values: 56.0 56.0 57.0 54.0 57.0 56.0 58.0 54.0 54.0 54.0 18:06:30 INFO - PROCESS | 1676 | 18:06:30 INFO - PROCESS | 1676 | [#9] json-stringify-tinderbox Cycles:10 Average:78.90 Median:78.50 stddev:12.37 (15.8%) stddev-sans-first:10.56 18:06:30 INFO - PROCESS | 1676 | Values: 58.0 88.0 98.0 97.0 79.0 78.0 75.0 74.0 71.0 71.0 18:06:30 INFO - PROCESS | 1676 | 18:06:30 INFO - PROCESS | 1676 | [#10] stanford-crypto-aes Cycles:10 Average:85.60 Median:87.00 stddev:2.32 (2.7%) stddev-sans-first:2.29 18:06:30 INFO - PROCESS | 1676 | Values: 88.0 84.0 89.0 82.0 85.0 87.0 87.0 84.0 87.0 83.0 18:06:30 INFO - PROCESS | 1676 | 18:06:30 INFO - PROCESS | 1676 | [#11] stanford-crypto-ccm Cycles:10 Average:149.90 Median:155.00 stddev:12.40 (8.0%) stddev-sans-first:12.96 18:06:30 INFO - PROCESS | 1676 | Values: 144.0 161.0 145.0 135.0 136.0 173.0 157.0 157.0 138.0 153.0 18:06:30 INFO - PROCESS | 1676 | 18:06:30 INFO - PROCESS | 1676 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.70 Median:166.00 stddev:12.34 (7.4%) stddev-sans-first:11.59 18:06:30 INFO - PROCESS | 1676 | Values: 188.0 199.0 166.0 166.0 166.0 176.0 166.0 164.0 163.0 163.0 18:06:30 INFO - PROCESS | 1676 | 18:06:30 INFO - PROCESS | 1676 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:76.50 Median:80.00 stddev:8.80 (11.0%) stddev-sans-first:8.78 18:06:30 INFO - PROCESS | 1676 | Values: 68.0 68.0 67.0 67.0 74.0 82.0 87.0 88.0 86.0 78.0 18:06:30 INFO - PROCESS | 1676 | -------- Summary: end -------- 18:06:30 INFO - PROCESS | 1676 | 18:06:30 INFO - TEST-INFO | 1676: exit 0 18:06:31 INFO - TEST-OK | kraken | took 60297ms 18:06:31 INFO - SUITE-END | took 1174s 18:06:31 INFO - Completed test suite (00:19:34) 18:06:31 INFO - javascript benchmark 18:06:31 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7465.918401401221, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3380.3070370574037, 3402.625711171771, 3408.539847120638, 3430.656934306569, 3432.365012472694, 5676.375598684152, 5699.7150142492865, 5707.714614269291, 5710.5717071219615, 5792.82621521355, 5725.513331366838, 5732.627379220347, 5821.126830975356, 5835.241418615585, 5836.2996440427105, 5162.354705661793, 5254.21186821976, 5285.762140703659, 5334.0, 5385.946140538584, 5399.595030372718, 5400.405955344929, 5441.755121019544, 5448.155535891943, 5461.1535212042, 5168.069747445458, 5197.974010129963, 5293.57651387888, 5308.071087559701, 5333.280007199037, 4237.4915010198665, 4363.956360436387, 5262.526372626482, 5276.234945932857, 5281.943611277759, 5184.351956005499, 5219.791208351699, 5238.188080847474, 5247.950409918031, 5251.527362537352, 5547.833564993057, 5620.4098569650005, 5659.320881494205, 5699.715014249271, 5738.77044918207, 6284.2458904931245, 6307.243130824285, 6315.052742088677, 6327.525435592349, 6331.905021424683, 6298.779542715983, 6299.5275354348605, 6314.179156709644, 6316.1788967434395, 6331.2719037310835, 4787.257975013878, 5782.971085144632, 5800.24596802413, 5908.645481271137, 5965.940340596582, 6317.14718513004, 6328.557001009977, 6336.081268216083, 6344.080108384258, 6347.650879201688, 6167.506599472121, 6228.065790131516, 6232.065190221412, 6237.688115594202, 6252.499800015988, 6154.846128846814, 6200.627962322275, 6221.626702397871, 6247.656378899113, 6363.109164716943, 6295.811125666238, 6324.43080122782, 6335.68321583919, 6338.524610654127, 6340.587861788969, 5677.659340439587, 5828.941710582924, 6279.7488100476385, 6312.368763123651, 6324.747010119636, 4928.802847886116, 4958.454569997298, 4972.030454061495, 5020.623453240948, 5081.618878584121, 4410.095930334273, 4479.193745125908, 4496.348029535764, 4513.661475389359, 4560.384348113029, 5660.830175094754, 5762.798302059407, 5781.132830075522, 5786.94213057864, 5846.356900740915, 5258.0, 6177.135201071854, 6287.245530536274, 6341.4292713656, 6344.524160687967, 4868.342773725572, 5800.564957628195, 5815.069588865761, 5818.389069147678, 5851.268591426072, 4667.836625718083, 4738.8341408050555, 4775.856724298276, 5319.749858783183, 5518.834434966958, 5521.69630670317, 6082.197745648207, 6219.906701399392, 6366.140571022853, 6389.808305750835, 6313.210848643919, 6324.083007963727, 6325.114483972339, 6329.367063293634, 6330.303666596763, 6331.05034244867, 6384.7446102157255, 6394.936050639434, 6396.0, 6450.580712253689, 6122.15420935445, 6125.693715314127, 6164.691765411621, 6189.04069869171, 6198.783042593668, 5566.554675625859, 6153.969230153821, 6202.968985155046, 6211.068339748893, 6224.315325314121, 6003.0695242237525, 6139.2325959255095, 6213.689315534115, 6220.098085777447, 6223.439890409885, 6117.3270940197435, 6127.264728232641, 6152.600080994721, 6211.223597050369, 6244.812655620157, 5943.970280148572, 6086.056661217518, 6129.754809807558, 6131.77428366204, 6131.901258721728, 6146.416090471398, 6189.967982924248, 6193.690315484298, 6228.657423841551, 6264.937350626436, 5895.557833162616, 5990.7903223386975, 6029.969850150721, 6126.66303353302, 6133.080037994337], "value": 5709.956682143307, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [502.5878779400891, 515.4948150812206, 540.3299908113938, 549.3819453115243, 569.1235497334106, 38403.03992400188, 41520.37719434207, 41649.583504164984, 41658.58341416585, 41729.0, 42398.15203695932, 42807.78596107023, 42840.78579607105, 42901.7854910725, 42908.0, 9598.520073996324, 9816.754581135494, 9819.36174148678, 9820.0, 9829.754256143582, 9699.854502182437, 9721.465319407429, 9758.707238782812, 9784.168345690625, 9796.265280103986, 9609.231261499099, 9729.805403891918, 9755.170810481117, 9777.755556111082, 9788.853167202462, 9654.806903861883, 9713.95143024284, 9767.755806104833, 9783.36408133469, 9787.608495660164, 9573.664921727775, 9613.759656008586, 9683.370580912218, 9779.951100244452, 9795.314327997043, 40202.39696404556, 40211.39682904759, 40265.79867100646, 40420.0, 40602.59397406047, 2633.591793272046, 3351.095204294851, 3372.853229901845, 3427.1089516725583, 3429.4855771634207, 29116.708832911612, 29769.553456698166, 30734.846325768453, 30789.230269243224, 31430.528542071886, 3105.9534106988413, 3160.478521044025, 3163.9209019774457, 3203.1511649412923, 3257.071734555664, 535119.3244033793, 538859.0, 538887.0, 541684.0, 547580.0, 62775.6861215691, 63024.684876575324, 63038.68480657659, 63247.0, 63253.0, 35243.29513409718, 36019.63980360215, 66107.33892661011, 66834.66582667055, 67126.98619041436, 16286.26711797972, 16572.419965301397, 16793.0, 16806.15969201535, 16827.74758378625, 12742.235465872078, 12781.041421893395, 12814.295213763333, 12822.935885320514, 12838.29389383593, 15253.161076140697, 18785.436436906915, 19482.0, 19544.72959257672, 19550.608987820164, 8014.438989270695, 8137.715179968791, 8140.947144820692, 8171.591420428955, 8206.466579672302, 885.2475395913422, 1030.5156576409076, 1042.0257059649252, 1070.7644318249972, 1076.311160857052, 23264.836758162364, 26133.738662613512, 30427.391452170832, 30488.08535743931, 31102.68897311043, 943.4480828715141, 1060.7719340341864, 1070.208046045936, 1088.2219213262556, 1162.2851946053286, 12470.875291247154, 12797.168184068007, 13417.798733019012, 15598.844011559966, 16148.35406583747, 624848.0, 727590.0, 729861.0, 734996.0, 735733.0, 59273.40726592679, 59454.40545594575, 59839.70080149572, 59897.70051149716, 59938.40061599328, 1378.1248906944163, 1402.2077526197666, 1448.7030158817417, 1580.7707882356995, 1634.2890842483557, 28439.293642381523, 29532.409351812414, 29744.405111898075, 30029.5495567571, 30553.847230763702, 50868.23697644464, 51114.74442627912, 51194.23208651948, 51204.74397627988, 51216.74391628018, 605954.0, 607153.0, 607901.0, 608743.0, 610072.0, 26923.057692980652, 26985.460290793682, 27292.31769205786, 27409.451810964067, 27717.861410692818, 47191.76404117957, 47518.52481475141, 47563.52436475591, 47735.761321193175, 48070.5192948066, 37374.439383409815, 38578.228435431694, 38876.0, 39276.803615981735, 39592.208155837296, 38531.80734096312, 38786.0, 38859.0, 39629.0, 40052.399214012396, 37676.05809854666, 38235.0, 38315.0, 38575.61424385833, 38888.611113888495, 24968.500629986935, 33077.338453231285, 33866.153346166546, 34327.0, 34618.65381346154, 23558.0, 25377.492450150523, 25686.8715656428, 25830.87084564565, 25851.0], "value": 20185.98994594567, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [379.4213823918524, 385.80131232415306, 389.0150041609832, 390.9765414075156, 415.21731536054546, 14691.412343506247, 20893.686594701074, 21011.159553617876, 21726.91365431728, 21744.89127554362, 20102.396928092145, 20443.591128177428, 20954.790452095476, 21518.462038449048, 21525.0, 5829.504492118164, 6108.297545782225, 6150.753969841201, 6161.599496032743, 6181.6600086995195, 5969.373215812342, 6009.09863520471, 6058.545609079315, 6101.145839582462, 6104.603200791934, 5918.112283157518, 6029.427204415595, 6032.487238584726, 6042.395760423967, 6045.425684559959, 5679.062954612505, 5935.317438494563, 5970.223870896777, 5991.940080599182, 6048.123022161806, 5849.327327357366, 5962.791302304398, 5965.194698715662, 5972.880542389172, 5978.013627751416, 24175.637365439532, 24179.91190396419, 25477.235682929542, 25908.74091259082, 26346.077887273852, 2281.7490076091617, 2401.3396316013063, 2876.6260386149665, 3002.6697063323018, 3032.5147976323683, 10180.949095254551, 10332.58669653213, 10917.0, 12566.560170394083, 12956.48174073036, 1773.3084097201972, 1801.1534578747967, 1855.202263026898, 1899.3067530351461, 1943.523836660013, 124921.0, 125667.0, 126063.10905336335, 128775.0, 130000.34999825036, 9649.649049132986, 11165.609203677996, 11457.026152777107, 11490.482928268248, 11660.183787134989, 14214.289285535682, 14608.926955365156, 14613.26933653313, 14642.633934151732, 14651.853481465261, 7240.818979525554, 8304.501729896225, 8573.828523429496, 8591.44155629882, 8717.084706105768, 8442.620082096197, 8518.0, 8559.786005349915, 8636.22273995331, 8701.47791132534, 4482.843100491467, 4501.639868810487, 4570.428696412949, 4574.817007319736, 4624.745638989821, 1907.6947688369794, 1970.6452838488922, 1973.4375702924597, 1977.8318842898227, 1978.7130866024345, 851.82537579796, 881.7619242804407, 912.8630705394244, 945.669015844449, 971.7764914069662, 20512.487187820425, 20640.27759028427, 21876.45308867259, 21923.561528769336, 22000.33998980033, 921.9673965159064, 939.178219058324, 957.8802649668792, 967.2552134856121, 1007.5919252702668, 10996.460495530631, 11323.716907077223, 11596.01433878113, 11642.708932276591, 11723.589674361527, 617501.0, 618953.0, 621913.0, 635910.0, 637409.0, 139529.0, 142147.28926355302, 145779.27110364594, 148653.25673371565, 150598.0, 974.4396971741277, 975.7414285214423, 992.5434300221834, 993.3940296419179, 1009.1674368645896, 18543.165557549673, 19441.222351106364, 19442.319518816774, 19534.511637209183, 19581.902090490028, 56377.43622563722, 58638.70680646569, 59060.0, 59239.40760592512, 59305.70347148237, 55601.77592896239, 83500.58249708713, 84487.0, 85645.0, 86597.56701216454, 6983.406410455168, 8021.398395120273, 8286.295664868554, 8311.95844020776, 8380.95809520973, 11653.359065251492, 11941.104417168573, 13097.214167150001, 13160.934195328962, 13493.865061349261, 8798.868016979879, 9398.20115290208, 10983.780324393307, 11270.380129092979, 11769.882301177222, 8843.717660939257, 9361.4383137012, 11096.389698566656, 11283.153763467608, 11507.482163302504, 11434.770219807058, 11612.245204062046, 11665.533378664759, 11791.351475668578, 11960.282383057045, 7979.162187970412, 8030.919690803017, 8297.336213103057, 8370.246677799027, 8375.706850260212, 8944.284457243535, 9058.864117038118, 11609.5356185755, 11610.477528511406, 11618.593349232737], "value": 9791.32765345616, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1527.5188315680557, 1583.2479572203206, 1771.291483406637, 1867.3930972433961, 1871.6911709567914, 7287.8542429151385, 7829.491083079596, 8254.91745082549, 8850.159234872694, 8855.778605534864, 8366.07973122956, 8559.400841941067, 8561.101084386128, 8571.871421928676, 8593.742187734379, 2339.2163625185585, 2372.4306166519996, 2376.66726658268, 2378.8334816562847, 2385.3678775124604, 1897.487678326851, 1952.4728323352685, 2366.503034362786, 2373.774491423312, 2376.869272190029, 2341.613633750429, 2377.8929948152377, 2378.3935096550354, 2380.595298799208, 2384.3085505203558, 2335.7664233576675, 2354.458474550854, 2364.18435639704, 2366.3610825077217, 2385.9642105368434, 2361.397843549901, 2362.055177928825, 2362.4212068043266, 2362.6337917622795, 2366.1363602285214, 8633.913660863436, 8711.520866352348, 8725.476471411735, 8735.475871447734, 8863.955680221623, 5202.92195617066, 5328.413874473805, 5362.195670649395, 5368.651037682577, 5378.650387724785, 3489.5638045244345, 3597.442396428558, 3684.7840212729734, 3692.593814680383, 3739.6447337502896, 972.2610815779988, 1075.3386667199616, 1102.9503672334765, 1118.3401792942202, 1126.4086354663784, 11340.603078892282, 11382.97553220206, 11488.310701357945, 11554.94222528882, 11564.90133437322, 4524.09518096382, 4594.931076033862, 4738.407699037621, 4776.95223047772, 4795.760211989456, 9745.269104817167, 9874.160696340892, 9887.950560247296, 9901.60393584263, 9903.702888913343, 5256.369235691742, 5280.6303558750515, 5288.709120998382, 5289.418164001957, 5308.495692909168, 3794.430835374716, 4666.719996800203, 4763.118823017753, 4804.111239420718, 4849.830255941025, 3915.784631845219, 3919.2161567686007, 4017.2568074906235, 4034.495688038995, 4035.475388199574, 1293.2369901758009, 1301.3493253373313, 1302.3813688497887, 1311.1608570514877, 1317.1965101288206, 894.6645008121955, 935.3639525122845, 937.9249660027182, 949.7957939043139, 963.8650588917557, 5663.122216056436, 5847.122931560215, 5895.793647222326, 5896.056630939029, 5973.1936188614845, 433.741923555484, 434.433064850367, 444.7968245894847, 451.43119669216367, 452.0236289614417, 3484.77348972316, 3550.680438760524, 3821.560520540118, 3915.432262322004, 3936.15372694872, 10099.343542669703, 10480.423576703355, 10544.420056896945, 10555.894441055645, 10557.788844223072, 10219.437930913722, 10424.739381515523, 10503.159747220205, 10520.368777873353, 10529.0, 7135.607541585263, 7375.704971801175, 7990.520568765893, 8117.756467305991, 8168.714095006765, 4554.360430245175, 5080.568151706999, 5405.243265942692, 5731.455511726379, 5871.706414679335, 9861.915189329025, 9914.454704991007, 9934.503274836374, 9954.153896918842, 9967.40195588267, 9493.0981556752, 9741.172000380047, 9870.161036311707, 9870.555824987749, 9893.208543316661, 7448.404127669665, 7891.960540197492, 7936.246056624612, 7971.043474783063, 8171.060328062111, 8207.261346478846, 8376.958115209629, 8382.664693412195, 8388.664453421794, 8397.992240931128, 7298.56208627484, 7379.151397589346, 7498.737544185928, 7499.400047996038, 7568.091828980558, 7238.710451581877, 7338.853222935618, 7358.558486490828, 7391.186969433251, 7453.664585093792, 6988.965055174895, 7004.474664400089, 7023.403010744144, 7083.114610673666, 7097.25478824716, 4896.804127834846, 4910.386201724785, 5007.47421520735, 5008.874778130576, 5129.79480820763, 4920.015996800583, 4985.775640096132, 5103.10695628271, 5181.35233095863, 5201.193814958688], "value": 4471.28814447592, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [256.6304521489056, 294.70382265822843, 316.0408161230665, 317.7108830963822, 318.3839271010594, 4516.616087632547, 4567.794449249784, 5332.520073193412, 5571.0, 5657.0948648216345, 5003.599712023039, 5274.4198138204765, 5326.520613144816, 5557.194206840006, 5580.720963951807, 4014.678825693952, 4294.0, 4310.97844510777, 4312.116016216683, 4312.404410368168, 3740.9812950935207, 4258.041940563379, 4319.524852266264, 4340.804663790122, 4350.825966961318, 3567.7859328440245, 3672.9081772955624, 4078.388241763744, 4252.170826688797, 4263.4031235627035, 3565.0374398912277, 3707.94438083429, 3780.8298626561595, 4257.787110644455, 4266.146770645883, 3722.1253005543676, 3726.7018638508853, 3739.196072844324, 3740.9438858417147, 3753.6434038766274, 5083.237514372837, 5166.475889612573, 5308.283381743454, 5397.0, 5422.129365368942, 4945.208766597327, 4957.3059771632, 4962.3548938638105, 4969.503049695038, 4998.150314446553, 5404.83785486436, 5761.855953601152, 5920.319163296233, 5947.910781338283, 5959.40405959405, 3252.8861489847977, 4058.8376464941366, 4086.9386959195635, 4092.7135100542973, 4094.508658960914, 4895.971845912362, 6126.877462450726, 6148.6618235997, 6189.288231853305, 6248.125262463259, 3645.5078564393466, 3831.4635950966886, 4149.751014939114, 4166.562510936369, 4186.539480657125, 4112.712110152321, 4134.37984302357, 4205.002623753692, 4222.725522841067, 4234.597713217239, 4877.975610121997, 4880.048390563877, 4886.828960986349, 4907.944791869693, 4913.385826771653, 5838.283138823409, 5923.696786706918, 5924.437178468039, 6004.489618382487, 6006.729697163638, 1410.4851729118798, 1431.591996281055, 1446.3491428857055, 1449.6593300574357, 1454.8254209494928, 867.6139118092389, 885.274075258282, 895.583553647557, 903.3089686389917, 904.9819003620022, 4094.8566800161852, 4496.6177874881005, 4519.638428925678, 4639.608117564784, 4688.835890743808, 5128.3076784633595, 5169.663971841894, 5177.870553236124, 5178.974105129526, 5185.714785686748, 4204.978975105166, 4316.611504964569, 4364.432623758891, 4502.842400515966, 4657.510961349078, 2624.5827253283396, 2898.550724637681, 3182.347618738153, 3246.9837650811596, 3251.6260630027377, 5462.8361149165585, 5654.547636189095, 6086.908696369558, 6316.336784637547, 6345.238571371465, 5334.986352592995, 5862.648241105548, 6187.257529096537, 6283.8114856554375, 6312.74893429884, 6295.811125666329, 6320.71556779946, 6376.362363763679, 6405.743770249231, 6433.806985790434, 5956.711167959063, 6181.381861813783, 6195.349488303663, 6206.293269350965, 6210.546834000635, 5399.0, 6090.878182436415, 6096.512279017757, 6103.42017508336, 6124.785632503019, 5503.2114562766465, 5791.942080579141, 6414.518911081781, 6415.262244841716, 6421.486281097407, 3888.5806680560827, 3949.881503554898, 3991.2217117661776, 4010.9744578987425, 4029.758214507022, 5324.707141107277, 5605.467480589337, 6131.130005348412, 6175.59858609189, 6193.597416167935, 4486.91026179468, 5581.10702287632, 5641.871625674799, 5770.538004673894, 5979.624686322083, 5844.649321040752, 5903.527717782481, 5974.522038236843, 5989.023622204749, 6015.819525414245, 5003.123204157697, 5882.352941176553, 5883.35283118848, 5894.823155305347, 5897.587168898136, 5186.0, 5670.234518340137, 5906.940930590639, 5975.193348897843, 5986.491148252448, 5520.006398848246, 5529.529989950899, 5834.970825146017, 5838.474537291664, 5861.479563787442], "value": 4252.720065065866, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [726.8280072384514, 742.9814254643636, 771.8147644565306, 803.1526739290049, 809.8299357135003, 15153.39386424543, 15504.612384690388, 15791.0, 15849.603759906007, 15883.602909927258, 14421.63945901353, 14487.203203823785, 14487.275636218174, 14500.0, 14505.564833055025, 701.0885848397089, 732.8351120997786, 853.9444936079151, 895.2882458445519, 895.6327905558722, 901.8016036471965, 902.5171533229724, 903.2954295649404, 904.2043002158125, 905.0316161706976, 935.3592788939565, 939.9013103624123, 941.1247539787994, 942.8632848237002, 950.3775027357092, 920.5443305563755, 943.4009404028423, 943.6414162618161, 945.2910317262019, 946.0728486083608, 675.1526833823569, 707.7063018847173, 708.2881703887612, 709.904162938002, 710.254233055295, 13231.801522977163, 14839.0, 14849.812015038771, 15225.923870380577, 15242.390304387922, 14880.851191488055, 14923.403063877431, 14937.701245975128, 14938.775918361232, 14998.62503437412, 11855.94072029643, 12052.457639406248, 12191.833781064433, 12350.38248087592, 12571.874281257162, 3855.6722678572355, 3861.716053790311, 3952.980235098806, 4060.7360521566, 4085.162541678949, 123269.38365308206, 124155.0, 127907.0, 128483.35758321149, 128569.35715321457, 11159.888401116048, 11472.655820325404, 11595.652130436101, 11755.529778808752, 11939.223950443193, 23984.52030959371, 24048.87975560146, 24234.515309693707, 24478.877605612215, 24548.895299711556, 7857.921420785833, 8136.715214967566, 8202.38482113844, 8330.250277475056, 8382.58087095655, 4456.131054444417, 4503.659035771671, 4542.517125160373, 4548.4541854977615, 4559.156556037144, 3590.3716849551224, 3644.1800594865945, 3665.9633403666157, 3698.260347930425, 3722.236941427001, 629.9055141728686, 655.5509476008949, 661.272600139852, 666.7299743603849, 672.5695554844904, 641.2881701311541, 667.7896462614261, 692.4287462843074, 707.6037419045351, 722.5339655922006, 9289.674861379819, 9713.61145554184, 9770.462624555576, 9942.751431214132, 10095.192384609214, 620.7672122953892, 620.7672122953892, 624.3382015063955, 655.6557807151188, 667.89981502774, 4060.519463708762, 4388.210122177975, 4453.933191002137, 4483.789376868227, 4718.292256161603, 131288.3435582835, 133649.0, 135630.0, 147748.261258693, 179492.0, 130384.348078259, 130496.0, 132031.33984330017, 133981.66018339692, 134639.98040029407, 89847.55076224708, 111474.0, 111554.0, 111686.88313116765, 120047.0, 9144.222741067084, 10118.13995810335, 10139.695809125738, 10163.44101074448, 10175.389476631426, 52607.73696131495, 56173.595660108826, 62638.0, 64411.0, 65887.67056164688, 86346.81919084875, 88143.0, 88350.0, 89538.55230723805, 91185.63221551549, 13639.931800340935, 13871.930640346734, 13918.0, 13926.58220253394, 14440.566782996528, 15207.5667893141, 15273.539560023153, 15412.229388530304, 15448.0, 15582.844171558592, 13903.304834758424, 14031.649208769863, 14095.788563171765, 14398.352074156479, 14432.639184020483, 14069.296535173406, 14073.507427240407, 14168.645783855485, 14290.857091428952, 14644.633884152556, 13659.658508536968, 13783.379747911167, 14024.649383765487, 14185.290735463392, 14333.990006004187, 10265.640702575374, 10971.506282217479, 11589.594364197214, 11757.62699221754, 11798.941005294919, 9933.304668673123, 11514.88485115138, 11629.253296335906, 11639.47622357013, 11748.941255293668], "value": 8069.182948611829, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1590.0, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 118.0, 107.0, 116.0, 119.0, 117.0, 115.0, 117.0, 117.0, 116.0], "value": 114.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 110.0, 134.0, 156.0, 115.0, 127.0, 152.0, 145.0, 154.0, 116.0], "value": 135.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [192.0, 195.0, 192.0, 224.0, 270.0, 268.0, 271.0, 201.0, 192.0, 206.0], "value": 221.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 103.0, 94.0, 175.0, 83.0, 53.0, 59.0, 79.0, 153.0, 83.0], "value": 94.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 71.0, 126.0, 71.0, 67.0, 70.0, 108.0, 69.0, 74.0, 112.0], "value": 83.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 125.0, 87.0, 85.0, 127.0, 103.0, 135.0, 86.0, 122.0, 127.0], "value": 108.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 147.0, 95.0, 94.0, 95.0, 95.0, 104.0, 95.0, 95.0, 96.0], "value": 106.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 142.0, 92.0, 92.0, 92.0, 94.0, 95.0, 92.0, 76.0, 149.0], "value": 107.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 56.0, 57.0, 54.0, 57.0, 56.0, 58.0, 54.0, 54.0, 54.0], "value": 55.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 88.0, 98.0, 97.0, 79.0, 78.0, 75.0, 74.0, 71.0, 71.0], "value": 78.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 84.0, 89.0, 82.0, 85.0, 87.0, 87.0, 84.0, 87.0, 83.0], "value": 85.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 161.0, 145.0, 135.0, 136.0, 173.0, 157.0, 157.0, 138.0, 153.0], "value": 149.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [188.0, 199.0, 166.0, 166.0, 166.0, 176.0, 166.0, 164.0, 163.0, 163.0], "value": 171.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 68.0, 67.0, 67.0, 74.0, 82.0, 87.0, 88.0, 86.0, 78.0], "value": 76.5, "unit": "score"}]}]} 18:06:31 INFO - Return code: 0 18:06:31 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 18:06:31 ERROR - # TBPL SUCCESS # 18:06:31 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 18:06:31 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 18:06:31 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 18:06:31 INFO - 2016-08-05 18:06:31.460 screenresolution[1681:10320] starting screenresolution argv=screenresolution get 18:06:31 INFO - 2016-08-05 18:06:31.463 screenresolution[1681:10320] Display 0: 1600x1200x32@60 18:06:31 INFO - 2016-08-05 18:06:31.468 screenresolution[1682:10323] starting screenresolution argv=screenresolution list 18:06:31 INFO - Available Modes on Display 0 18:06:31 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 18:06:31 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 18:06:31 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 18:06:31 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 18:06:31 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 18:06:31 INFO - Intel Iris: 18:06:31 INFO - Chipset Model: Intel Iris 18:06:31 INFO - Type: GPU 18:06:31 INFO - Bus: Built-In 18:06:31 INFO - VRAM (Dynamic, Max): 1536 MB 18:06:31 INFO - Vendor: Intel (0x8086) 18:06:31 INFO - Device ID: 0x0a2e 18:06:31 INFO - Revision ID: 0x0009 18:06:31 INFO - Displays: 18:06:31 INFO - Display: 18:06:31 INFO - Resolution: 1600 x 1200 @ 60 Hz 18:06:31 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 18:06:31 INFO - Display Serial Number: 1600x1200 60 18:06:31 INFO - Main Display: Yes 18:06:31 INFO - Mirror: Off 18:06:31 INFO - Online: Yes 18:06:31 INFO - Rotation: Supported 18:06:31 INFO - Return code: 0 18:06:31 INFO - Running post-action listener: _resource_record_post_action 18:06:31 INFO - [mozharness: 2016-08-06 01:06:31.703427Z] Finished run-tests step (success) 18:06:31 INFO - Running post-run listener: _resource_record_post_run 18:06:31 INFO - Total resource usage - Wall time: 1209s; CPU: 55.0%; Read bytes: 37176320; Write bytes: 705051136; Read time: 237; Write time: 1940 18:06:31 INFO - TinderboxPrint: CPU usage
54.5% 18:06:31 INFO - TinderboxPrint: I/O read bytes / time
37,176,320 / 237 18:06:31 INFO - TinderboxPrint: I/O write bytes / time
705,051,136 / 1,940 18:06:31 INFO - TinderboxPrint: CPU idle
2,198.7 (45.5%) 18:06:31 INFO - TinderboxPrint: CPU system
978.4 (20.2%) 18:06:31 INFO - TinderboxPrint: CPU user
1,660.6 (34.3%) 18:06:31 INFO - TinderboxPrint: Swap in / out
444,043,264 / 0 18:06:31 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 407861760; Write bytes: 409486848; Read time: 29868; Write time: 829 18:06:31 INFO - run-tests - Wall time: 1175s; CPU: 55.0%; Read bytes: 34518016; Write bytes: 293946368; Read time: 214; Write time: 1102 18:06:32 INFO - Running post-run listener: _upload_blobber_files 18:06:32 INFO - Blob upload gear active. 18:06:32 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:06:32 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 18:06:32 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', 'Autoland', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 18:06:32 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 Autoland -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 18:06:32 INFO - (blobuploader) - INFO - Open directory for files ... 18:06:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 18:06:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:06:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:06:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 18:06:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:06:33 INFO - (blobuploader) - INFO - Done attempting. 18:06:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 18:06:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:06:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:06:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 18:06:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:06:34 INFO - (blobuploader) - INFO - Done attempting. 18:06:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 18:06:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:06:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:06:37 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 18:06:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:06:37 INFO - (blobuploader) - INFO - Done attempting. 18:06:37 INFO - (blobuploader) - INFO - Iteration through files over. 18:06:37 INFO - Return code: 0 18:06:37 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:06:37 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:06:37 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/667962a06c762e0a8dcdb80a46883d0d94f6f381f45a21147b747c0d0dfa9487582afb04bfd632a3818d24c4350df2f0c3f28f04b6492f113589b10b22019382", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/273aaab5dfcc13231f3fcb59666d42596273ec2c084f615910b3b76b25cfd9d553a95d0cd48b5f8554caaca9d70bba016f6549bf198b40e141b3f71d2c383ca2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/c9209d9a9798b69bab1f6b1ac28e79dea0970f05cf9d53e9cd2e0ab1284907ccefee90031eb56b1c49f3b4a7c54958bf272089bf4d58f8c5ab26c3f42120bc26"} 18:06:37 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:06:37 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:06:37 INFO - Contents: 18:06:37 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/667962a06c762e0a8dcdb80a46883d0d94f6f381f45a21147b747c0d0dfa9487582afb04bfd632a3818d24c4350df2f0c3f28f04b6492f113589b10b22019382", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/273aaab5dfcc13231f3fcb59666d42596273ec2c084f615910b3b76b25cfd9d553a95d0cd48b5f8554caaca9d70bba016f6549bf198b40e141b3f71d2c383ca2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/c9209d9a9798b69bab1f6b1ac28e79dea0970f05cf9d53e9cd2e0ab1284907ccefee90031eb56b1c49f3b4a7c54958bf272089bf4d58f8c5ab26c3f42120bc26"} 18:06:37 INFO - Running post-run listener: copy_logs_to_upload_dir 18:06:37 INFO - Copying logs to upload dir... 18:06:37 INFO - mkdir: /builds/slave/test/build/upload/logs 18:06:37 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1263.282632 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2016-08-05 18:06:37.087687) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-05 18:06:37.091224) ========= 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.q1KuuMK0Aa/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.xwUu34LewB/Listeners TMPDIR=/var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/667962a06c762e0a8dcdb80a46883d0d94f6f381f45a21147b747c0d0dfa9487582afb04bfd632a3818d24c4350df2f0c3f28f04b6492f113589b10b22019382", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/273aaab5dfcc13231f3fcb59666d42596273ec2c084f615910b3b76b25cfd9d553a95d0cd48b5f8554caaca9d70bba016f6549bf198b40e141b3f71d2c383ca2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/c9209d9a9798b69bab1f6b1ac28e79dea0970f05cf9d53e9cd2e0ab1284907ccefee90031eb56b1c49f3b4a7c54958bf272089bf4d58f8c5ab26c3f42120bc26"} build_url:https://queue.taskcluster.net/v1/task/UyzA1WRmSp2igr7llMdS3Q/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011315 build_url: 'https://queue.taskcluster.net/v1/task/UyzA1WRmSp2igr7llMdS3Q/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/667962a06c762e0a8dcdb80a46883d0d94f6f381f45a21147b747c0d0dfa9487582afb04bfd632a3818d24c4350df2f0c3f28f04b6492f113589b10b22019382", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/273aaab5dfcc13231f3fcb59666d42596273ec2c084f615910b3b76b25cfd9d553a95d0cd48b5f8554caaca9d70bba016f6549bf198b40e141b3f71d2c383ca2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/c9209d9a9798b69bab1f6b1ac28e79dea0970f05cf9d53e9cd2e0ab1284907ccefee90031eb56b1c49f3b4a7c54958bf272089bf4d58f8c5ab26c3f42120bc26"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-05 18:06:37.124563) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-05 18:06:37.124917) ========= 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.q1KuuMK0Aa/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.xwUu34LewB/Listeners TMPDIR=/var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/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.005357 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-05 18:06:37.174156) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-05 18:06:37.174506) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-05 18:06:37.174850) ========= ========= Total master_lag: 0.17 =========