builder: autoland_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0314 starttime: 1470692794.23 results: success (0) buildid: 20160808134626 builduid: 3fdc67fcb1e946c9a03e4bf2a8c4497f revision: 98ad8d33b747018425edb486f8345a7c4c1d47cc ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-08 14:46:34.235039) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-08 14:46:34.235462) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-08 14:46:34.235786) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-08 14:46:34.278964) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-08 14:46:34.279220) ========= 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.k8xXNNJHNU/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.UncfaQmDPK/Listeners TMPDIR=/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/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-08 14:46:34-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 165M=0s 2016-08-08 14:46:34 (165 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.444760 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-08 14:46:34.748857) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-08 14:46:34.749153) ========= 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.k8xXNNJHNU/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.UncfaQmDPK/Listeners TMPDIR=/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/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.020409 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-08 14:46:34.797859) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-08 14:46:34.798234) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev 98ad8d33b747018425edb486f8345a7c4c1d47cc --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 98ad8d33b747018425edb486f8345a7c4c1d47cc --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.k8xXNNJHNU/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.UncfaQmDPK/Listeners TMPDIR=/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/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-08 14:46:34,878 truncating revision to first 12 chars 2016-08-08 14:46:34,879 Setting DEBUG logging. 2016-08-08 14:46:34,879 attempt 1/10 2016-08-08 14:46:34,879 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/98ad8d33b747?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-08 14:46:36,057 unpacking tar archive at: autoland-98ad8d33b747/testing/mozharness/ program finished with exit code 0 elapsedTime=1.456387 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-08 14:46:36.277196) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-08 14:46:36.277603) ========= script_repo_revision: 98ad8d33b747018425edb486f8345a7c4c1d47cc ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-08 14:46:36.278053) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-08 14:46:36.278419) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-08 14:46:36.296561) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2016-08-08 14:46:36.296874) ========= /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.k8xXNNJHNU/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.UncfaQmDPK/Listeners TMPDIR=/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/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 14:46:36 INFO - MultiFileLogger online at 20160808 14:46:36 in /builds/slave/test 14:46:36 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 14:46:36 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:46:36 INFO - {'append_to_log': False, 14:46:36 INFO - 'base_work_dir': '/builds/slave/test', 14:46:36 INFO - 'blob_upload_branch': 'Autoland', 14:46:36 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:46:36 INFO - 'branch': 'Autoland', 14:46:36 INFO - 'buildbot_json_path': 'buildprops.json', 14:46:36 INFO - 'config_files': ('talos/mac_config.py',), 14:46:36 INFO - 'default_actions': ('clobber', 14:46:36 INFO - 'read-buildbot-config', 14:46:36 INFO - 'download-and-extract', 14:46:36 INFO - 'populate-webroot', 14:46:36 INFO - 'create-virtualenv', 14:46:36 INFO - 'install', 14:46:36 INFO - 'run-tests'), 14:46:36 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:46:36 INFO - 'download_minidump_stackwalk': True, 14:46:36 INFO - 'download_symbols': 'ondemand', 14:46:36 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:46:36 INFO - 'tooltool.py': '/tools/tooltool.py', 14:46:36 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:46:36 INFO - '/tools/misc-python/virtualenv.py')}, 14:46:36 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:46:36 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:46:36 INFO - 'installer_path': 'installer.exe', 14:46:36 INFO - 'log_level': 'info', 14:46:36 INFO - 'log_name': 'talos', 14:46:36 INFO - 'log_to_console': True, 14:46:36 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 14:46:36 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 14:46:36 INFO - 'opt_config_files': (), 14:46:36 INFO - 'pip_index': False, 14:46:36 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:46:36 INFO - 'cmd': ('bash', 14:46:36 INFO - '-c', 14:46:36 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:46:36 INFO - 'enabled': True, 14:46:36 INFO - 'halt_on_failure': False, 14:46:36 INFO - 'name': 'check_screen_resolution'},), 14:46:36 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:46:36 INFO - 'cmd': ('bash', 14:46:36 INFO - '-c', 14:46:36 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:46:36 INFO - 'enabled': True, 14:46:36 INFO - 'halt_on_failure': False, 14:46:36 INFO - 'name': 'check_screen_resolution'},), 14:46:36 INFO - 'run_cmd_checks_enabled': True, 14:46:36 INFO - 'sps_profile': False, 14:46:36 INFO - 'sps_profile_interval': 0, 14:46:36 INFO - 'suite': 'dromaeojs-e10s', 14:46:36 INFO - 'system_bits': '32', 14:46:36 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:46:36 INFO - 'title': 't-yosemite-r7-0314', 14:46:36 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:46:36 INFO - 'use_talos_json': True, 14:46:36 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:46:36 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:46:36 INFO - 'work_dir': 'build'} 14:46:36 INFO - [mozharness: 2016-08-08 21:46:36.480747Z] Running clobber step. 14:46:36 INFO - Running pre-action listener: _resource_record_pre_action 14:46:36 INFO - Running main action method: clobber 14:46:36 INFO - rmtree: /builds/slave/test/build 14:46:36 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:46:37 INFO - Running post-action listener: _resource_record_post_action 14:46:37 INFO - [mozharness: 2016-08-08 21:46:37.382861Z] Finished clobber step (success) 14:46:37 INFO - [mozharness: 2016-08-08 21:46:37.383012Z] Running read-buildbot-config step. 14:46:37 INFO - Running pre-action listener: _resource_record_pre_action 14:46:37 INFO - Running main action method: read_buildbot_config 14:46:37 INFO - Using buildbot properties: 14:46:37 INFO - { 14:46:37 INFO - "project": "", 14:46:37 INFO - "product": "firefox", 14:46:37 INFO - "script_repo_revision": "production", 14:46:37 INFO - "builddir": "autoland_yosemite_r7_test-dromaeojs-e10s", 14:46:37 INFO - "repository": "", 14:46:37 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 autoland talos dromaeojs-e10s", 14:46:37 INFO - "buildid": "20160808134626", 14:46:37 INFO - "pgo_build": "False", 14:46:37 INFO - "basedir": "/builds/slave/test", 14:46:37 INFO - "buildnumber": 87, 14:46:37 INFO - "slavename": "t-yosemite-r7-0314", 14:46:37 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 14:46:37 INFO - "platform": "yosemite_r7", 14:46:37 INFO - "scheduler": "tests-autoland-macosx64-talos", 14:46:37 INFO - "branch": "autoland", 14:46:37 INFO - "repo_path": "integration/autoland", 14:46:37 INFO - "revision": "98ad8d33b747018425edb486f8345a7c4c1d47cc", 14:46:37 INFO - "stage_platform": "macosx64", 14:46:37 INFO - "builduid": "3fdc67fcb1e946c9a03e4bf2a8c4497f", 14:46:37 INFO - "slavebuilddir": "test" 14:46:37 INFO - } 14:46:37 INFO - Found installer url https://queue.taskcluster.net/v1/task/Ra5Kb7uNSmSLYBf66CBAWQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg. 14:46:37 INFO - Running post-action listener: _resource_record_post_action 14:46:37 INFO - [mozharness: 2016-08-08 21:46:37.386314Z] Finished read-buildbot-config step (success) 14:46:37 INFO - [mozharness: 2016-08-08 21:46:37.386431Z] Running download-and-extract step. 14:46:37 INFO - Running pre-action listener: _resource_record_pre_action 14:46:37 INFO - Running main action method: download_and_extract 14:46:37 INFO - mkdir: /builds/slave/test/build/tests 14:46: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')]} 14:46:37 INFO - trying https://queue.taskcluster.net/v1/task/Ra5Kb7uNSmSLYBf66CBAWQ/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json 14:46:37 INFO - Downloading https://queue.taskcluster.net/v1/task/Ra5Kb7uNSmSLYBf66CBAWQ/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 14:46:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Ra5Kb7uNSmSLYBf66CBAWQ/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 14:46:38 INFO - Downloaded 1199 bytes. 14:46:38 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 14:46:38 INFO - Using the following test package requirements: 14:46:38 INFO - {u'common': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 14:46:38 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 14:46:38 INFO - u'firefox-51.0a1.en-US.mac.cppunittest.tests.zip'], 14:46:38 INFO - u'gtest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 14:46:38 INFO - u'firefox-51.0a1.en-US.mac.gtest.tests.zip'], 14:46:38 INFO - u'jittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 14:46:38 INFO - u'jsshell-mac.zip'], 14:46:38 INFO - u'mochitest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 14:46:38 INFO - u'firefox-51.0a1.en-US.mac.mochitest.tests.zip'], 14:46:38 INFO - u'mozbase': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 14:46:38 INFO - u'reftest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 14:46:38 INFO - u'firefox-51.0a1.en-US.mac.reftest.tests.zip'], 14:46:38 INFO - u'talos': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 14:46:38 INFO - u'firefox-51.0a1.en-US.mac.talos.tests.zip'], 14:46:38 INFO - u'web-platform': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 14:46:38 INFO - u'firefox-51.0a1.en-US.mac.web-platform.tests.zip'], 14:46:38 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 14:46:38 INFO - u'firefox-51.0a1.en-US.mac.xpcshell.tests.zip']} 14:46:38 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip'] for test suite category: common 14:46:38 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')]} 14:46:38 INFO - trying https://queue.taskcluster.net/v1/task/Ra5Kb7uNSmSLYBf66CBAWQ/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 14:46:38 INFO - Downloading https://queue.taskcluster.net/v1/task/Ra5Kb7uNSmSLYBf66CBAWQ/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 14:46:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Ra5Kb7uNSmSLYBf66CBAWQ/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 14:46:39 INFO - Downloaded 16324224 bytes. 14:46: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'] 14:46: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 14:46:42 INFO - Return code: 0 14:46: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 14:46: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')]} 14:46:42 INFO - trying https://queue.taskcluster.net/v1/task/Ra5Kb7uNSmSLYBf66CBAWQ/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 14:46:42 INFO - Downloading https://queue.taskcluster.net/v1/task/Ra5Kb7uNSmSLYBf66CBAWQ/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 14:46:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Ra5Kb7uNSmSLYBf66CBAWQ/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 14:46:43 INFO - Downloaded 16324224 bytes. 14:46: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'] 14:46: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 14:46:47 INFO - Return code: 0 14:46:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:46:47 INFO - trying https://queue.taskcluster.net/v1/task/Ra5Kb7uNSmSLYBf66CBAWQ/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip 14:46:47 INFO - Downloading https://queue.taskcluster.net/v1/task/Ra5Kb7uNSmSLYBf66CBAWQ/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 14:46:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Ra5Kb7uNSmSLYBf66CBAWQ/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 14:46:48 INFO - Downloaded 14413723 bytes. 14:46:48 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'] 14:46:48 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 14:46:48 INFO - Return code: 0 14:46: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')]} 14:46:48 INFO - trying https://queue.taskcluster.net/v1/task/Ra5Kb7uNSmSLYBf66CBAWQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 14:46:48 INFO - Downloading https://queue.taskcluster.net/v1/task/Ra5Kb7uNSmSLYBf66CBAWQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg 14:46:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Ra5Kb7uNSmSLYBf66CBAWQ/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 14:46:59 INFO - Downloaded 111977579 bytes. 14:46:59 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Ra5Kb7uNSmSLYBf66CBAWQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 14:46:59 INFO - mkdir: /builds/slave/test/properties 14:46:59 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:46:59 INFO - Writing to file /builds/slave/test/properties/build_url 14:46:59 INFO - Contents: 14:46:59 INFO - build_url:https://queue.taskcluster.net/v1/task/Ra5Kb7uNSmSLYBf66CBAWQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 14:47:00 INFO - Running post-action listener: _resource_record_post_action 14:47:00 INFO - Running post-action listener: set_extra_try_arguments 14:47:00 INFO - [mozharness: 2016-08-08 21:47:00.692285Z] Finished download-and-extract step (success) 14:47:00 INFO - [mozharness: 2016-08-08 21:47:00.692411Z] Running populate-webroot step. 14:47:00 INFO - Running pre-action listener: _resource_record_pre_action 14:47:00 INFO - Running main action method: populate_webroot 14:47:00 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:47:00 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:47:00 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:47:00 INFO - '--tppagecycles', 14:47:00 INFO - '7'], 14:47:00 INFO - 'tests': ['tsvgm']}}, 14:47:00 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:47:00 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:47:00 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:47:00 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:47:00 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:47:00 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:47:00 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:47:00 INFO - 'talos_options': ['--disable-e10s'], 14:47:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:47:00 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:47:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:47:00 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:47:00 INFO - 'talos_options': ['--disable-e10s'], 14:47:00 INFO - 'tests': ['damp', 'tps']}, 14:47:00 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:47:00 INFO - 'tests': ['damp', 'tps']}, 14:47:00 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:47:00 INFO - 'tests': ['dromaeo_dom']}, 14:47:00 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:47:00 INFO - 'g4': {'talos_options': ['--disable-e10s'], 14:47:00 INFO - 'tests': ['basic_compositor_video']}, 14:47:00 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 14:47:00 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:47:00 INFO - 'tests': ['a11yr', 14:47:00 INFO - 'ts_paint', 14:47:00 INFO - 'tpaint', 14:47:00 INFO - 'sessionrestore', 14:47:00 INFO - 'sessionrestore_no_auto_restore', 14:47:00 INFO - 'tabpaint']}, 14:47:00 INFO - 'other-e10s': {'tests': ['a11yr', 14:47:00 INFO - 'ts_paint', 14:47:00 INFO - 'tpaint', 14:47:00 INFO - 'sessionrestore', 14:47:00 INFO - 'sessionrestore_no_auto_restore', 14:47:00 INFO - 'tabpaint']}, 14:47:00 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:47:00 INFO - 'ts_paint', 14:47:00 INFO - 'tpaint', 14:47:00 INFO - 'sessionrestore', 14:47:00 INFO - 'sessionrestore_no_auto_restore', 14:47:00 INFO - 'tabpaint']}, 14:47:00 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:47:00 INFO - 'ts_paint', 14:47:00 INFO - 'tpaint', 14:47:00 INFO - 'sessionrestore', 14:47:00 INFO - 'sessionrestore_no_auto_restore', 14:47:00 INFO - 'tabpaint']}, 14:47:00 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:47:00 INFO - 'tests': ['a11yr', 14:47:00 INFO - 'ts_paint', 14:47:00 INFO - 'tpaint', 14:47:00 INFO - 'sessionrestore', 14:47:00 INFO - 'sessionrestore_no_auto_restore', 14:47:00 INFO - 'tabpaint']}, 14:47:00 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:47:00 INFO - 'tests': ['a11yr', 14:47:00 INFO - 'ts_paint', 14:47:00 INFO - 'tpaint', 14:47:00 INFO - 'sessionrestore', 14:47:00 INFO - 'sessionrestore_no_auto_restore', 14:47:00 INFO - 'tabpaint']}, 14:47:00 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:47:00 INFO - 'tests': ['tsvgx', 14:47:00 INFO - 'tsvgr_opacity', 14:47:00 INFO - 'tart', 14:47:00 INFO - 'tscrollx', 14:47:00 INFO - 'cart']}, 14:47:00 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:47:00 INFO - 'tsvgr_opacity', 14:47:00 INFO - 'tart', 14:47:00 INFO - 'tscrollx', 14:47:00 INFO - 'cart']}, 14:47:00 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:47:00 INFO - 'talos_options': ['--disable-e10s'], 14:47:00 INFO - 'tests': ['tp5o']}, 14:47:00 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:47:00 INFO - 'tests': ['tp5o']}, 14:47:00 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:47:00 INFO - 'talos_options': ['--disable-e10s', 14:47:00 INFO - '--xperf_path', 14:47:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:47:00 INFO - 'tests': ['tp5n']}, 14:47:00 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:47:00 INFO - 'talos_options': ['--xperf_path', 14:47:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:47:00 INFO - 'tests': ['tp5n']}}, 14:47:00 INFO - 'talos.zip': {'path': '', 14:47:00 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:47:00 INFO - Running post-action listener: _resource_record_post_action 14:47:00 INFO - [mozharness: 2016-08-08 21:47:00.711021Z] Finished populate-webroot step (success) 14:47:00 INFO - [mozharness: 2016-08-08 21:47:00.711133Z] Running create-virtualenv step. 14:47:00 INFO - Running pre-action listener: _resource_record_pre_action 14:47:00 INFO - Running main action method: create_virtualenv 14:47:00 INFO - Creating virtualenv /builds/slave/test/build/venv 14:47:00 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 14:47:00 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:47:00 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:47:00 INFO - Using real prefix '/tools/python27' 14:47:00 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:47:01 INFO - Installing distribute.............................................................................................................................................................................................done. 14:47:04 INFO - Installing pip.................done. 14:47:04 INFO - Return code: 0 14:47:04 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:47:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:47:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:47:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:47:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:47:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:47:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:47:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1019bfa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101a54618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f98bb4cb7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101923d30>, '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 0x101688db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10191bb20>, '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.k8xXNNJHNU/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.UncfaQmDPK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/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 14:47:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 14:47:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 14:47:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.k8xXNNJHNU/Render', 14:47:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:47:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:47:04 INFO - 'HOME': '/Users/cltbld', 14:47:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:47:04 INFO - 'LOGNAME': 'cltbld', 14:47:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:47:04 INFO - 'MOZ_NO_REMOTE': '1', 14:47:04 INFO - 'NO_EM_RESTART': '1', 14:47:04 INFO - 'PAGER': '/bin/cat', 14:47:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:47:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:47:04 INFO - 'PWD': '/builds/slave/test', 14:47:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:47:04 INFO - 'SHELL': '/bin/bash', 14:47:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UncfaQmDPK/Listeners', 14:47:04 INFO - 'TMPDIR': '/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/', 14:47:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:47:04 INFO - 'USER': 'cltbld', 14:47:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:47:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:47:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:47:04 INFO - 'XPC_FLAGS': '0x0', 14:47:04 INFO - 'XPC_SERVICE_NAME': '0', 14:47:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:47:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:47:04 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 14:47:04 INFO - Cleaning up... 14:47:04 INFO - Return code: 0 14:47:04 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:47:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:47:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:47:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:47:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:47:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:47:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:47:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1019bfa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101a54618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f98bb4cb7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101923d30>, '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 0x101688db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10191bb20>, '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.k8xXNNJHNU/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.UncfaQmDPK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/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 14:47:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 14:47:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 14:47:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.k8xXNNJHNU/Render', 14:47:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:47:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:47:04 INFO - 'HOME': '/Users/cltbld', 14:47:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:47:04 INFO - 'LOGNAME': 'cltbld', 14:47:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:47:04 INFO - 'MOZ_NO_REMOTE': '1', 14:47:04 INFO - 'NO_EM_RESTART': '1', 14:47:04 INFO - 'PAGER': '/bin/cat', 14:47:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:47:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:47:04 INFO - 'PWD': '/builds/slave/test', 14:47:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:47:04 INFO - 'SHELL': '/bin/bash', 14:47:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UncfaQmDPK/Listeners', 14:47:04 INFO - 'TMPDIR': '/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/', 14:47:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:47:04 INFO - 'USER': 'cltbld', 14:47:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:47:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:47:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:47:04 INFO - 'XPC_FLAGS': '0x0', 14:47:04 INFO - 'XPC_SERVICE_NAME': '0', 14:47:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:47:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:47:04 INFO - Downloading/unpacking psutil>=3.1.1 14:47:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:47:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:47:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:47:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:47:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:47:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:47:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:47:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:47:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:47:07 INFO - Installing collected packages: psutil 14:47:07 INFO - Running setup.py install for psutil 14:47:07 INFO - building 'psutil._psutil_osx' extension 14:47:07 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 14:47:08 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 14:47:08 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 14:47:08 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 14:47:08 INFO - building 'psutil._psutil_posix' extension 14:47:08 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 14:47:08 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 14:47:08 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 14:47:08 INFO - ^ 14:47:08 INFO - 1 warning generated. 14:47:08 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 14:47:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:47:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:47:08 INFO - Successfully installed psutil 14:47:08 INFO - Cleaning up... 14:47:08 INFO - Return code: 0 14:47:08 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:47:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:47:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:47:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:47:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:47:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:47:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:47:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1019bfa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101a54618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f98bb4cb7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101923d30>, '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 0x101688db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10191bb20>, '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.k8xXNNJHNU/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.UncfaQmDPK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/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 14:47:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 14:47:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 14:47:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.k8xXNNJHNU/Render', 14:47:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:47:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:47:08 INFO - 'HOME': '/Users/cltbld', 14:47:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:47:08 INFO - 'LOGNAME': 'cltbld', 14:47:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:47:08 INFO - 'MOZ_NO_REMOTE': '1', 14:47:08 INFO - 'NO_EM_RESTART': '1', 14:47:08 INFO - 'PAGER': '/bin/cat', 14:47:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:47:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:47:08 INFO - 'PWD': '/builds/slave/test', 14:47:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:47:08 INFO - 'SHELL': '/bin/bash', 14:47:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UncfaQmDPK/Listeners', 14:47:08 INFO - 'TMPDIR': '/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/', 14:47:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:47:08 INFO - 'USER': 'cltbld', 14:47:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:47:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:47:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:47:08 INFO - 'XPC_FLAGS': '0x0', 14:47:08 INFO - 'XPC_SERVICE_NAME': '0', 14:47:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:47:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:47:08 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:47:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:47:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:47:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:47:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:47:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:47:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:47:11 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:47:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:47:11 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:47:11 INFO - Installing collected packages: mozsystemmonitor 14:47:11 INFO - Running setup.py install for mozsystemmonitor 14:47:11 INFO - Successfully installed mozsystemmonitor 14:47:11 INFO - Cleaning up... 14:47:11 INFO - Return code: 0 14:47:11 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 14:47: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')]} 14:47:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:47:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:47: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')]} 14:47:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:47:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:47:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1019bfa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101a54618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f98bb4cb7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101923d30>, '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 0x101688db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10191bb20>, '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.k8xXNNJHNU/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.UncfaQmDPK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/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 14:47:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 14:47:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 14:47:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.k8xXNNJHNU/Render', 14:47:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:47:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:47:11 INFO - 'HOME': '/Users/cltbld', 14:47:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:47:11 INFO - 'LOGNAME': 'cltbld', 14:47:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:47:11 INFO - 'MOZ_NO_REMOTE': '1', 14:47:11 INFO - 'NO_EM_RESTART': '1', 14:47:11 INFO - 'PAGER': '/bin/cat', 14:47:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:47:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:47:11 INFO - 'PWD': '/builds/slave/test', 14:47:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:47:11 INFO - 'SHELL': '/bin/bash', 14:47:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UncfaQmDPK/Listeners', 14:47:11 INFO - 'TMPDIR': '/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/', 14:47:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:47:11 INFO - 'USER': 'cltbld', 14:47:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:47:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:47:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:47:11 INFO - 'XPC_FLAGS': '0x0', 14:47:11 INFO - 'XPC_SERVICE_NAME': '0', 14:47:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:47:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:47:11 INFO - Downloading/unpacking jsonschema==2.5.1 14:47:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:47:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:47:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:47:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:47:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:47:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:47:14 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:47:14 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 14:47:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:47:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:47:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:47:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:47:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:47:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:47:14 INFO - Downloading functools32-3.2.3-2.tar.gz 14:47:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:47:14 INFO - warning: no files found matching '*.txt' 14:47:14 INFO - no previously-included directories found matching 'build' 14:47:14 INFO - no previously-included directories found matching 'dist' 14:47:14 INFO - no previously-included directories found matching '.git*' 14:47:14 INFO - Installing collected packages: jsonschema, functools32 14:47:14 INFO - Running setup.py install for functools32 14:47:14 INFO - warning: no files found matching '*.txt' 14:47:14 INFO - no previously-included directories found matching 'build' 14:47:14 INFO - no previously-included directories found matching 'dist' 14:47:14 INFO - no previously-included directories found matching '.git*' 14:47:15 INFO - Successfully installed jsonschema functools32 14:47:15 INFO - Cleaning up... 14:47:15 INFO - Return code: 0 14:47:15 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 14:47:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:47:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:47:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:47:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:47:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:47:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:47:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1019bfa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101a54618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f98bb4cb7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101923d30>, '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 0x101688db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10191bb20>, '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.k8xXNNJHNU/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.UncfaQmDPK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/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 14:47:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 14:47:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 14:47:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.k8xXNNJHNU/Render', 14:47:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:47:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:47:15 INFO - 'HOME': '/Users/cltbld', 14:47:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:47:15 INFO - 'LOGNAME': 'cltbld', 14:47:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:47:15 INFO - 'MOZ_NO_REMOTE': '1', 14:47:15 INFO - 'NO_EM_RESTART': '1', 14:47:15 INFO - 'PAGER': '/bin/cat', 14:47:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:47:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:47:15 INFO - 'PWD': '/builds/slave/test', 14:47:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:47:15 INFO - 'SHELL': '/bin/bash', 14:47:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UncfaQmDPK/Listeners', 14:47:15 INFO - 'TMPDIR': '/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/', 14:47:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:47:15 INFO - 'USER': 'cltbld', 14:47:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:47:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:47:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:47:15 INFO - 'XPC_FLAGS': '0x0', 14:47:15 INFO - 'XPC_SERVICE_NAME': '0', 14:47:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:47:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:47:15 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 14:47:15 INFO - Cleaning up... 14:47:15 INFO - Return code: 0 14:47:15 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:47:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:47:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:47:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:47:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:47:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:47:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:47:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1019bfa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101a54618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f98bb4cb7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101923d30>, '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 0x101688db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10191bb20>, '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.k8xXNNJHNU/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.UncfaQmDPK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/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 14:47:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 14:47:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 14:47:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.k8xXNNJHNU/Render', 14:47:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:47:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:47:15 INFO - 'HOME': '/Users/cltbld', 14:47:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:47:15 INFO - 'LOGNAME': 'cltbld', 14:47:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:47:15 INFO - 'MOZ_NO_REMOTE': '1', 14:47:15 INFO - 'NO_EM_RESTART': '1', 14:47:15 INFO - 'PAGER': '/bin/cat', 14:47:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:47:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:47:15 INFO - 'PWD': '/builds/slave/test', 14:47:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:47:15 INFO - 'SHELL': '/bin/bash', 14:47:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UncfaQmDPK/Listeners', 14:47:15 INFO - 'TMPDIR': '/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/', 14:47:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:47:15 INFO - 'USER': 'cltbld', 14:47:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:47:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:47:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:47:15 INFO - 'XPC_FLAGS': '0x0', 14:47:15 INFO - 'XPC_SERVICE_NAME': '0', 14:47:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:47:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:47:15 INFO - Downloading/unpacking blobuploader==1.2.4 14:47:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:47:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:47:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:47:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:47:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:47:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:47:17 INFO - Downloading blobuploader-1.2.4.tar.gz 14:47:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:47:18 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:47: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 14:47: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 14:47: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 14:47: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 14:47: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 14:47: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 14:47:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:47:18 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:47: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 14:47: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 14:47: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 14:47: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 14:47: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 14:47: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 14:47:19 INFO - Downloading docopt-0.6.1.tar.gz 14:47:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:47:19 INFO - Installing collected packages: blobuploader, requests, docopt 14:47:19 INFO - Running setup.py install for blobuploader 14:47:19 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:47:19 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:47:19 INFO - Running setup.py install for requests 14:47:19 INFO - Running setup.py install for docopt 14:47:20 INFO - Successfully installed blobuploader requests docopt 14:47:20 INFO - Cleaning up... 14:47:20 INFO - Return code: 0 14:47:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:47:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:47:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:47:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:47:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:47:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:47:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:47:20 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 0x1019bfa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101a54618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f98bb4cb7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101923d30>, '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 0x101688db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10191bb20>, '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.k8xXNNJHNU/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.UncfaQmDPK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/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 14:47:20 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 14:47:20 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 14:47:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.k8xXNNJHNU/Render', 14:47:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:47:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:47:20 INFO - 'HOME': '/Users/cltbld', 14:47:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:47:20 INFO - 'LOGNAME': 'cltbld', 14:47:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:47:20 INFO - 'MOZ_NO_REMOTE': '1', 14:47:20 INFO - 'NO_EM_RESTART': '1', 14:47:20 INFO - 'PAGER': '/bin/cat', 14:47:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:47:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:47:20 INFO - 'PWD': '/builds/slave/test', 14:47:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:47:20 INFO - 'SHELL': '/bin/bash', 14:47:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UncfaQmDPK/Listeners', 14:47:20 INFO - 'TMPDIR': '/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/', 14:47:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:47:20 INFO - 'USER': 'cltbld', 14:47:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:47:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:47:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:47:20 INFO - 'XPC_FLAGS': '0x0', 14:47:20 INFO - 'XPC_SERVICE_NAME': '0', 14:47:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:47:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:47:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:47:20 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-R9w7su-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:47:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:47:20 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-qFEXJv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:47:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:47:20 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-sHnxiL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:47:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:47:20 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-Klb7OT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:47:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:47:20 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-0lQXhK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:47:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:47:20 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-xX71IE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:47:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:47:21 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-tsyfoE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:47:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:47:21 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-9J64Nl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:47:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:47:21 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-G6197C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:47:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:47:21 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-2t0kQ_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:47:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:47:21 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-BJ5dWt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:47:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:47:21 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-FljtYM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:47:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:47:21 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-ZGK52L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:47:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:47:21 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-aBR5xZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:47:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:47:21 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-oBelAL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:47:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:47:22 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-V2Xe7t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:47:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:47:22 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-FaUMUG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:47:22 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:47:22 INFO - Running setup.py install for manifestparser 14:47:22 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:47:22 INFO - Running setup.py install for mozcrash 14:47:22 INFO - Running setup.py install for mozdebug 14:47:22 INFO - Running setup.py install for mozdevice 14:47:22 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:47:22 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:47:22 INFO - Running setup.py install for mozfile 14:47:22 INFO - Running setup.py install for mozhttpd 14:47:23 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:47:23 INFO - Running setup.py install for mozinfo 14:47:23 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:47:23 INFO - Running setup.py install for mozInstall 14:47:23 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:47:23 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:47:23 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:47:23 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:47:23 INFO - Running setup.py install for mozleak 14:47:23 INFO - Running setup.py install for mozlog 14:47:23 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:47:23 INFO - Running setup.py install for moznetwork 14:47:23 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:47:23 INFO - Running setup.py install for mozprocess 14:47:24 INFO - Running setup.py install for mozprofile 14:47:24 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:47:24 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:47:24 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:47:24 INFO - Running setup.py install for mozrunner 14:47:24 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:47:24 INFO - Running setup.py install for mozscreenshot 14:47:24 INFO - Running setup.py install for moztest 14:47:24 INFO - Running setup.py install for mozversion 14:47:24 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:47:24 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:47:24 INFO - Cleaning up... 14:47:24 INFO - Return code: 0 14:47:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:47:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:47:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:47:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:47:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:47:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:47:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:47:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1019bfa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101a54618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f98bb4cb7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101923d30>, '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 0x101688db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10191bb20>, '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.k8xXNNJHNU/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.UncfaQmDPK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/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 14:47:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 14:47:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:47:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.k8xXNNJHNU/Render', 14:47:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:47:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:47:24 INFO - 'HOME': '/Users/cltbld', 14:47:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:47:24 INFO - 'LOGNAME': 'cltbld', 14:47:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:47:24 INFO - 'MOZ_NO_REMOTE': '1', 14:47:24 INFO - 'NO_EM_RESTART': '1', 14:47:24 INFO - 'PAGER': '/bin/cat', 14:47:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:47:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:47:24 INFO - 'PWD': '/builds/slave/test', 14:47:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:47:24 INFO - 'SHELL': '/bin/bash', 14:47:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UncfaQmDPK/Listeners', 14:47:24 INFO - 'TMPDIR': '/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/', 14:47:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:47:24 INFO - 'USER': 'cltbld', 14:47:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:47:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:47:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:47:24 INFO - 'XPC_FLAGS': '0x0', 14:47:24 INFO - 'XPC_SERVICE_NAME': '0', 14:47:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:47:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:47:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:47:25 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-UEw3If-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:47:25 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)) 14:47:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:47:25 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-7K3eHg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:47:25 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)) 14:47:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:47:25 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-JhUYuB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:47:25 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)) 14:47:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:47:25 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-O1k_Sn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:47:25 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)) 14:47:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:47:25 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-Xe0VOa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:47:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 14:47:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:47:25 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-iIXoSj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:47:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 14:47:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:47:25 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-t4BKXH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:47:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 14:47:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:47:25 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-E4Fk9H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:47:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 14:47:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:47:25 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-ODiDBn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:47:26 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)) 14:47:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:47:26 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-kpo6sa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:47:26 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)) 14:47:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:47:26 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-QeUoVr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:47:26 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)) 14:47:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:47:26 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-C1MJqP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:47:26 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)) 14:47:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:47:26 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-t7Fh_C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:47:26 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)) 14:47:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:47:26 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-PY7zUs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:47:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 14:47:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:47:26 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-d5AKUQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:47:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 14:47:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:47:26 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-0x84ZS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:47:26 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 14:47:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:47:26 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-IvawtS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:47:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 14:47:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:47:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:47:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 14:47:26 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:47:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:47:26 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:47:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:47:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:47:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:47:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:47:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:47:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:47:29 INFO - Downloading blessings-1.6.tar.gz 14:47:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:47:29 INFO - Installing collected packages: blessings 14:47:29 INFO - Running setup.py install for blessings 14:47:29 INFO - Successfully installed blessings 14:47:29 INFO - Cleaning up... 14:47:29 INFO - Return code: 0 14:47:29 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:47:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:47:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:47:29 INFO - Reading from file tmpfile_stdout 14:47:29 INFO - Current package versions: 14:47:29 INFO - blessings == 1.6 14:47:29 INFO - blobuploader == 1.2.4 14:47:29 INFO - docopt == 0.6.1 14:47:29 INFO - functools32 == 3.2.3-2 14:47:29 INFO - jsonschema == 2.5.1 14:47:29 INFO - manifestparser == 1.1 14:47:29 INFO - mozInstall == 1.12 14:47:29 INFO - mozcrash == 0.17 14:47:29 INFO - mozdebug == 0.1 14:47:29 INFO - mozdevice == 0.48 14:47:29 INFO - mozfile == 1.2 14:47:29 INFO - mozhttpd == 0.7 14:47:29 INFO - mozinfo == 0.9 14:47:29 INFO - mozleak == 0.1 14:47:29 INFO - mozlog == 3.3 14:47:29 INFO - moznetwork == 0.27 14:47:29 INFO - mozprocess == 0.23 14:47:29 INFO - mozprofile == 0.28 14:47:29 INFO - mozrunner == 6.12 14:47:29 INFO - mozscreenshot == 0.1 14:47:29 INFO - mozsystemmonitor == 0.3 14:47:29 INFO - moztest == 0.7 14:47:29 INFO - mozversion == 1.4 14:47:29 INFO - psutil == 3.1.1 14:47:29 INFO - requests == 1.2.3 14:47:29 INFO - wsgiref == 0.1.2 14:47:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:47:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:47:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:47:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:47:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:47:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:47:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:47:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1019bfa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101a54618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f98bb4cb7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101923d30>, '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 0x101688db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10191bb20>, '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.k8xXNNJHNU/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.UncfaQmDPK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/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 14:47:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 14:47:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:47:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.k8xXNNJHNU/Render', 14:47:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:47:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:47:29 INFO - 'HOME': '/Users/cltbld', 14:47:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:47:29 INFO - 'LOGNAME': 'cltbld', 14:47:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:47:29 INFO - 'MOZ_NO_REMOTE': '1', 14:47:29 INFO - 'NO_EM_RESTART': '1', 14:47:29 INFO - 'PAGER': '/bin/cat', 14:47:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:47:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:47:29 INFO - 'PWD': '/builds/slave/test', 14:47:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:47:29 INFO - 'SHELL': '/bin/bash', 14:47:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UncfaQmDPK/Listeners', 14:47:29 INFO - 'TMPDIR': '/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/', 14:47:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:47:29 INFO - 'USER': 'cltbld', 14:47:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:47:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:47:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:47:29 INFO - 'XPC_FLAGS': '0x0', 14:47:29 INFO - 'XPC_SERVICE_NAME': '0', 14:47:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:47:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:47:30 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)) 14:47:30 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)) 14:47:30 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)) 14:47:30 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)) 14:47:30 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)) 14:47:30 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)) 14:47:30 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)) 14:47:30 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)) 14:47:30 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)) 14:47:30 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)) 14:47:30 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)) 14:47:30 INFO - Cleaning up... 14:47:30 INFO - Return code: 0 14:47:30 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:47:30 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')]} 14:47:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:47:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:47:30 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')]} 14:47:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:47:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:47:30 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 0x1019bfa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101a54618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f98bb4cb7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101923d30>, '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 0x101688db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10191bb20>, '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.k8xXNNJHNU/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.UncfaQmDPK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/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 14:47:30 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 14:47:30 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 14:47:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.k8xXNNJHNU/Render', 14:47:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:47:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:47:30 INFO - 'HOME': '/Users/cltbld', 14:47:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:47:30 INFO - 'LOGNAME': 'cltbld', 14:47:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:47:30 INFO - 'MOZ_NO_REMOTE': '1', 14:47:30 INFO - 'NO_EM_RESTART': '1', 14:47:30 INFO - 'PAGER': '/bin/cat', 14:47:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:47:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:47:30 INFO - 'PWD': '/builds/slave/test', 14:47:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:47:30 INFO - 'SHELL': '/bin/bash', 14:47:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UncfaQmDPK/Listeners', 14:47:30 INFO - 'TMPDIR': '/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/', 14:47:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:47:30 INFO - 'USER': 'cltbld', 14:47:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:47:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:47:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:47:30 INFO - 'XPC_FLAGS': '0x0', 14:47:30 INFO - 'XPC_SERVICE_NAME': '0', 14:47:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:47:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:47:30 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 14:47:30 INFO - Cleaning up... 14:47:30 INFO - Return code: 0 14:47:30 INFO - Running post-action listener: _resource_record_post_action 14:47:30 INFO - Running post-action listener: _start_resource_monitoring 14:47:30 INFO - Starting resource monitoring. 14:47:30 INFO - [mozharness: 2016-08-08 21:47:30.574425Z] Finished create-virtualenv step (success) 14:47:30 INFO - [mozharness: 2016-08-08 21:47:30.575368Z] Running install step. 14:47:30 INFO - Running pre-action listener: _resource_record_pre_action 14:47:30 INFO - Running main action method: install 14:47:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:47:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:47:30 INFO - Reading from file tmpfile_stdout 14:47:30 INFO - Detecting whether we're running mozinstall >=1.0... 14:47:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:47:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:47:30 INFO - Reading from file tmpfile_stdout 14:47:30 INFO - Output received: 14:47:30 INFO - Usage: mozinstall [options] installer 14:47:30 INFO - Options: 14:47:30 INFO - -h, --help show this help message and exit 14:47:30 INFO - -d DEST, --destination=DEST 14:47:30 INFO - Directory to install application into. [default: 14:47:30 INFO - "/builds/slave/test"] 14:47:30 INFO - --app=APP Application being installed. [default: firefox] 14:47:30 INFO - mkdir: /builds/slave/test/build/application 14:47:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 14:47:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 14:48:05 INFO - Reading from file tmpfile_stdout 14:48:05 INFO - Output received: 14:48:05 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 14:48:05 INFO - Running post-action listener: _resource_record_post_action 14:48:05 INFO - [mozharness: 2016-08-08 21:48:05.493642Z] Finished install step (success) 14:48:05 INFO - [mozharness: 2016-08-08 21:48:05.493785Z] Running run-tests step. 14:48:05 INFO - Running pre-action listener: _resource_record_pre_action 14:48:05 INFO - Running main action method: run_tests 14:48:05 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:48:05 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:48:05 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:48:05 INFO - 2016-08-08 14:48:05.508 screenresolution[2087:10558] starting screenresolution argv=screenresolution get 14:48:05 INFO - 2016-08-08 14:48:05.510 screenresolution[2087:10558] Display 0: 1600x1200x32@60 14:48:05 INFO - 2016-08-08 14:48:05.516 screenresolution[2088:10560] starting screenresolution argv=screenresolution list 14:48:05 INFO - Available Modes on Display 0 14:48:05 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:48:05 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:48:05 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:48:05 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:48:05 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:48:05 INFO - Intel Iris: 14:48:05 INFO - Chipset Model: Intel Iris 14:48:05 INFO - Type: GPU 14:48:05 INFO - Bus: Built-In 14:48:05 INFO - VRAM (Dynamic, Max): 1536 MB 14:48:05 INFO - Vendor: Intel (0x8086) 14:48:05 INFO - Device ID: 0x0a2e 14:48:05 INFO - Revision ID: 0x0009 14:48:05 INFO - Displays: 14:48:05 INFO - Display: 14:48:05 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:48:05 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:48:05 INFO - Display Serial Number: 1600x1200 60 14:48:05 INFO - Main Display: Yes 14:48:05 INFO - Mirror: Off 14:48:05 INFO - Online: Yes 14:48:05 INFO - Rotation: Supported 14:48:05 INFO - Return code: 0 14:48:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:48:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:48:05 INFO - Python 2.7.3 14:48:05 INFO - Return code: 0 14:48:05 INFO - grabbing minidump binary from tooltool 14:48:05 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')]} 14:48:05 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 0x101923d30>, '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 0x101688db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10191bb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:48:05 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 14:48:05 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 14:48:05 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 14:48:05 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:48:05 INFO - Return code: 0 14:48:05 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 14:48:05 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:48:05 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:48:05 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 14:48:05 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:48:05 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/Ra5Kb7uNSmSLYBf66CBAWQ/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0314', '--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 14:48:05 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/Ra5Kb7uNSmSLYBf66CBAWQ/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0314 --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 14:48:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.k8xXNNJHNU/Render', 14:48:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:48:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:48:05 INFO - 'HOME': '/Users/cltbld', 14:48:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:48:05 INFO - 'LOGNAME': 'cltbld', 14:48:05 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:48:05 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 14:48:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:48:05 INFO - 'MOZ_NO_REMOTE': '1', 14:48:05 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:48:05 INFO - 'NO_EM_RESTART': '1', 14:48:05 INFO - 'PAGER': '/bin/cat', 14:48:05 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:48:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:48:05 INFO - 'PWD': '/builds/slave/test', 14:48:05 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:48:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:48:05 INFO - 'SHELL': '/bin/bash', 14:48:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UncfaQmDPK/Listeners', 14:48:05 INFO - 'TMPDIR': '/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/', 14:48:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:48:05 INFO - 'USER': 'cltbld', 14:48:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:48:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:48:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:48:05 INFO - 'XPC_FLAGS': '0x0', 14:48:05 INFO - 'XPC_SERVICE_NAME': '0', 14:48:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:48:05 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/Ra5Kb7uNSmSLYBf66CBAWQ/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0314', '--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 14:48:06 INFO - mozversion application_buildid: 20160808134626 14:48:06 INFO - mozversion application_changeset: 98ad8d33b747018425edb486f8345a7c4c1d47cc 14:48:06 INFO - mozversion application_display_name: Nightly 14:48:06 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:48:06 INFO - mozversion application_name: Firefox 14:48:06 INFO - mozversion application_remotingname: firefox 14:48:06 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 14:48:06 INFO - mozversion application_vendor: Mozilla 14:48:06 INFO - mozversion application_version: 51.0a1 14:48:06 INFO - mozversion platform_buildid: 20160808134626 14:48:06 INFO - mozversion platform_changeset: 98ad8d33b747018425edb486f8345a7c4c1d47cc 14:48:06 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 14:48:06 INFO - mozversion platform_version: 51.0a1 14:48:06 INFO - using testdate: 1470692886 14:48:06 INFO - actual date: 1470692886 14:48:06 INFO - starting webserver on 'localhost:49657' 14:48:06 INFO - SUITE-START | Running 2 tests 14:48:06 INFO - TEST-START | dromaeo_css 14:48:06 INFO - operating with platform_type : mac_ 14:48:06 INFO - Initialising browser for dromaeo_css test... 14:48:06 INFO - TEST-INFO | started process 2098 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/tmpjyuWAG/profile http://localhost:49657/getInfo.html) 14:48:08 INFO - PROCESS | 2098 | __metrics Screen width/height:1600/1200 14:48:08 INFO - PROCESS | 2098 | colorDepth:24 14:48:08 INFO - PROCESS | 2098 | Browser inner width/height: 1024/689 14:48:08 INFO - PROCESS | 2098 | __metrics 14:48:08 ERROR - PROCESS | 2098 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 14:48:09 INFO - TEST-INFO | 2098: exit 0 14:48:09 INFO - Browser initialized. 14:48:09 INFO - Running cycle 1/1 for dromaeo_css test... 14:48:09 INFO - TEST-INFO | started process 2101 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/tmpjyuWAG/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:48:21 INFO - PROCESS | 2101 | RSS: Main: 254697472 14:48:21 INFO - PROCESS | 2101 | 14:49:11 INFO - PROCESS | 2101 | 1470692951322 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] 14:51:24 INFO - PROCESS | 2101 | Cycle 1(1): loaded http://localhost:49657/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49657/tests/dromaeo/cssquery-ext.html) 14:51:25 INFO - PROCESS | 2101 | RSS: Main: 267796480 14:51:25 INFO - PROCESS | 2101 | 14:54:27 INFO - PROCESS | 2101 | Cycle 1(1): loaded http://localhost:49657/tests/dromaeo/cssquery-ext.html (next: http://localhost:49657/tests/dromaeo/cssquery-jquery.html) 14:54:28 INFO - PROCESS | 2101 | RSS: Main: 280256512 14:54:28 INFO - PROCESS | 2101 | 14:57:30 INFO - PROCESS | 2101 | Cycle 1(1): loaded http://localhost:49657/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49657/tests/dromaeo/cssquery-mootools.html) 14:57:30 INFO - PROCESS | 2101 | RSS: Main: 287539200 14:57:30 INFO - PROCESS | 2101 | 15:00:32 INFO - PROCESS | 2101 | Cycle 1(1): loaded http://localhost:49657/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49657/tests/dromaeo/cssquery-prototype.html) 15:00:33 INFO - PROCESS | 2101 | RSS: Main: 287404032 15:00:33 INFO - PROCESS | 2101 | 15:03:35 INFO - PROCESS | 2101 | Cycle 1(1): loaded http://localhost:49657/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49657/tests/dromaeo/cssquery-yui.html) 15:03:36 INFO - PROCESS | 2101 | RSS: Main: 291299328 15:03:36 INFO - PROCESS | 2101 | 15:06:39 INFO - PROCESS | 2101 | Cycle 1(1): loaded http://localhost:49657/tests/dromaeo/cssquery-yui.html (next: http://localhost:49657/tests/dromaeo/cssquery-dojo.html) 15:06:39 INFO - PROCESS | 2101 | RSS: Main: 291196928 15:06:39 INFO - PROCESS | 2101 | 15:06:39 INFO - PROCESS | 2101 | __start_tp_report 15:06:39 INFO - PROCESS | 2101 | _x_x_mozilla_page_load 15:06:39 INFO - PROCESS | 2101 | _x_x_mozilla_page_load_details 15:06:39 INFO - PROCESS | 2101 | |i|pagename|runs| 15:06:39 INFO - PROCESS | 2101 | |0;dojo.html;3427.7429192810528;3439.105832483554;3445.5865296164466;3461.3077384523094;3465.0817533353666;5670.4896559309655;5834;5873.911891321628;5943.138244954484;5943.13824495449;5812.680302583356;5846.21076154719;5946.583739138262;5970.313413957396;5977.790777322794;5266.157414813631;5300.443453437391;5303.124984377573;5405.4324295948945;5429.429909859467;5422.376426710939;5431.755570999315;5440.129579267318;5475.753591088411;5499.175123731432;5188.6367954243215;5331.2269720890645;5365.678059316453;5371.650842695212;5407.83776486704;5227.424983251839;5248.370195576517;5293.57651387888;5313.840584782462;5320.547753440962;5206.973965130188;5235.476452354734;5291.973540132275;5315.149576067849;5351.7056561889085;5768.97115514424;5829.417058294179;5885;5928.40715928408;5934.5845790794665;6194.194754681907;6218.440340369389;6251.843703907393;6276.560640755149;6282.089097080898;6268.843278918063;6308.526860485482;6316.526260530432;6320.841978950517;6329.810105696836;5828.358880523139;5939.4357536034;5940.405959404025;5967.343592204854;5984.281886173643;6395.744170233139;6415.839604009844;6421.550491465552;6449.871002580016;6455.709493072823;6247.406496382836;6249.593776404519;6275.309715931244;6278.277998030194;6296.968515157395;6188.504919606421;6201.441870231701;6212.378762123752;6268.968655156787;6280.842978925563;6156.26124865019;6208.317085120633;6212.502999760009;6214.161088253119;6244.781432649836;6195.907061394083;6201.81394558164;6211.2857021443115;6235.625862448268;6252.406021428048;4979.601631869442;5032.194848824171;5061.342025536656;5094.388673359221;5151.7681704323395;4492.191405546968;4556.544345565417;4558.635309175258;4591.563801438925;4637.1653102441205;4979.30289759434;5824.796132135355;5914.349421563625;5954.732037058343;6013.9699301503215;6143.020634992025;6170.938290617126;6206.162168107247;6294.496440284766;6384.52116091295;5904.4095590441475;5910.143029260733;5919.112133180058;5929.762809487658;5954.55340849438;5509.5041446270025;5525.237381309345;5557.805476808292;5591.077472217039;5601;6267.62394256346;6323.272823625342;6342.714577843916;6440.452561532322;6456.386643268976;6246.969250073687;6255.874882502416;6278.058291256348;6308.116863639002;6368.917284061813;6427.58220715652;6447.70985305653;6490.415862572391;6503.577267477599;6516.478681705357;6168.506519478521;6198.907016394848;6231.688415579293;6231.937680623136;6277.089821975696;6190.195274614452;6252.062190671254;6260.593061450991;6272.2159730033745;6287.151234583455;6215.689215539295;6231.2522497300615;6246.219222597176;6257.843553911189;6288.905666414916;4978.85486338137;6127.264728232641;6136.917362303726;6168.506519478341;6225.688715564294;5119.334486516729;5622.100463925753;5799.652020878761;5987.43119403656;6098.512119030555;5020.6234532410945;6200.596961197508;6227.439530442282;6247.375262473716;6263.592866463665;5159.664621799571;5944.791932282349;6050.364711705208;6059.182010428536;6080.635161890301 15:06:39 INFO - PROCESS | 2101 | |1;ext.html;468.4542507978206;484.479184876258;486.55237181792756;532.6165161084018;558.701094914221;31437.371252574965;41788.37317440241;41826.58173418265;41833.7908310458;41887.37168942468;42534.57465425345;42873.57126428735;42984.35523467151;42985.850707464655;43150.7842460788;9534.380265282769;9725.902740972571;9726.610935562605;9767;9769.120779129877;9634.373765705242;9720.75698107546;9721.465319407429;9724.076212759812;9728.367656102331;9709.514524273793;9715.028497150264;9724.902750972506;9728.610855565768;9765.462899540522;9694.079062489052;9704.369216000938;9726.854097188549;9735.561899714494;9767.609295628166;9461.290403219786;9556.522173891277;9587.376820506644;9598.472084035375;9614.326997110205;39725.40411893824;39948;40011.799646010666;40081.79959100215;40132.398014029815;3036.635603727567;3250.2199472126754;3283.819389933553;3386.373520898642;3399.779014364083;24175.516489670284;30698.386032279228;30702.84648576765;31100.42368029297;31245.843770781226;3111.595492585949;3143.811371317728;3153.369326134782;3175.7935734177204;3263.8694452221885;388385;445691;458392;458878;459173.70413148054;29102.690378933;33856;33944.83027584896;34005.80979665749;34076.82961585226;34677.65322346795;34718.30563388718;35094.649053509645;35166.82416587901;35663.64336356603;15955.441559545592;16562.254698538596;16591.25339359732;16594.08732519723;16670.249838757285;12574.559890403792;12669.93665031669;12712.555060572835;12740.36298185087;12752.744945101045;19097.522561936064;19229.80770192308;19393.03034848252;19418.223271069;19467;8239.464434811718;8287.792805179799;8364.205400486944;8369.070825211249;8386.496810191407;868.5830801215326;920.3143657974852;970.5680971967407;982.4645568165367;1032.4579595712162;30439.391212176077;30525.405340546302;30738.846305768777;31582.526262106087;32084.03747887567;1087.9292845964987;1106.8229083346625;1108.2020944919645;1138.980612351957;1145.5966441109574;13596.864031359757;15861.048337099812;15933.920330398505;15956.202189890459;16291.348346066025;583680;674480;677989;682014;685191;51540.74229628903;60393.69803151044;60705.69647151736;61079.6946015276;61247;1324.8012798080172;1362.1963041805382;1377.0980008094514;1396.4344440501613;1401.2153194211273;29991;30124.24689382783;30295.491444985637;30386.69613303927;30519.237019074702;44343.77828110839;52104.47895521148;52419;52689;52730.47269527409;502609;600857;600862;601232;602359;26957.595636065867;27430.451390972466;27443.588346174423;27463.588046178924;27465.588016179372;39350.2129957405;48896;49181.754091230745;50407.747961259956;50617.493825061276;40019;40063;40308;40486;41400.58599413967;33412.8305509306;39202.41196381999;40793.59206408016;40983.38524922188;41306.793466032475;35493.58025678944;38333.4249986256;38588.842334730005;39883.80058099691;40119.799401002805;31904.36191276115;35795;35961.58364955325;36294.63705362913;36547.72082977083;25750.484990300465;25987;26171.607425888247;26524.55302565294;26550 15:06:39 INFO - PROCESS | 2101 | |2;jquery.html;367.7683059672406;383.61063520526665;387.7130923116894;395.32004951483475;403.28417059719015;19224.134913928872;21510.354689359305;22114;22218.88890555549;22249.110035598576;18242.17910194041;20752.688709669328;21355.252566160187;21503.139874405006;21504.569908601818;4961.280614310923;5928.199693041427;5954.07711804671;6014.127951447038;6053.273607167146;3856.093817952793;5121.8463446096675;5284.735763211824;5932.6143800653035;6117.69411529424;6120.326764055951;6141.969290153543;6142.201513803199;6162.876742465148;6170.2904166021035;5703.144528320744;5816.720321529257;6205.162303089093;6727.764528241512;6839.247682754893;5095.8980820383385;5111.08000559899;5150.356205474316;5165.586753059746;5180.974095129538;12977.545785897542;13180.802287965687;17610.12552342922;24036.03855845764;25245.49509009828;2077.1276064053136;2154.676798480225;2156.91372345106;2161.492049368397;2172.858764180339;9978.800423991552;9999.250056245737;10185;10370.585176592927;10419.947900260526;1661.7258152404838;1697.3804561335023;1760.9698326479024;1801.639672065592;1846.5596834469136;93171;120551.39724301323;130496.43262485863;131481;134207;11255.380954047607;11484.540618375171;11687.415629218505;11773;11827.17209795306;14739.115653060637;14744.336504857307;14751.92624036873;14761;14827.18450485212;8266.669333226724;8562.357823163287;8618.052014278424;8663.393562450568;8706.347023973101;7148.606826624586;8399.034111077182;8489.872651910226;8520.8721869172;8594.5702714864;3811.3330167220624;3820.6943444524372;3897.4738410314812;4552.590266875997;4702.012577358793;1591.5145880506557;1676.3964972609851;1690.9915450422668;1888.4334699590343;1939.776925653568;844.7888027993001;902.4359775140537;903.1871315815687;912.7124955638952;971.4268581536927;21863;22173.22393716212;22358.329250122522;22377.992990315473;22437.887810560842;922.082527884759;927.7031349967946;933.6638810028385;965.1795973422535;1070.3898777696638;10934.890651093547;11045.837750017254;11581;11587.88412115885;11652.126090543243;601782;616221;621967;623343;625639;142822;144207;144572;145042;145801;954.7708549948102;981.916537094355;1001.8897921228659;1006.3358183598936;1011.5650270383805;18920.43238702841;19509.8049019508;19638.821670699803;19651.606967860276;19673.80326196777;38229.61770382261;52330.168444104274;53570.46429535655;55309;55562.166567502325;81735;82144.35711285622;82343;82413;82511.17488825035;7376.7786966391095;7561.357284630868;7585.241475852371;7610.847783044419;7655.6937722490475;10608.628697995533;11438.370889601152;12580.748385032066;13233.206007639572;13266.27035513056;11107.666769996913;11276.154288428237;11379.54481820751;11391.202615816814;11640.24338418034;10001.099901008944;10350.948245258725;11100.61147859821;11269.154813389192;11429.199956003;11226.21416500837;11332.886671133512;11709.824352634547;11727.47226374798;11732.824007640063;7327.816804579928;7428.665710043169;7483.176850546327;7499.962500187464;7555.206703296075;10262.692119236435;11026.338419694523;11152.553897843994;11435.714107147387;11494 15:06:39 INFO - PROCESS | 2101 | |3;mootools.html;1543.5446543269734;1552.8524790144938;1564.9921750391247;1864.058650381558;1875.0718394394776;7813.960930195355;8301.66793328267;8451.450655707375;8828.911710882889;8875.201231889137;8515.574221288942;8711.91288087119;8731.345149113826;8748.825023499527;8751.431156974792;2326.127702111708;2365.66880636711;2370;2371.4664200554907;2376.9168079117235;2342.882855857209;2345.2026311054237;2377.3581133094053;2382.0352757133387;2390.1514962188435;2343.824213184018;2361.9763802362013;2367.230650038736;2380.4405964598304;2386.6300723387903;2320.1995311617466;2322.7793359630978;2336.9298921032396;2341.1220792202926;2342.16853017179;2284.828637852168;2318.9072437102664;2329.301209637119;2330.1611419888827;2331.6825993313723;8820;8826.029136794947;8860.645574177026;8894.59974301158;8915.55422228886;5089.211172268304;5182.170852663593;5283.788648454057;5291.232771248147;5310.867228319323;3087.8919237826794;3464.8960531184107;3628.2743451309843;3666.981665091684;3682.3739964206147;1062.7661914378825;1095.7151140703395;1106.8505751723576;1123.0959077942252;1125.5779082843933;11513.963743263146;11537.48081336342;11618.244814087057;11656.88343116575;11659.00898423635;4510.526394728507;4688.062387522509;4790.688605240648;4795.592374648194;4809.326694262806;9946.154576860903;9947.303688741864;9951.502424878727;9954;9961.750956226153;5297.576193904479;5297.973510132425;5300.628955973122;5307.150855863043;5308.893822123536;3581.3553560358864;4311.568843115663;4789.856304310876;4835.178019736653;4845.418549773979;3063.7702172337163;3859.2281543691374;3935.960640393617;3964.7312859885137;4061.756294622332;1271.2944315904576;1284.5183056353867;1292.6186774901428;1298.6233992142172;1300.63582196985;827.954462504568;895.1853813030242;906.6328137104483;919.9742287349557;947.9478628675352;5144.717040562805;5731.684757338387;5968.403159684084;6053.969730151409;6288.151099601587;447.5166819834571;457.7459509971931;457.88781748471837;1008.1732978957185;1027.111548510548;3926.509186351706;3945.705336044435;4003.91992160161;4073.816678249486;4117.75293482392;10545.683629491128;10937.671869843918;10955.50700218492;10963.671089867317;10989.340639561651;9345.953270233742;10872.402017889091;10890.183236257313;10896.61861834832;10901;8061.717839875576;8073.233042861037;8192.959035204905;8281.792955176048;8336;5741.483266506035;5754.424557544212;5893.351731309467;5905.143754155709;5974.970125149346;9927.553260103457;10064.043915827984;10184;10204.591816327264;10225.948870255601;9649.421034737938;10110.545025474019;10227.43749093807;10297.794044118926;10358.948205259227;6984.196817366068;7393.223711510214;7471.663775130023;7575.6969721210535;7729.652165652672;8451.535165565952;8510.191531804468;8517.488950662731;8534.018587862476;8568.91431085706;7445.702171913063;7474.701011959461;7598.620068996639;7683.385329173541;7720.7683769487;7426.443016773872;7497.62511874415;7509;7637.159912409742;7679.769606911802;6913.1358580177475;7047.929520704727;7052.576845389293;7059.117610298713;7076.964615176891;4919.803207871645;4929.7535123244415;5022.924656130234;5086.54221120101;5117.334746482933;4932.802687892444;5046.419661738947;5135.6918584885025;5153.149730294459;5161.045206636634 15:06:39 INFO - PROCESS | 2101 | |4;prototype.html;291.27036772883935;300.24787906294733;307.70306654078814;308.8888000319883;310.469097842689;5252.395974462943;5409.459054094588;5435.93999170161;5539.058360078786;5647.802326918559;4228.978855105728;4370.847020354288;4629.560191781776;5587.804426845051;5632.915506267409;4202.936955945664;4233.597808208223;4286.957130428687;4306.138772245547;4317.625306081658;3574.4280915053596;3891.455196272524;4111.177764447108;4265.850695225668;4333.378306124797;3449.896503104911;4085.9182816343655;4111.321631930728;4126.9793651031705;4137.234611596849;3498.7201023918024;3622.7464077514583;4074.470318858544;4177.97911010446;4208.852690155861;3567.714582833367;3602.2975519773654;3603.7117030637487;3625.7461977661574;3630.364686179908;4155.4182414462;4376.081022985177;4474.664400170001;5425.810096646638;5491;4017.0760725033115;4392.319190525442;4759.834275404683;4764.952350476486;4811.75941202942;5385.461453854622;5847.912281315784;5908.261467316585;5923.289205295349;5953.374895635982;3777.527809023872;3827.9043023924346;3903.9219215615813;3904.4338570907344;3964.493492472871;5666.603337766358;6228.532860035471;6235.129461161679;6267.4672652824565;6286.811395658092;4004.3593025115842;4008.498937632796;4008.939865902014;4020.8391664333685;4021.2761702893176;3712.406015037635;3998.5601583825755;4064.9390259146135;4075.694322925792;4088.9182216355507;4511.616512596401;4749.59886833385;4779.545943135466;4783.856484305476;4833.468318484964;4850.587700045465;5925.4370834770625;5931.288245410578;5951.464368206882;5999.730012149464;1094.8631421072366;1282.8011658192995;1343.2746316988912;1365.590322903125;1378.5588611644177;887.6854717130924;900.7432881628704;913.7207908927554;920.3925409229876;929.4376901974343;4244.554321796167;5144.996725638464;5318.308619879468;5445.482679145475;5461.808836690697;5705.457981491834;5966.671833049137;5967.701614919237;5969.120071953178;5986.461218490357;4546.840860569931;4709.81160753566;4856.927146092811;5375.914305128053;5436.565074794007;2369.992753079934;2399.796017338546;2606.6741657292837;2716.7147449517515;2724.741149590786;4270.957290427118;4928.48250933654;4956.033573453142;5291.703532634529;5307.363116426053;3952.6837852971694;4891.654794931423;5209.47905209476;5240.349289973646;5270.894582108336;4324.978375108167;4890.24201248807;5151.5106064923775;5158.793648254028;5180.860210753553;4490.977545112253;4505.842295519641;4653.744044077473;5072;5123.846284611468;4221.746695198298;4383.342498625232;4771.71369717818;4772.377391686843;4809.567138957511;4491.438570178728;4510.819567217406;4875.756212189447;5123.718195499283;5235.869103272448;2977.6129103216444;3002.894898678536;3486.337595856779;3491.0973519431464;3558.270554536262;4266.637335826489;4578.359029735773;4589.066026060899;4999.900002000012;5137.717425541481;4953.380827396575;4967.205247160437;4975.825846095369;5002.824901128589;5032.823851165338;4507.842225522091;4890.728410613195;4913.508649135058;4929.728864912464;4954.900901982012;4126.566710495475;4627.46784119817;4864.80812201013;4904.337914381513;5204.713740744295;5218.608604354765;5808.883822323614;5901.734421950937;5951.655291637216;5958.19564358806;5433.619646624857;5885.352611212677;5905.954421221477;5913.201717768218;5942.316633587193 15:06:39 INFO - PROCESS | 2101 | |5;yui.html;697.7278861244118;699.4334588982923;714.5534041224234;717.3615482220821;746.7796999885034;15073.698526029473;15612.2974466149;15621.68756624867;15717.52847414578;15748.448804291853;14089.43642254311;14177.291135443238;14212.928935355334;14217;14236.28818559073;687.3950923187613;701.2391555162654;836.0385556609887;841.5371545649899;861.2550144125349;869.2046777198856;869.4652788535069;871.5859966515918;873.4933738431727;875.6453636277317;909.9317551183688;913.8309412758628;914.0402577293848;914.9313801464916;918.9432153024009;884.6240347852137;896.5203616065406;905.483874191711;906.5467266366817;908.504864848659;662.9237637671681;667.4393509452084;679.2867489136437;679.8436359637311;680.4658343200613;14504.34730437133;14718.337674804552;14789.556313310617;14809.703805923822;15007;12805.615831525069;14851.480198193012;14897.702045959128;14935;14953.40186392543;11090.944545277303;11262.837713381114;11873.52505899763;11999.820002699966;12004.69988250292;3880.5343358796845;3889.727719059667;3923.6468717815533;4029.5567487576345;4056.4726585543985;78680.60659696722;91312.54343728305;92582;120842;121128.78871211351;9334.393264437926;11191.66425007251;11401.201915865975;11514.194006419637;11590.634973420696;22156.2245321413;22184.77815221827;22203.66694499584;22226.777732222796;22229.77770222277;7628.69485220596;7867.921320786833;7971.163027882105;7982.640781164861;8189.385796065319;4195.811188496464;4541;4542.3413605027745;4662.230731929261;4672.602828759525;3209.6950789674943;3313.9668603313658;3319.68462996015;3360.7143392811395;3361;604.5888795618934;648.3710800523485;662.6057495789997;663.2087424770317;669.2872091222929;572.5448268626369;609;627.4290395739855;635.8251480842805;646.6475770704977;8882.15619516145;8913.197812196933;8955.105284068439;9023.819523609622;9300.34897557178;553.8479961679697;594.8542607061211;594.9434803693642;634.8000379880323;637.2862394118524;4145.937810932778;4183.707140500197;4195.202911446815;4438.201123797683;4468.620167285752;78659;102967;146846.26576867048;150379;183486;131780;132181;134992;135284.32357838147;139181;103583.96416035894;106318.46840765746;107546;117516;117550;8091.716789912325;9876.753081173028;9982.35114717541;10027.348222365814;10164.48105108629;46544;59796.70101649464;62440;62909.68545157428;63388.73222535616;88596.5570172145;94713;96682.51658741942;97673;97935.51032244794;11438.885611143782;13206.537771177962;13361.13152645075;13368.331583420595;13433.865661343261;15059.548213553611;15176;15186.164760937812;15448.459303924308;15594.688106238038;13947;14020.719585608434;14282.42870285177;14305.427782888568;14476.420943162155;11086.833697494383;13809.585712428643;13923.651908701959;13924.651883702989;13931.233782142079;13021.804672929724;13611.319434028457;13613.047086704231;13661.385237664528;13811.585652430444;11257.26827756226;11361.147913906325;11481.82777258325;11488.54045838157;12168.817467738168;7475.36459400957;10612.740463561136;10917.727056823644;10931.726706832393;11619.709507262049 15:06:39 INFO - PROCESS | 2101 | __end_tp_report 15:06:39 INFO - PROCESS | 2101 | __start_cc_report 15:06:39 INFO - PROCESS | 2101 | _x_x_mozilla_cycle_collect,415 15:06:39 INFO - PROCESS | 2101 | __end_cc_report 15:06:39 INFO - PROCESS | 2101 | __startTimestamp1470693999407__endTimestamp 15:06:39 INFO - PROCESS | 2101 | 15:06:39 INFO - PROCESS | 2101 | ------- Summary: start ------- 15:06:39 INFO - PROCESS | 2101 | Number of tests: 6 15:06:39 INFO - PROCESS | 2101 | 15:06:39 INFO - PROCESS | 2101 | [#0] dojo.html Cycles:165 Average:5819.96 Median:6013.97 stddev:633.51 (10.5%) stddev-sans-first:607.02 15:06:39 INFO - PROCESS | 2101 | Values: 3427.7 3439.1 3445.6 3461.3 3465.1 5670.5 5834.0 5873.9 5943.1 5943.1 5812.7 5846.2 5946.6 5970.3 5977.8 5266.2 5300.4 5303.1 5405.4 5429.4 5422.4 5431.8 5440.1 5475.8 5499.2 5188.6 5331.2 5365.7 5371.7 5407.8 5227.4 5248.4 5293.6 5313.8 5320.5 5207.0 5235.5 5292.0 5315.1 5351.7 5769.0 5829.4 5885.0 5928.4 5934.6 6194.2 6218.4 6251.8 6276.6 6282.1 6268.8 6308.5 6316.5 6320.8 6329.8 5828.4 5939.4 5940.4 5967.3 5984.3 6395.7 6415.8 6421.6 6449.9 6455.7 6247.4 6249.6 6275.3 6278.3 6297.0 6188.5 6201.4 6212.4 6269.0 6280.8 6156.3 6208.3 6212.5 6214.2 6244.8 6195.9 6201.8 6211.3 6235.6 6252.4 4979.6 5032.2 5061.3 5094.4 5151.8 4492.2 4556.5 4558.6 4591.6 4637.2 4979.3 5824.8 5914.3 5954.7 6014.0 6143.0 6170.9 6206.2 6294.5 6384.5 5904.4 5910.1 5919.1 5929.8 5954.6 5509.5 5525.2 5557.8 5591.1 5601.0 6267.6 6323.3 6342.7 6440.5 6456.4 6247.0 6255.9 6278.1 6308.1 6368.9 6427.6 6447.7 6490.4 6503.6 6516.5 6168.5 6198.9 6231.7 6231.9 6277.1 6190.2 6252.1 6260.6 6272.2 6287.2 6215.7 6231.3 6246.2 6257.8 6288.9 4978.9 6127.3 6136.9 6168.5 6225.7 5119.3 5622.1 5799.7 5987.4 6098.5 5020.6 6200.6 6227.4 6247.4 6263.6 5159.7 5944.8 6050.4 6059.2 6080.6 15:06:39 INFO - PROCESS | 2101 | 15:06:39 INFO - PROCESS | 2101 | [#1] ext.html Cycles:180 Average:68378.21 Median:39915.90 stddev:152550.60 (382.2%) stddev-sans-first:152893.33 15:06:39 INFO - PROCESS | 2101 | Values: 468.5 484.5 486.6 532.6 558.7 31437.4 41788.4 41826.6 41833.8 41887.4 42534.6 42873.6 42984.4 42985.9 43150.8 9534.4 9725.9 9726.6 9767.0 9769.1 9634.4 9720.8 9721.5 9724.1 9728.4 9709.5 9715.0 9724.9 9728.6 9765.5 9694.1 9704.4 9726.9 9735.6 9767.6 9461.3 9556.5 9587.4 9598.5 9614.3 39725.4 39948.0 40011.8 40081.8 40132.4 3036.6 3250.2 3283.8 3386.4 3399.8 24175.5 30698.4 30702.8 31100.4 31245.8 3111.6 3143.8 3153.4 3175.8 3263.9 388385.0 445691.0 458392.0 458878.0 459173.7 29102.7 33856.0 33944.8 34005.8 34076.8 34677.7 34718.3 35094.6 35166.8 35663.6 15955.4 16562.3 16591.3 16594.1 16670.2 12574.6 12669.9 12712.6 12740.4 12752.7 19097.5 19229.8 19393.0 19418.2 19467.0 8239.5 8287.8 8364.2 8369.1 8386.5 868.6 920.3 970.6 982.5 1032.5 30439.4 30525.4 30738.8 31582.5 32084.0 1087.9 1106.8 1108.2 1139.0 1145.6 13596.9 15861.0 15933.9 15956.2 16291.3 583680.0 674480.0 677989.0 682014.0 685191.0 51540.7 60393.7 60705.7 61079.7 61247.0 1324.8 1362.2 1377.1 1396.4 1401.2 29991.0 30124.2 30295.5 30386.7 30519.2 44343.8 52104.5 52419.0 52689.0 52730.5 502609.0 600857.0 600862.0 601232.0 602359.0 26957.6 27430.5 27443.6 27463.6 27465.6 39350.2 48896.0 49181.8 50407.7 50617.5 40019.0 40063.0 40308.0 40486.0 41400.6 33412.8 39202.4 40793.6 40983.4 41306.8 35493.6 38333.4 38588.8 39883.8 40119.8 31904.4 35795.0 35961.6 36294.6 36547.7 25750.5 25987.0 26171.6 26524.6 26550.0 15:06:39 INFO - PROCESS | 2101 | 15:06:39 INFO - PROCESS | 2101 | [#2] jquery.html Cycles:180 Average:36066.01 Median:22303.72 stddev:103585.34 (464.4%) stddev-sans-first:103841.24 15:06:39 INFO - PROCESS | 2101 | Values: 367.8 383.6 387.7 395.3 403.3 19224.1 21510.4 22114.0 22218.9 22249.1 18242.2 20752.7 21355.3 21503.1 21504.6 4961.3 5928.2 5954.1 6014.1 6053.3 3856.1 5121.8 5284.7 5932.6 6117.7 6120.3 6142.0 6142.2 6162.9 6170.3 5703.1 5816.7 6205.2 6727.8 6839.2 5095.9 5111.1 5150.4 5165.6 5181.0 12977.5 13180.8 17610.1 24036.0 25245.5 2077.1 2154.7 2156.9 2161.5 2172.9 9978.8 9999.3 10185.0 10370.6 10419.9 1661.7 1697.4 1761.0 1801.6 1846.6 93171.0 120551.4 130496.4 131481.0 134207.0 11255.4 11484.5 11687.4 11773.0 11827.2 14739.1 14744.3 14751.9 14761.0 14827.2 8266.7 8562.4 8618.1 8663.4 8706.3 7148.6 8399.0 8489.9 8520.9 8594.6 3811.3 3820.7 3897.5 4552.6 4702.0 1591.5 1676.4 1691.0 1888.4 1939.8 844.8 902.4 903.2 912.7 971.4 21863.0 22173.2 22358.3 22378.0 22437.9 922.1 927.7 933.7 965.2 1070.4 10934.9 11045.8 11581.0 11587.9 11652.1 601782.0 616221.0 621967.0 623343.0 625639.0 142822.0 144207.0 144572.0 145042.0 145801.0 954.8 981.9 1001.9 1006.3 1011.6 18920.4 19509.8 19638.8 19651.6 19673.8 38229.6 52330.2 53570.5 55309.0 55562.2 81735.0 82144.4 82343.0 82413.0 82511.2 7376.8 7561.4 7585.2 7610.8 7655.7 10608.6 11438.4 12580.7 13233.2 13266.3 11107.7 11276.2 11379.5 11391.2 11640.2 10001.1 10350.9 11100.6 11269.2 11429.2 11226.2 11332.9 11709.8 11727.5 11732.8 7327.8 7428.7 7483.2 7500.0 7555.2 10262.7 11026.3 11152.6 11435.7 11494.0 15:06:39 INFO - PROCESS | 2101 | 15:06:39 INFO - PROCESS | 2101 | [#3] mootools.html Cycles:180 Average:5716.24 Median:4840.30 stddev:3226.71 (66.7%) stddev-sans-first:3220.53 15:06:39 INFO - PROCESS | 2101 | Values: 1543.5 1552.9 1565.0 1864.1 1875.1 7814.0 8301.7 8451.5 8828.9 8875.2 8515.6 8711.9 8731.3 8748.8 8751.4 2326.1 2365.7 2370.0 2371.5 2376.9 2342.9 2345.2 2377.4 2382.0 2390.2 2343.8 2362.0 2367.2 2380.4 2386.6 2320.2 2322.8 2336.9 2341.1 2342.2 2284.8 2318.9 2329.3 2330.2 2331.7 8820.0 8826.0 8860.6 8894.6 8915.6 5089.2 5182.2 5283.8 5291.2 5310.9 3087.9 3464.9 3628.3 3667.0 3682.4 1062.8 1095.7 1106.9 1123.1 1125.6 11514.0 11537.5 11618.2 11656.9 11659.0 4510.5 4688.1 4790.7 4795.6 4809.3 9946.2 9947.3 9951.5 9954.0 9961.8 5297.6 5298.0 5300.6 5307.2 5308.9 3581.4 4311.6 4789.9 4835.2 4845.4 3063.8 3859.2 3936.0 3964.7 4061.8 1271.3 1284.5 1292.6 1298.6 1300.6 828.0 895.2 906.6 920.0 947.9 5144.7 5731.7 5968.4 6054.0 6288.2 447.5 457.7 457.9 1008.2 1027.1 3926.5 3945.7 4003.9 4073.8 4117.8 10545.7 10937.7 10955.5 10963.7 10989.3 9346.0 10872.4 10890.2 10896.6 10901.0 8061.7 8073.2 8193.0 8281.8 8336.0 5741.5 5754.4 5893.4 5905.1 5975.0 9927.6 10064.0 10184.0 10204.6 10225.9 9649.4 10110.5 10227.4 10297.8 10358.9 6984.2 7393.2 7471.7 7575.7 7729.7 8451.5 8510.2 8517.5 8534.0 8568.9 7445.7 7474.7 7598.6 7683.4 7720.8 7426.4 7497.6 7509.0 7637.2 7679.8 6913.1 7047.9 7052.6 7059.1 7077.0 4919.8 4929.8 5022.9 5086.5 5117.3 4932.8 5046.4 5135.7 5153.1 5161.0 15:06:39 INFO - PROCESS | 2101 | 15:06:39 INFO - PROCESS | 2101 | [#4] prototype.html Cycles:180 Average:4390.42 Median:4768.33 stddev:1350.57 (28.3%) stddev-sans-first:1318.85 15:06:39 INFO - PROCESS | 2101 | Values: 291.3 300.2 307.7 308.9 310.5 5252.4 5409.5 5435.9 5539.1 5647.8 4229.0 4370.8 4629.6 5587.8 5632.9 4202.9 4233.6 4287.0 4306.1 4317.6 3574.4 3891.5 4111.2 4265.9 4333.4 3449.9 4085.9 4111.3 4127.0 4137.2 3498.7 3622.7 4074.5 4178.0 4208.9 3567.7 3602.3 3603.7 3625.7 3630.4 4155.4 4376.1 4474.7 5425.8 5491.0 4017.1 4392.3 4759.8 4765.0 4811.8 5385.5 5847.9 5908.3 5923.3 5953.4 3777.5 3827.9 3903.9 3904.4 3964.5 5666.6 6228.5 6235.1 6267.5 6286.8 4004.4 4008.5 4008.9 4020.8 4021.3 3712.4 3998.6 4064.9 4075.7 4088.9 4511.6 4749.6 4779.5 4783.9 4833.5 4850.6 5925.4 5931.3 5951.5 5999.7 1094.9 1282.8 1343.3 1365.6 1378.6 887.7 900.7 913.7 920.4 929.4 4244.6 5145.0 5318.3 5445.5 5461.8 5705.5 5966.7 5967.7 5969.1 5986.5 4546.8 4709.8 4856.9 5375.9 5436.6 2370.0 2399.8 2606.7 2716.7 2724.7 4271.0 4928.5 4956.0 5291.7 5307.4 3952.7 4891.7 5209.5 5240.3 5270.9 4325.0 4890.2 5151.5 5158.8 5180.9 4491.0 4505.8 4653.7 5072.0 5123.8 4221.7 4383.3 4771.7 4772.4 4809.6 4491.4 4510.8 4875.8 5123.7 5235.9 2977.6 3002.9 3486.3 3491.1 3558.3 4266.6 4578.4 4589.1 4999.9 5137.7 4953.4 4967.2 4975.8 5002.8 5032.8 4507.8 4890.7 4913.5 4929.7 4954.9 4126.6 4627.5 4864.8 4904.3 5204.7 5218.6 5808.9 5901.7 5951.7 5958.2 5433.6 5885.4 5906.0 5913.2 5942.3 15:06:39 INFO - PROCESS | 2101 | 15:06:39 INFO - PROCESS | 2101 | [#5] yui.html Cycles:180 Average:24364.80 Median:3620.77 stddev:38890.18 (1074.1%) stddev-sans-first:38958.67 15:06:39 INFO - PROCESS | 2101 | Values: 697.7 699.4 714.6 717.4 746.8 15073.7 15612.3 15621.7 15717.5 15748.4 14089.4 14177.3 14212.9 14217.0 14236.3 687.4 701.2 836.0 841.5 861.3 869.2 869.5 871.6 873.5 875.6 909.9 913.8 914.0 914.9 918.9 884.6 896.5 905.5 906.5 908.5 662.9 667.4 679.3 679.8 680.5 14504.3 14718.3 14789.6 14809.7 15007.0 12805.6 14851.5 14897.7 14935.0 14953.4 11090.9 11262.8 11873.5 11999.8 12004.7 3880.5 3889.7 3923.6 4029.6 4056.5 78680.6 91312.5 92582.0 120842.0 121128.8 9334.4 11191.7 11401.2 11514.2 11590.6 22156.2 22184.8 22203.7 22226.8 22229.8 7628.7 7867.9 7971.2 7982.6 8189.4 4195.8 4541.0 4542.3 4662.2 4672.6 3209.7 3314.0 3319.7 3360.7 3361.0 604.6 648.4 662.6 663.2 669.3 572.5 609.0 627.4 635.8 646.6 8882.2 8913.2 8955.1 9023.8 9300.3 553.8 594.9 594.9 634.8 637.3 4145.9 4183.7 4195.2 4438.2 4468.6 78659.0 102967.0 146846.3 150379.0 183486.0 131780.0 132181.0 134992.0 135284.3 139181.0 103584.0 106318.5 107546.0 117516.0 117550.0 8091.7 9876.8 9982.4 10027.3 10164.5 46544.0 59796.7 62440.0 62909.7 63388.7 88596.6 94713.0 96682.5 97673.0 97935.5 11438.9 13206.5 13361.1 13368.3 13433.9 15059.5 15176.0 15186.2 15448.5 15594.7 13947.0 14020.7 14282.4 14305.4 14476.4 11086.8 13809.6 13923.7 13924.7 13931.2 13021.8 13611.3 13613.0 13661.4 13811.6 11257.3 11361.1 11481.8 11488.5 12168.8 7475.4 10612.7 10917.7 10931.7 11619.7 15:06:39 INFO - PROCESS | 2101 | -------- Summary: end -------- 15:06:39 INFO - PROCESS | 2101 | 15:06:40 INFO - TEST-INFO | 2101: exit 0 15:06:40 INFO - TEST-OK | dromaeo_css | took 1113945ms 15:06:40 INFO - TEST-START | kraken 15:06:40 INFO - operating with platform_type : mac_ 15:06:40 INFO - Initialising browser for kraken test... 15:06:40 INFO - TEST-INFO | started process 2221 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/tmp3zf6tw/profile http://localhost:49657/getInfo.html) 15:06:42 INFO - PROCESS | 2221 | __metrics Screen width/height:1600/1200 15:06:42 INFO - PROCESS | 2221 | colorDepth:24 15:06:42 INFO - PROCESS | 2221 | Browser inner width/height: 1024/689 15:06:42 INFO - PROCESS | 2221 | __metrics 15:06:42 ERROR - PROCESS | 2221 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 15:06:43 INFO - TEST-INFO | 2221: exit 0 15:06:43 INFO - Browser initialized. 15:06:43 INFO - Running cycle 1/1 for kraken test... 15:06:43 INFO - TEST-INFO | started process 2223 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/tmp3zf6tw/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:06:55 INFO - PROCESS | 2223 | RSS: Main: 254771200 15:06:55 INFO - PROCESS | 2223 | 15:06:58 INFO - PROCESS | 2223 | Cycle 1(1): loaded http://localhost:49657/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49657/tests/kraken/driver.html?testName=audio-beat-detection) 15:06:59 INFO - PROCESS | 2223 | RSS: Main: 267595776 15:06:59 INFO - PROCESS | 2223 | 15:07:02 INFO - PROCESS | 2223 | Cycle 1(1): loaded http://localhost:49657/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49657/tests/kraken/driver.html?testName=audio-dft) 15:07:02 INFO - PROCESS | 2223 | RSS: Main: 276267008 15:07:02 INFO - PROCESS | 2223 | 15:07:06 INFO - PROCESS | 2223 | Cycle 1(1): loaded http://localhost:49657/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49657/tests/kraken/driver.html?testName=audio-fft) 15:07:06 INFO - PROCESS | 2223 | RSS: Main: 279281664 15:07:06 INFO - PROCESS | 2223 | 15:07:08 INFO - PROCESS | 2223 | Cycle 1(1): loaded http://localhost:49657/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49657/tests/kraken/driver.html?testName=audio-oscillator) 15:07:09 INFO - PROCESS | 2223 | RSS: Main: 280494080 15:07:09 INFO - PROCESS | 2223 | 15:07:11 INFO - PROCESS | 2223 | Cycle 1(1): loaded http://localhost:49657/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49657/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:07:12 INFO - PROCESS | 2223 | RSS: Main: 280977408 15:07:12 INFO - PROCESS | 2223 | 15:07:15 INFO - PROCESS | 2223 | Cycle 1(1): loaded http://localhost:49657/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49657/tests/kraken/driver.html?testName=imaging-darkroom) 15:07:15 INFO - PROCESS | 2223 | RSS: Main: 282284032 15:07:15 INFO - PROCESS | 2223 | 15:07:18 INFO - PROCESS | 2223 | Cycle 1(1): loaded http://localhost:49657/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49657/tests/kraken/driver.html?testName=imaging-desaturate) 15:07:19 INFO - PROCESS | 2223 | RSS: Main: 281997312 15:07:19 INFO - PROCESS | 2223 | 15:07:22 INFO - PROCESS | 2223 | Cycle 1(1): loaded http://localhost:49657/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49657/tests/kraken/driver.html?testName=json-parse-financial) 15:07:22 INFO - PROCESS | 2223 | RSS: Main: 282984448 15:07:22 INFO - PROCESS | 2223 | 15:07:24 INFO - PROCESS | 2223 | Cycle 1(1): loaded http://localhost:49657/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49657/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:07:24 INFO - PROCESS | 2223 | RSS: Main: 282648576 15:07:24 INFO - PROCESS | 2223 | 15:07:26 INFO - PROCESS | 2223 | Cycle 1(1): loaded http://localhost:49657/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49657/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:07:27 INFO - PROCESS | 2223 | RSS: Main: 282943488 15:07:27 INFO - PROCESS | 2223 | 15:07:29 INFO - PROCESS | 2223 | Cycle 1(1): loaded http://localhost:49657/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49657/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:07:30 INFO - PROCESS | 2223 | RSS: Main: 282980352 15:07:30 INFO - PROCESS | 2223 | 15:07:33 INFO - PROCESS | 2223 | Cycle 1(1): loaded http://localhost:49657/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49657/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:07:33 INFO - PROCESS | 2223 | RSS: Main: 282992640 15:07:33 INFO - PROCESS | 2223 | 15:07:36 INFO - PROCESS | 2223 | Cycle 1(1): loaded http://localhost:49657/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49657/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:07:37 INFO - PROCESS | 2223 | RSS: Main: 283152384 15:07:37 INFO - PROCESS | 2223 | 15:07:39 INFO - PROCESS | 2223 | Cycle 1(1): loaded http://localhost:49657/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49657/tests/kraken/driver.html?testName=ai-astar) 15:07:39 INFO - PROCESS | 2223 | RSS: Main: 284127232 15:07:39 INFO - PROCESS | 2223 | 15:07:39 INFO - PROCESS | 2223 | __start_tp_report 15:07:39 INFO - PROCESS | 2223 | _x_x_mozilla_page_load 15:07:39 INFO - PROCESS | 2223 | _x_x_mozilla_page_load_details 15:07:39 INFO - PROCESS | 2223 | |i|pagename|runs| 15:07:39 INFO - PROCESS | 2223 | |0;ai-astar;104;119;107;120;119;118;115;118;140;171 15:07:39 INFO - PROCESS | 2223 | |1;audio-beat-detection;146;125;166;166;109;140;161;95;179;140 15:07:39 INFO - PROCESS | 2223 | |2;audio-dft;205;217;215;199;194;195;196;204;199;195 15:07:39 INFO - PROCESS | 2223 | |3;audio-fft;56;98;107;138;83;81;86;67;141;88 15:07:39 INFO - PROCESS | 2223 | |4;audio-oscillator;73;73;140;58;91;71;116;57;71;128 15:07:39 INFO - PROCESS | 2223 | |5;imaging-gaussian-blur;92;88;137;116;91;90;93;89;91;88 15:07:39 INFO - PROCESS | 2223 | |6;imaging-darkroom;96;97;99;96;99;97;97;96;97;118 15:07:39 INFO - PROCESS | 2223 | |7;imaging-desaturate;107;98;91;92;95;91;92;96;91;97 15:07:39 INFO - PROCESS | 2223 | |8;json-parse-financial;57;57;57;56;55;59;57;56;58;56 15:07:39 INFO - PROCESS | 2223 | |9;json-stringify-tinderbox;68;70;70;76;76;76;80;70;72;69 15:07:39 INFO - PROCESS | 2223 | |10;stanford-crypto-aes;90;83;88;85;85;73;91;109;103;108 15:07:39 INFO - PROCESS | 2223 | |11;stanford-crypto-ccm;139;136;138;138;150;140;137;137;168;152 15:07:39 INFO - PROCESS | 2223 | |12;stanford-crypto-pbkdf2;167;169;163;171;160;176;222;228;167;170 15:07:39 INFO - PROCESS | 2223 | |13;stanford-crypto-sha256-iterative;69;66;68;66;69;67;68;67;85;84 15:07:39 INFO - PROCESS | 2223 | __end_tp_report 15:07:39 INFO - PROCESS | 2223 | __start_cc_report 15:07:39 INFO - PROCESS | 2223 | _x_x_mozilla_cycle_collect,1059 15:07:39 INFO - PROCESS | 2223 | __end_cc_report 15:07:39 INFO - PROCESS | 2223 | __startTimestamp1470694059548__endTimestamp 15:07:39 INFO - PROCESS | 2223 | 15:07:39 INFO - PROCESS | 2223 | ------- Summary: start ------- 15:07:39 INFO - PROCESS | 2223 | Number of tests: 14 15:07:39 INFO - PROCESS | 2223 | 15:07:39 INFO - PROCESS | 2223 | [#0] ai-astar Cycles:10 Average:123.10 Median:119.00 stddev:19.34 (16.2%) stddev-sans-first:19.23 15:07:39 INFO - PROCESS | 2223 | Values: 104.0 119.0 107.0 120.0 119.0 118.0 115.0 118.0 140.0 171.0 15:07:39 INFO - PROCESS | 2223 | 15:07:39 INFO - PROCESS | 2223 | [#1] audio-beat-detection Cycles:10 Average:142.70 Median:163.50 stddev:26.85 (16.4%) stddev-sans-first:28.45 15:07:39 INFO - PROCESS | 2223 | Values: 146.0 125.0 166.0 166.0 109.0 140.0 161.0 95.0 179.0 140.0 15:07:39 INFO - PROCESS | 2223 | 15:07:39 INFO - PROCESS | 2223 | [#2] audio-dft Cycles:10 Average:201.90 Median:201.50 stddev:8.32 (4.1%) stddev-sans-first:8.75 15:07:39 INFO - PROCESS | 2223 | Values: 205.0 217.0 215.0 199.0 194.0 195.0 196.0 204.0 199.0 195.0 15:07:39 INFO - PROCESS | 2223 | 15:07:39 INFO - PROCESS | 2223 | [#3] audio-fft Cycles:10 Average:94.50 Median:82.00 stddev:27.67 (33.7%) stddev-sans-first:25.60 15:07:39 INFO - PROCESS | 2223 | Values: 56.0 98.0 107.0 138.0 83.0 81.0 86.0 67.0 141.0 88.0 15:07:39 INFO - PROCESS | 2223 | 15:07:39 INFO - PROCESS | 2223 | [#4] audio-oscillator Cycles:10 Average:87.80 Median:71.00 stddev:29.79 (42.0%) stddev-sans-first:31.11 15:07:39 INFO - PROCESS | 2223 | Values: 73.0 73.0 140.0 58.0 91.0 71.0 116.0 57.0 71.0 128.0 15:07:39 INFO - PROCESS | 2223 | 15:07:39 INFO - PROCESS | 2223 | [#5] imaging-gaussian-blur Cycles:10 Average:97.50 Median:90.50 stddev:16.15 (17.8%) stddev-sans-first:17.00 15:07:39 INFO - PROCESS | 2223 | Values: 92.0 88.0 137.0 116.0 91.0 90.0 93.0 89.0 91.0 88.0 15:07:39 INFO - PROCESS | 2223 | 15:07:39 INFO - PROCESS | 2223 | [#6] imaging-darkroom Cycles:10 Average:99.20 Median:97.00 stddev:6.70 (6.9%) stddev-sans-first:7.00 15:07:39 INFO - PROCESS | 2223 | Values: 96.0 97.0 99.0 96.0 99.0 97.0 97.0 96.0 97.0 118.0 15:07:39 INFO - PROCESS | 2223 | 15:07:39 INFO - PROCESS | 2223 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:93.50 stddev:4.99 (5.3%) stddev-sans-first:2.83 15:07:39 INFO - PROCESS | 2223 | Values: 107.0 98.0 91.0 92.0 95.0 91.0 92.0 96.0 91.0 97.0 15:07:39 INFO - PROCESS | 2223 | 15:07:39 INFO - PROCESS | 2223 | [#8] json-parse-financial Cycles:10 Average:56.80 Median:57.00 stddev:1.14 (2.0%) stddev-sans-first:1.20 15:07:39 INFO - PROCESS | 2223 | Values: 57.0 57.0 57.0 56.0 55.0 59.0 57.0 56.0 58.0 56.0 15:07:39 INFO - PROCESS | 2223 | 15:07:39 INFO - PROCESS | 2223 | [#9] json-stringify-tinderbox Cycles:10 Average:72.70 Median:74.00 stddev:4.00 (5.4%) stddev-sans-first:3.87 15:07:39 INFO - PROCESS | 2223 | Values: 68.0 70.0 70.0 76.0 76.0 76.0 80.0 70.0 72.0 69.0 15:07:39 INFO - PROCESS | 2223 | 15:07:39 INFO - PROCESS | 2223 | [#10] stanford-crypto-aes Cycles:10 Average:91.50 Median:85.00 stddev:11.66 (13.7%) stddev-sans-first:12.36 15:07:39 INFO - PROCESS | 2223 | Values: 90.0 83.0 88.0 85.0 85.0 73.0 91.0 109.0 103.0 108.0 15:07:39 INFO - PROCESS | 2223 | 15:07:39 INFO - PROCESS | 2223 | [#11] stanford-crypto-ccm Cycles:10 Average:143.50 Median:139.50 stddev:10.27 (7.4%) stddev-sans-first:10.76 15:07:39 INFO - PROCESS | 2223 | Values: 139.0 136.0 138.0 138.0 150.0 140.0 137.0 137.0 168.0 152.0 15:07:39 INFO - PROCESS | 2223 | 15:07:39 INFO - PROCESS | 2223 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:179.30 Median:170.50 stddev:24.51 (14.4%) stddev-sans-first:25.59 15:07:39 INFO - PROCESS | 2223 | Values: 167.0 169.0 163.0 171.0 160.0 176.0 222.0 228.0 167.0 170.0 15:07:39 INFO - PROCESS | 2223 | 15:07:39 INFO - PROCESS | 2223 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.90 Median:68.50 stddev:7.25 (10.6%) stddev-sans-first:7.66 15:07:39 INFO - PROCESS | 2223 | Values: 69.0 66.0 68.0 66.0 69.0 67.0 68.0 67.0 85.0 84.0 15:07:39 INFO - PROCESS | 2223 | -------- Summary: end -------- 15:07:39 INFO - PROCESS | 2223 | 15:07:40 INFO - TEST-INFO | 2223: exit 0 15:07:40 INFO - TEST-OK | kraken | took 60359ms 15:07:40 INFO - SUITE-END | took 1174s 15:07:40 INFO - Completed test suite (00:19:34) 15:07:40 INFO - javascript benchmark 15:07:40 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7288.336638761006, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3427.7429192810528, 3439.105832483554, 3445.5865296164466, 3461.3077384523094, 3465.0817533353666, 5670.4896559309655, 5834.0, 5873.911891321628, 5943.138244954484, 5943.13824495449, 5812.680302583356, 5846.21076154719, 5946.583739138262, 5970.313413957396, 5977.790777322794, 5266.157414813631, 5300.443453437391, 5303.124984377573, 5405.4324295948945, 5429.429909859467, 5422.376426710939, 5431.755570999315, 5440.129579267318, 5475.753591088411, 5499.175123731432, 5188.6367954243215, 5331.2269720890645, 5365.678059316453, 5371.650842695212, 5407.83776486704, 5227.424983251839, 5248.370195576517, 5293.57651387888, 5313.840584782462, 5320.547753440962, 5206.973965130188, 5235.476452354734, 5291.973540132275, 5315.149576067849, 5351.7056561889085, 5768.97115514424, 5829.417058294179, 5885.0, 5928.40715928408, 5934.5845790794665, 6194.194754681907, 6218.440340369389, 6251.843703907393, 6276.560640755149, 6282.089097080898, 6268.843278918063, 6308.526860485482, 6316.526260530432, 6320.841978950517, 6329.810105696836, 5828.358880523139, 5939.4357536034, 5940.405959404025, 5967.343592204854, 5984.281886173643, 6395.744170233139, 6415.839604009844, 6421.550491465552, 6449.871002580016, 6455.709493072823, 6247.406496382836, 6249.593776404519, 6275.309715931244, 6278.277998030194, 6296.968515157395, 6188.504919606421, 6201.441870231701, 6212.378762123752, 6268.968655156787, 6280.842978925563, 6156.26124865019, 6208.317085120633, 6212.502999760009, 6214.161088253119, 6244.781432649836, 6195.907061394083, 6201.81394558164, 6211.2857021443115, 6235.625862448268, 6252.406021428048, 4979.601631869442, 5032.194848824171, 5061.342025536656, 5094.388673359221, 5151.7681704323395, 4492.191405546968, 4556.544345565417, 4558.635309175258, 4591.563801438925, 4637.1653102441205, 4979.30289759434, 5824.796132135355, 5914.349421563625, 5954.732037058343, 6013.9699301503215, 6143.020634992025, 6170.938290617126, 6206.162168107247, 6294.496440284766, 6384.52116091295, 5904.4095590441475, 5910.143029260733, 5919.112133180058, 5929.762809487658, 5954.55340849438, 5509.5041446270025, 5525.237381309345, 5557.805476808292, 5591.077472217039, 5601.0, 6267.62394256346, 6323.272823625342, 6342.714577843916, 6440.452561532322, 6456.386643268976, 6246.969250073687, 6255.874882502416, 6278.058291256348, 6308.116863639002, 6368.917284061813, 6427.58220715652, 6447.70985305653, 6490.415862572391, 6503.577267477599, 6516.478681705357, 6168.506519478521, 6198.907016394848, 6231.688415579293, 6231.937680623136, 6277.089821975696, 6190.195274614452, 6252.062190671254, 6260.593061450991, 6272.2159730033745, 6287.151234583455, 6215.689215539295, 6231.2522497300615, 6246.219222597176, 6257.843553911189, 6288.905666414916, 4978.85486338137, 6127.264728232641, 6136.917362303726, 6168.506519478341, 6225.688715564294, 5119.334486516729, 5622.100463925753, 5799.652020878761, 5987.43119403656, 6098.512119030555, 5020.6234532410945, 6200.596961197508, 6227.439530442282, 6247.375262473716, 6263.592866463665, 5159.664621799571, 5944.791932282349, 6050.364711705208, 6059.182010428536, 6080.635161890301], "value": 5781.817327265326, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [468.4542507978206, 484.479184876258, 486.55237181792756, 532.6165161084018, 558.701094914221, 31437.371252574965, 41788.37317440241, 41826.58173418265, 41833.7908310458, 41887.37168942468, 42534.57465425345, 42873.57126428735, 42984.35523467151, 42985.850707464655, 43150.7842460788, 9534.380265282769, 9725.902740972571, 9726.610935562605, 9767.0, 9769.120779129877, 9634.373765705242, 9720.75698107546, 9721.465319407429, 9724.076212759812, 9728.367656102331, 9709.514524273793, 9715.028497150264, 9724.902750972506, 9728.610855565768, 9765.462899540522, 9694.079062489052, 9704.369216000938, 9726.854097188549, 9735.561899714494, 9767.609295628166, 9461.290403219786, 9556.522173891277, 9587.376820506644, 9598.472084035375, 9614.326997110205, 39725.40411893824, 39948.0, 40011.799646010666, 40081.79959100215, 40132.398014029815, 3036.635603727567, 3250.2199472126754, 3283.819389933553, 3386.373520898642, 3399.779014364083, 24175.516489670284, 30698.386032279228, 30702.84648576765, 31100.42368029297, 31245.843770781226, 3111.595492585949, 3143.811371317728, 3153.369326134782, 3175.7935734177204, 3263.8694452221885, 388385.0, 445691.0, 458392.0, 458878.0, 459173.70413148054, 29102.690378933, 33856.0, 33944.83027584896, 34005.80979665749, 34076.82961585226, 34677.65322346795, 34718.30563388718, 35094.649053509645, 35166.82416587901, 35663.64336356603, 15955.441559545592, 16562.254698538596, 16591.25339359732, 16594.08732519723, 16670.249838757285, 12574.559890403792, 12669.93665031669, 12712.555060572835, 12740.36298185087, 12752.744945101045, 19097.522561936064, 19229.80770192308, 19393.03034848252, 19418.223271069, 19467.0, 8239.464434811718, 8287.792805179799, 8364.205400486944, 8369.070825211249, 8386.496810191407, 868.5830801215326, 920.3143657974852, 970.5680971967407, 982.4645568165367, 1032.4579595712162, 30439.391212176077, 30525.405340546302, 30738.846305768777, 31582.526262106087, 32084.03747887567, 1087.9292845964987, 1106.8229083346625, 1108.2020944919645, 1138.980612351957, 1145.5966441109574, 13596.864031359757, 15861.048337099812, 15933.920330398505, 15956.202189890459, 16291.348346066025, 583680.0, 674480.0, 677989.0, 682014.0, 685191.0, 51540.74229628903, 60393.69803151044, 60705.69647151736, 61079.6946015276, 61247.0, 1324.8012798080172, 1362.1963041805382, 1377.0980008094514, 1396.4344440501613, 1401.2153194211273, 29991.0, 30124.24689382783, 30295.491444985637, 30386.69613303927, 30519.237019074702, 44343.77828110839, 52104.47895521148, 52419.0, 52689.0, 52730.47269527409, 502609.0, 600857.0, 600862.0, 601232.0, 602359.0, 26957.595636065867, 27430.451390972466, 27443.588346174423, 27463.588046178924, 27465.588016179372, 39350.2129957405, 48896.0, 49181.754091230745, 50407.747961259956, 50617.493825061276, 40019.0, 40063.0, 40308.0, 40486.0, 41400.58599413967, 33412.8305509306, 39202.41196381999, 40793.59206408016, 40983.38524922188, 41306.793466032475, 35493.58025678944, 38333.4249986256, 38588.842334730005, 39883.80058099691, 40119.799401002805, 31904.36191276115, 35795.0, 35961.58364955325, 36294.63705362913, 36547.72082977083, 25750.484990300465, 25987.0, 26171.607425888247, 26524.55302565294, 26550.0], "value": 19512.78450639722, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [367.7683059672406, 383.61063520526665, 387.7130923116894, 395.32004951483475, 403.28417059719015, 19224.134913928872, 21510.354689359305, 22114.0, 22218.88890555549, 22249.110035598576, 18242.17910194041, 20752.688709669328, 21355.252566160187, 21503.139874405006, 21504.569908601818, 4961.280614310923, 5928.199693041427, 5954.07711804671, 6014.127951447038, 6053.273607167146, 3856.093817952793, 5121.8463446096675, 5284.735763211824, 5932.6143800653035, 6117.69411529424, 6120.326764055951, 6141.969290153543, 6142.201513803199, 6162.876742465148, 6170.2904166021035, 5703.144528320744, 5816.720321529257, 6205.162303089093, 6727.764528241512, 6839.247682754893, 5095.8980820383385, 5111.08000559899, 5150.356205474316, 5165.586753059746, 5180.974095129538, 12977.545785897542, 13180.802287965687, 17610.12552342922, 24036.03855845764, 25245.49509009828, 2077.1276064053136, 2154.676798480225, 2156.91372345106, 2161.492049368397, 2172.858764180339, 9978.800423991552, 9999.250056245737, 10185.0, 10370.585176592927, 10419.947900260526, 1661.7258152404838, 1697.3804561335023, 1760.9698326479024, 1801.639672065592, 1846.5596834469136, 93171.0, 120551.39724301323, 130496.43262485863, 131481.0, 134207.0, 11255.380954047607, 11484.540618375171, 11687.415629218505, 11773.0, 11827.17209795306, 14739.115653060637, 14744.336504857307, 14751.92624036873, 14761.0, 14827.18450485212, 8266.669333226724, 8562.357823163287, 8618.052014278424, 8663.393562450568, 8706.347023973101, 7148.606826624586, 8399.034111077182, 8489.872651910226, 8520.8721869172, 8594.5702714864, 3811.3330167220624, 3820.6943444524372, 3897.4738410314812, 4552.590266875997, 4702.012577358793, 1591.5145880506557, 1676.3964972609851, 1690.9915450422668, 1888.4334699590343, 1939.776925653568, 844.7888027993001, 902.4359775140537, 903.1871315815687, 912.7124955638952, 971.4268581536927, 21863.0, 22173.22393716212, 22358.329250122522, 22377.992990315473, 22437.887810560842, 922.082527884759, 927.7031349967946, 933.6638810028385, 965.1795973422535, 1070.3898777696638, 10934.890651093547, 11045.837750017254, 11581.0, 11587.88412115885, 11652.126090543243, 601782.0, 616221.0, 621967.0, 623343.0, 625639.0, 142822.0, 144207.0, 144572.0, 145042.0, 145801.0, 954.7708549948102, 981.916537094355, 1001.8897921228659, 1006.3358183598936, 1011.5650270383805, 18920.43238702841, 19509.8049019508, 19638.821670699803, 19651.606967860276, 19673.80326196777, 38229.61770382261, 52330.168444104274, 53570.46429535655, 55309.0, 55562.166567502325, 81735.0, 82144.35711285622, 82343.0, 82413.0, 82511.17488825035, 7376.7786966391095, 7561.357284630868, 7585.241475852371, 7610.847783044419, 7655.6937722490475, 10608.628697995533, 11438.370889601152, 12580.748385032066, 13233.206007639572, 13266.27035513056, 11107.666769996913, 11276.154288428237, 11379.54481820751, 11391.202615816814, 11640.24338418034, 10001.099901008944, 10350.948245258725, 11100.61147859821, 11269.154813389192, 11429.199956003, 11226.21416500837, 11332.886671133512, 11709.824352634547, 11727.47226374798, 11732.824007640063, 7327.816804579928, 7428.665710043169, 7483.176850546327, 7499.962500187464, 7555.206703296075, 10262.692119236435, 11026.338419694523, 11152.553897843994, 11435.714107147387, 11494.0], "value": 9465.362850627871, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1543.5446543269734, 1552.8524790144938, 1564.9921750391247, 1864.058650381558, 1875.0718394394776, 7813.960930195355, 8301.66793328267, 8451.450655707375, 8828.911710882889, 8875.201231889137, 8515.574221288942, 8711.91288087119, 8731.345149113826, 8748.825023499527, 8751.431156974792, 2326.127702111708, 2365.66880636711, 2370.0, 2371.4664200554907, 2376.9168079117235, 2342.882855857209, 2345.2026311054237, 2377.3581133094053, 2382.0352757133387, 2390.1514962188435, 2343.824213184018, 2361.9763802362013, 2367.230650038736, 2380.4405964598304, 2386.6300723387903, 2320.1995311617466, 2322.7793359630978, 2336.9298921032396, 2341.1220792202926, 2342.16853017179, 2284.828637852168, 2318.9072437102664, 2329.301209637119, 2330.1611419888827, 2331.6825993313723, 8820.0, 8826.029136794947, 8860.645574177026, 8894.59974301158, 8915.55422228886, 5089.211172268304, 5182.170852663593, 5283.788648454057, 5291.232771248147, 5310.867228319323, 3087.8919237826794, 3464.8960531184107, 3628.2743451309843, 3666.981665091684, 3682.3739964206147, 1062.7661914378825, 1095.7151140703395, 1106.8505751723576, 1123.0959077942252, 1125.5779082843933, 11513.963743263146, 11537.48081336342, 11618.244814087057, 11656.88343116575, 11659.00898423635, 4510.526394728507, 4688.062387522509, 4790.688605240648, 4795.592374648194, 4809.326694262806, 9946.154576860903, 9947.303688741864, 9951.502424878727, 9954.0, 9961.750956226153, 5297.576193904479, 5297.973510132425, 5300.628955973122, 5307.150855863043, 5308.893822123536, 3581.3553560358864, 4311.568843115663, 4789.856304310876, 4835.178019736653, 4845.418549773979, 3063.7702172337163, 3859.2281543691374, 3935.960640393617, 3964.7312859885137, 4061.756294622332, 1271.2944315904576, 1284.5183056353867, 1292.6186774901428, 1298.6233992142172, 1300.63582196985, 827.954462504568, 895.1853813030242, 906.6328137104483, 919.9742287349557, 947.9478628675352, 5144.717040562805, 5731.684757338387, 5968.403159684084, 6053.969730151409, 6288.151099601587, 447.5166819834571, 457.7459509971931, 457.88781748471837, 1008.1732978957185, 1027.111548510548, 3926.509186351706, 3945.705336044435, 4003.91992160161, 4073.816678249486, 4117.75293482392, 10545.683629491128, 10937.671869843918, 10955.50700218492, 10963.671089867317, 10989.340639561651, 9345.953270233742, 10872.402017889091, 10890.183236257313, 10896.61861834832, 10901.0, 8061.717839875576, 8073.233042861037, 8192.959035204905, 8281.792955176048, 8336.0, 5741.483266506035, 5754.424557544212, 5893.351731309467, 5905.143754155709, 5974.970125149346, 9927.553260103457, 10064.043915827984, 10184.0, 10204.591816327264, 10225.948870255601, 9649.421034737938, 10110.545025474019, 10227.43749093807, 10297.794044118926, 10358.948205259227, 6984.196817366068, 7393.223711510214, 7471.663775130023, 7575.6969721210535, 7729.652165652672, 8451.535165565952, 8510.191531804468, 8517.488950662731, 8534.018587862476, 8568.91431085706, 7445.702171913063, 7474.701011959461, 7598.620068996639, 7683.385329173541, 7720.7683769487, 7426.443016773872, 7497.62511874415, 7509.0, 7637.159912409742, 7679.769606911802, 6913.1358580177475, 7047.929520704727, 7052.576845389293, 7059.117610298713, 7076.964615176891, 4919.803207871645, 4929.7535123244415, 5022.924656130234, 5086.54221120101, 5117.334746482933, 4932.802687892444, 5046.419661738947, 5135.6918584885025, 5153.149730294459, 5161.045206636634], "value": 4559.70124748115, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [291.27036772883935, 300.24787906294733, 307.70306654078814, 308.8888000319883, 310.469097842689, 5252.395974462943, 5409.459054094588, 5435.93999170161, 5539.058360078786, 5647.802326918559, 4228.978855105728, 4370.847020354288, 4629.560191781776, 5587.804426845051, 5632.915506267409, 4202.936955945664, 4233.597808208223, 4286.957130428687, 4306.138772245547, 4317.625306081658, 3574.4280915053596, 3891.455196272524, 4111.177764447108, 4265.850695225668, 4333.378306124797, 3449.896503104911, 4085.9182816343655, 4111.321631930728, 4126.9793651031705, 4137.234611596849, 3498.7201023918024, 3622.7464077514583, 4074.470318858544, 4177.97911010446, 4208.852690155861, 3567.714582833367, 3602.2975519773654, 3603.7117030637487, 3625.7461977661574, 3630.364686179908, 4155.4182414462, 4376.081022985177, 4474.664400170001, 5425.810096646638, 5491.0, 4017.0760725033115, 4392.319190525442, 4759.834275404683, 4764.952350476486, 4811.75941202942, 5385.461453854622, 5847.912281315784, 5908.261467316585, 5923.289205295349, 5953.374895635982, 3777.527809023872, 3827.9043023924346, 3903.9219215615813, 3904.4338570907344, 3964.493492472871, 5666.603337766358, 6228.532860035471, 6235.129461161679, 6267.4672652824565, 6286.811395658092, 4004.3593025115842, 4008.498937632796, 4008.939865902014, 4020.8391664333685, 4021.2761702893176, 3712.406015037635, 3998.5601583825755, 4064.9390259146135, 4075.694322925792, 4088.9182216355507, 4511.616512596401, 4749.59886833385, 4779.545943135466, 4783.856484305476, 4833.468318484964, 4850.587700045465, 5925.4370834770625, 5931.288245410578, 5951.464368206882, 5999.730012149464, 1094.8631421072366, 1282.8011658192995, 1343.2746316988912, 1365.590322903125, 1378.5588611644177, 887.6854717130924, 900.7432881628704, 913.7207908927554, 920.3925409229876, 929.4376901974343, 4244.554321796167, 5144.996725638464, 5318.308619879468, 5445.482679145475, 5461.808836690697, 5705.457981491834, 5966.671833049137, 5967.701614919237, 5969.120071953178, 5986.461218490357, 4546.840860569931, 4709.81160753566, 4856.927146092811, 5375.914305128053, 5436.565074794007, 2369.992753079934, 2399.796017338546, 2606.6741657292837, 2716.7147449517515, 2724.741149590786, 4270.957290427118, 4928.48250933654, 4956.033573453142, 5291.703532634529, 5307.363116426053, 3952.6837852971694, 4891.654794931423, 5209.47905209476, 5240.349289973646, 5270.894582108336, 4324.978375108167, 4890.24201248807, 5151.5106064923775, 5158.793648254028, 5180.860210753553, 4490.977545112253, 4505.842295519641, 4653.744044077473, 5072.0, 5123.846284611468, 4221.746695198298, 4383.342498625232, 4771.71369717818, 4772.377391686843, 4809.567138957511, 4491.438570178728, 4510.819567217406, 4875.756212189447, 5123.718195499283, 5235.869103272448, 2977.6129103216444, 3002.894898678536, 3486.337595856779, 3491.0973519431464, 3558.270554536262, 4266.637335826489, 4578.359029735773, 4589.066026060899, 4999.900002000012, 5137.717425541481, 4953.380827396575, 4967.205247160437, 4975.825846095369, 5002.824901128589, 5032.823851165338, 4507.842225522091, 4890.728410613195, 4913.508649135058, 4929.728864912464, 4954.900901982012, 4126.566710495475, 4627.46784119817, 4864.80812201013, 4904.337914381513, 5204.713740744295, 5218.608604354765, 5808.883822323614, 5901.734421950937, 5951.655291637216, 5958.19564358806, 5433.619646624857, 5885.352611212677, 5905.954421221477, 5913.201717768218, 5942.316633587193], "value": 3969.271405723212, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [697.7278861244118, 699.4334588982923, 714.5534041224234, 717.3615482220821, 746.7796999885034, 15073.698526029473, 15612.2974466149, 15621.68756624867, 15717.52847414578, 15748.448804291853, 14089.43642254311, 14177.291135443238, 14212.928935355334, 14217.0, 14236.28818559073, 687.3950923187613, 701.2391555162654, 836.0385556609887, 841.5371545649899, 861.2550144125349, 869.2046777198856, 869.4652788535069, 871.5859966515918, 873.4933738431727, 875.6453636277317, 909.9317551183688, 913.8309412758628, 914.0402577293848, 914.9313801464916, 918.9432153024009, 884.6240347852137, 896.5203616065406, 905.483874191711, 906.5467266366817, 908.504864848659, 662.9237637671681, 667.4393509452084, 679.2867489136437, 679.8436359637311, 680.4658343200613, 14504.34730437133, 14718.337674804552, 14789.556313310617, 14809.703805923822, 15007.0, 12805.615831525069, 14851.480198193012, 14897.702045959128, 14935.0, 14953.40186392543, 11090.944545277303, 11262.837713381114, 11873.52505899763, 11999.820002699966, 12004.69988250292, 3880.5343358796845, 3889.727719059667, 3923.6468717815533, 4029.5567487576345, 4056.4726585543985, 78680.60659696722, 91312.54343728305, 92582.0, 120842.0, 121128.78871211351, 9334.393264437926, 11191.66425007251, 11401.201915865975, 11514.194006419637, 11590.634973420696, 22156.2245321413, 22184.77815221827, 22203.66694499584, 22226.777732222796, 22229.77770222277, 7628.69485220596, 7867.921320786833, 7971.163027882105, 7982.640781164861, 8189.385796065319, 4195.811188496464, 4541.0, 4542.3413605027745, 4662.230731929261, 4672.602828759525, 3209.6950789674943, 3313.9668603313658, 3319.68462996015, 3360.7143392811395, 3361.0, 604.5888795618934, 648.3710800523485, 662.6057495789997, 663.2087424770317, 669.2872091222929, 572.5448268626369, 609.0, 627.4290395739855, 635.8251480842805, 646.6475770704977, 8882.15619516145, 8913.197812196933, 8955.105284068439, 9023.819523609622, 9300.34897557178, 553.8479961679697, 594.8542607061211, 594.9434803693642, 634.8000379880323, 637.2862394118524, 4145.937810932778, 4183.707140500197, 4195.202911446815, 4438.201123797683, 4468.620167285752, 78659.0, 102967.0, 146846.26576867048, 150379.0, 183486.0, 131780.0, 132181.0, 134992.0, 135284.32357838147, 139181.0, 103583.96416035894, 106318.46840765746, 107546.0, 117516.0, 117550.0, 8091.716789912325, 9876.753081173028, 9982.35114717541, 10027.348222365814, 10164.48105108629, 46544.0, 59796.70101649464, 62440.0, 62909.68545157428, 63388.73222535616, 88596.5570172145, 94713.0, 96682.51658741942, 97673.0, 97935.51032244794, 11438.885611143782, 13206.537771177962, 13361.13152645075, 13368.331583420595, 13433.865661343261, 15059.548213553611, 15176.0, 15186.164760937812, 15448.459303924308, 15594.688106238038, 13947.0, 14020.719585608434, 14282.42870285177, 14305.427782888568, 14476.420943162155, 11086.833697494383, 13809.585712428643, 13923.651908701959, 13924.651883702989, 13931.233782142079, 13021.804672929724, 13611.319434028457, 13613.047086704231, 13661.385237664528, 13811.585652430444, 11257.26827756226, 11361.147913906325, 11481.82777258325, 11488.54045838157, 12168.817467738168, 7475.36459400957, 10612.740463561136, 10917.727056823644, 10931.726706832393, 11619.709507262049], "value": 7754.541012492892, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1556.3999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 119.0, 107.0, 120.0, 119.0, 118.0, 115.0, 118.0, 140.0, 171.0], "value": 123.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 125.0, 166.0, 166.0, 109.0, 140.0, 161.0, 95.0, 179.0, 140.0], "value": 142.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [205.0, 217.0, 215.0, 199.0, 194.0, 195.0, 196.0, 204.0, 199.0, 195.0], "value": 201.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 98.0, 107.0, 138.0, 83.0, 81.0, 86.0, 67.0, 141.0, 88.0], "value": 94.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 73.0, 140.0, 58.0, 91.0, 71.0, 116.0, 57.0, 71.0, 128.0], "value": 87.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 88.0, 137.0, 116.0, 91.0, 90.0, 93.0, 89.0, 91.0, 88.0], "value": 97.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 97.0, 99.0, 96.0, 99.0, 97.0, 97.0, 96.0, 97.0, 118.0], "value": 99.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 98.0, 91.0, 92.0, 95.0, 91.0, 92.0, 96.0, 91.0, 97.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 57.0, 57.0, 56.0, 55.0, 59.0, 57.0, 56.0, 58.0, 56.0], "value": 56.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 70.0, 70.0, 76.0, 76.0, 76.0, 80.0, 70.0, 72.0, 69.0], "value": 72.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 83.0, 88.0, 85.0, 85.0, 73.0, 91.0, 109.0, 103.0, 108.0], "value": 91.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 136.0, 138.0, 138.0, 150.0, 140.0, 137.0, 137.0, 168.0, 152.0], "value": 143.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 169.0, 163.0, 171.0, 160.0, 176.0, 222.0, 228.0, 167.0, 170.0], "value": 179.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 66.0, 68.0, 66.0, 69.0, 67.0, 68.0, 67.0, 85.0, 84.0], "value": 70.9, "unit": "score"}]}]} 15:07:40 INFO - Return code: 0 15:07:40 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 15:07:40 ERROR - # TBPL SUCCESS # 15:07:40 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 15:07:40 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 15:07:40 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 15:07:40 INFO - 2016-08-08 15:07:40.840 screenresolution[2234:13383] starting screenresolution argv=screenresolution get 15:07:40 INFO - 2016-08-08 15:07:40.843 screenresolution[2234:13383] Display 0: 1600x1200x32@60 15:07:40 INFO - 2016-08-08 15:07:40.849 screenresolution[2235:13386] starting screenresolution argv=screenresolution list 15:07:40 INFO - Available Modes on Display 0 15:07:40 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 15:07:40 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 15:07:40 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 15:07:40 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 15:07:41 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 15:07:41 INFO - Intel Iris: 15:07:41 INFO - Chipset Model: Intel Iris 15:07:41 INFO - Type: GPU 15:07:41 INFO - Bus: Built-In 15:07:41 INFO - VRAM (Dynamic, Max): 1536 MB 15:07:41 INFO - Vendor: Intel (0x8086) 15:07:41 INFO - Device ID: 0x0a2e 15:07:41 INFO - Revision ID: 0x0009 15:07:41 INFO - Displays: 15:07:41 INFO - Display: 15:07:41 INFO - Resolution: 1600 x 1200 @ 60 Hz 15:07:41 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 15:07:41 INFO - Display Serial Number: 1600x1200 60 15:07:41 INFO - Main Display: Yes 15:07:41 INFO - Mirror: Off 15:07:41 INFO - Online: Yes 15:07:41 INFO - Rotation: Supported 15:07:41 INFO - Return code: 0 15:07:41 INFO - Running post-action listener: _resource_record_post_action 15:07:41 INFO - [mozharness: 2016-08-08 22:07:41.084345Z] Finished run-tests step (success) 15:07:41 INFO - Running post-run listener: _resource_record_post_run 15:07:41 INFO - Total resource usage - Wall time: 1210s; CPU: 55.0%; Read bytes: 270336; Write bytes: 710660608; Read time: 9; Write time: 2078 15:07:41 INFO - TinderboxPrint: CPU usage
54.7% 15:07:41 INFO - TinderboxPrint: I/O read bytes / time
270,336 / 9 15:07:41 INFO - TinderboxPrint: I/O write bytes / time
710,660,608 / 2,078 15:07:41 INFO - TinderboxPrint: CPU idle
2,194.6 (45.3%) 15:07:41 INFO - TinderboxPrint: CPU system
984.0 (20.3%) 15:07:41 INFO - TinderboxPrint: CPU user
1,662.9 (34.3%) 15:07:41 INFO - TinderboxPrint: Swap in / out
407,539,712 / 0 15:07:41 INFO - install - Wall time: 35s; CPU: 55.0%; Read bytes: 387824128; Write bytes: 383141888; Read time: 29062; Write time: 804 15:07:41 INFO - run-tests - Wall time: 1176s; CPU: 55.0%; Read bytes: 266240; Write bytes: 300100096; Read time: 8; Write time: 1206 15:07:41 INFO - Running post-run listener: _upload_blobber_files 15:07:41 INFO - Blob upload gear active. 15:07:41 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:07:41 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 15:07:41 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'] 15:07:41 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 15:07:41 INFO - (blobuploader) - INFO - Open directory for files ... 15:07:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 15:07:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:07:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:07:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 15:07:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:07:42 INFO - (blobuploader) - INFO - Done attempting. 15:07:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 15:07:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:07:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:07:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 15:07:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:07:43 INFO - (blobuploader) - INFO - Done attempting. 15:07:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:07:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:07:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:07:45 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:07:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:07:45 INFO - (blobuploader) - INFO - Done attempting. 15:07:45 INFO - (blobuploader) - INFO - Iteration through files over. 15:07:45 INFO - Return code: 0 15:07:45 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:07:45 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:07:45 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/25019afe6968185d59a57fc2f179223aa5a0423f96d80150eda2a1382e0579d1c21864758e79f4bfd4fa9e48591f71277a39b483a46cdaf631994216fa745910", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/1fda49db01c70f0e7cf7c51e10eff050164fa93457af1180ad9883d280afc14ec124208cfd782f81b8fc296fb0184b0418521b31d31ac869ce14eddb8f9712b6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/444fc85edb09905c6ca3d5fe1e1991619c17648e399b35d734106a0c8cb8495f420088b48619e84fccebce41d6a737d5049ef22300871e3233c77fbdc3bb7816"} 15:07:45 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:07:45 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:07:45 INFO - Contents: 15:07:45 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/25019afe6968185d59a57fc2f179223aa5a0423f96d80150eda2a1382e0579d1c21864758e79f4bfd4fa9e48591f71277a39b483a46cdaf631994216fa745910", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/1fda49db01c70f0e7cf7c51e10eff050164fa93457af1180ad9883d280afc14ec124208cfd782f81b8fc296fb0184b0418521b31d31ac869ce14eddb8f9712b6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/444fc85edb09905c6ca3d5fe1e1991619c17648e399b35d734106a0c8cb8495f420088b48619e84fccebce41d6a737d5049ef22300871e3233c77fbdc3bb7816"} 15:07:45 INFO - Running post-run listener: copy_logs_to_upload_dir 15:07:45 INFO - Copying logs to upload dir... 15:07:45 INFO - mkdir: /builds/slave/test/build/upload/logs 15:07:45 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1269.662992 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2016-08-08 15:07:45.999043) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-08 15:07:46.003081) ========= 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.k8xXNNJHNU/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.UncfaQmDPK/Listeners TMPDIR=/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/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/25019afe6968185d59a57fc2f179223aa5a0423f96d80150eda2a1382e0579d1c21864758e79f4bfd4fa9e48591f71277a39b483a46cdaf631994216fa745910", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/1fda49db01c70f0e7cf7c51e10eff050164fa93457af1180ad9883d280afc14ec124208cfd782f81b8fc296fb0184b0418521b31d31ac869ce14eddb8f9712b6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/444fc85edb09905c6ca3d5fe1e1991619c17648e399b35d734106a0c8cb8495f420088b48619e84fccebce41d6a737d5049ef22300871e3233c77fbdc3bb7816"} build_url:https://queue.taskcluster.net/v1/task/Ra5Kb7uNSmSLYBf66CBAWQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011222 build_url: 'https://queue.taskcluster.net/v1/task/Ra5Kb7uNSmSLYBf66CBAWQ/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/25019afe6968185d59a57fc2f179223aa5a0423f96d80150eda2a1382e0579d1c21864758e79f4bfd4fa9e48591f71277a39b483a46cdaf631994216fa745910", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/1fda49db01c70f0e7cf7c51e10eff050164fa93457af1180ad9883d280afc14ec124208cfd782f81b8fc296fb0184b0418521b31d31ac869ce14eddb8f9712b6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/444fc85edb09905c6ca3d5fe1e1991619c17648e399b35d734106a0c8cb8495f420088b48619e84fccebce41d6a737d5049ef22300871e3233c77fbdc3bb7816"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-08 15:07:46.036464) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-08 15:07:46.036821) ========= 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.k8xXNNJHNU/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.UncfaQmDPK/Listeners TMPDIR=/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/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.005293 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-08 15:07:46.085654) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-08 15:07:46.085994) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-08 15:07:46.086338) ========= ========= Total master_lag: 0.18 =========