builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0358 starttime: 1470597574.2 results: success (0) buildid: 20160807091052 builduid: 77f43add1f0246eb9c1092a1eac8c3db revision: 204b39c31233c082553493f52bfe8c3ebcc404ff ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-07 12:19:34.204788) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-07 12:19:34.205241) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-07 12:19:34.205513) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-07 12:19:34.298871) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-07 12:19:34.299157) ========= 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.47pNUyM3s0/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.xAGJnQLTNj/Listeners TMPDIR=/var/folders/2r/mjh615_91fs88xk2w8x_w5l800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-08-07 12:19: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% 170M=0s 2016-08-07 12:19:34 (170 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.523866 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-07 12:19:34.851059) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-07 12:19:34.851453) ========= 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.47pNUyM3s0/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.xAGJnQLTNj/Listeners TMPDIR=/var/folders/2r/mjh615_91fs88xk2w8x_w5l800000w/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.025746 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-07 12:19:34.903367) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-07 12:19:34.903703) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 204b39c31233c082553493f52bfe8c3ebcc404ff --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 204b39c31233c082553493f52bfe8c3ebcc404ff --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.47pNUyM3s0/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.xAGJnQLTNj/Listeners TMPDIR=/var/folders/2r/mjh615_91fs88xk2w8x_w5l800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-08-07 12:19:34,988 truncating revision to first 12 chars 2016-08-07 12:19:34,988 Setting DEBUG logging. 2016-08-07 12:19:34,988 attempt 1/10 2016-08-07 12:19:34,988 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/204b39c31233?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-07 12:19:36,013 unpacking tar archive at: fx-team-204b39c31233/testing/mozharness/ program finished with exit code 0 elapsedTime=1.310823 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-07 12:19:36.237947) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-07 12:19:36.238258) ========= script_repo_revision: 204b39c31233c082553493f52bfe8c3ebcc404ff ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-07 12:19:36.238657) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-07 12:19:36.238940) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-07 12:19:36.257006) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2016-08-07 12:19:36.257363) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.47pNUyM3s0/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.xAGJnQLTNj/Listeners TMPDIR=/var/folders/2r/mjh615_91fs88xk2w8x_w5l800000w/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 12:19:36 INFO - MultiFileLogger online at 20160807 12:19:36 in /builds/slave/test 12:19:36 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 12:19:36 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:19:36 INFO - {'append_to_log': False, 12:19:36 INFO - 'base_work_dir': '/builds/slave/test', 12:19:36 INFO - 'blob_upload_branch': 'Fx-Team', 12:19:36 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:19:36 INFO - 'branch': 'Fx-Team', 12:19:36 INFO - 'buildbot_json_path': 'buildprops.json', 12:19:36 INFO - 'config_files': ('talos/mac_config.py',), 12:19:36 INFO - 'default_actions': ('clobber', 12:19:36 INFO - 'read-buildbot-config', 12:19:36 INFO - 'download-and-extract', 12:19:36 INFO - 'populate-webroot', 12:19:36 INFO - 'create-virtualenv', 12:19:36 INFO - 'install', 12:19:36 INFO - 'run-tests'), 12:19:36 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:19:36 INFO - 'download_minidump_stackwalk': True, 12:19:36 INFO - 'download_symbols': 'ondemand', 12:19:36 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:19:36 INFO - 'tooltool.py': '/tools/tooltool.py', 12:19:36 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:19:36 INFO - '/tools/misc-python/virtualenv.py')}, 12:19:36 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:19:36 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:19:36 INFO - 'installer_path': 'installer.exe', 12:19:36 INFO - 'log_level': 'info', 12:19:36 INFO - 'log_name': 'talos', 12:19:36 INFO - 'log_to_console': True, 12:19:36 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 12:19:36 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 12:19:36 INFO - 'opt_config_files': (), 12:19:36 INFO - 'pip_index': False, 12:19:36 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 12:19:36 INFO - 'cmd': ('bash', 12:19:36 INFO - '-c', 12:19:36 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 12:19:36 INFO - 'enabled': True, 12:19:36 INFO - 'halt_on_failure': False, 12:19:36 INFO - 'name': 'check_screen_resolution'},), 12:19:36 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 12:19:36 INFO - 'cmd': ('bash', 12:19:36 INFO - '-c', 12:19:36 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 12:19:36 INFO - 'enabled': True, 12:19:36 INFO - 'halt_on_failure': False, 12:19:36 INFO - 'name': 'check_screen_resolution'},), 12:19:36 INFO - 'run_cmd_checks_enabled': True, 12:19:36 INFO - 'sps_profile': False, 12:19:36 INFO - 'sps_profile_interval': 0, 12:19:36 INFO - 'suite': 'dromaeojs-e10s', 12:19:36 INFO - 'system_bits': '32', 12:19:36 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:19:36 INFO - 'title': 't-yosemite-r7-0358', 12:19:36 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:19:36 INFO - 'use_talos_json': True, 12:19:36 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:19:36 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:19:36 INFO - 'work_dir': 'build'} 12:19:36 INFO - [mozharness: 2016-08-07 19:19:36.447406Z] Running clobber step. 12:19:36 INFO - Running pre-action listener: _resource_record_pre_action 12:19:36 INFO - Running main action method: clobber 12:19:36 INFO - rmtree: /builds/slave/test/build 12:19:36 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:19:38 INFO - Running post-action listener: _resource_record_post_action 12:19:38 INFO - [mozharness: 2016-08-07 19:19:38.426467Z] Finished clobber step (success) 12:19:38 INFO - [mozharness: 2016-08-07 19:19:38.426631Z] Running read-buildbot-config step. 12:19:38 INFO - Running pre-action listener: _resource_record_pre_action 12:19:38 INFO - Running main action method: read_buildbot_config 12:19:38 INFO - Using buildbot properties: 12:19:38 INFO - { 12:19:38 INFO - "project": "", 12:19:38 INFO - "product": "firefox", 12:19:38 INFO - "script_repo_revision": "production", 12:19:38 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 12:19:38 INFO - "repository": "", 12:19:38 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 12:19:38 INFO - "buildid": "20160807091052", 12:19:38 INFO - "pgo_build": "False", 12:19:38 INFO - "basedir": "/builds/slave/test", 12:19:38 INFO - "buildnumber": 742, 12:19:38 INFO - "slavename": "t-yosemite-r7-0358", 12:19:38 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 12:19:38 INFO - "platform": "yosemite_r7", 12:19:38 INFO - "scheduler": "tests-fx-team-macosx64-talos-7-3600", 12:19:38 INFO - "branch": "fx-team", 12:19:38 INFO - "repo_path": "integration/fx-team", 12:19:38 INFO - "revision": "204b39c31233c082553493f52bfe8c3ebcc404ff", 12:19:38 INFO - "stage_platform": "macosx64", 12:19:38 INFO - "builduid": "77f43add1f0246eb9c1092a1eac8c3db", 12:19:38 INFO - "slavebuilddir": "test" 12:19:38 INFO - } 12:19:38 INFO - Found installer url https://queue.taskcluster.net/v1/task/fw2zS7k7TJuXZHy7J6H4Xw/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg. 12:19:38 INFO - Running post-action listener: _resource_record_post_action 12:19:38 INFO - [mozharness: 2016-08-07 19:19:38.429823Z] Finished read-buildbot-config step (success) 12:19:38 INFO - [mozharness: 2016-08-07 19:19:38.429922Z] Running download-and-extract step. 12:19:38 INFO - Running pre-action listener: _resource_record_pre_action 12:19:38 INFO - Running main action method: download_and_extract 12:19:38 INFO - mkdir: /builds/slave/test/build/tests 12:19: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')]} 12:19:38 INFO - trying https://queue.taskcluster.net/v1/task/fw2zS7k7TJuXZHy7J6H4Xw/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json 12:19:38 INFO - Downloading https://queue.taskcluster.net/v1/task/fw2zS7k7TJuXZHy7J6H4Xw/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 12:19:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fw2zS7k7TJuXZHy7J6H4Xw/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 12:19:39 INFO - Downloaded 1199 bytes. 12:19:39 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 12:19:39 INFO - Using the following test package requirements: 12:19:39 INFO - {u'common': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 12:19:39 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 12:19:39 INFO - u'firefox-51.0a1.en-US.mac.cppunittest.tests.zip'], 12:19:39 INFO - u'gtest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 12:19:39 INFO - u'firefox-51.0a1.en-US.mac.gtest.tests.zip'], 12:19:39 INFO - u'jittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 12:19:39 INFO - u'jsshell-mac.zip'], 12:19:39 INFO - u'mochitest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 12:19:39 INFO - u'firefox-51.0a1.en-US.mac.mochitest.tests.zip'], 12:19:39 INFO - u'mozbase': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 12:19:39 INFO - u'reftest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 12:19:39 INFO - u'firefox-51.0a1.en-US.mac.reftest.tests.zip'], 12:19:39 INFO - u'talos': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 12:19:39 INFO - u'firefox-51.0a1.en-US.mac.talos.tests.zip'], 12:19:39 INFO - u'web-platform': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 12:19:39 INFO - u'firefox-51.0a1.en-US.mac.web-platform.tests.zip'], 12:19:39 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 12:19:39 INFO - u'firefox-51.0a1.en-US.mac.xpcshell.tests.zip']} 12:19:39 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip'] for test suite category: common 12:19:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:19:39 INFO - trying https://queue.taskcluster.net/v1/task/fw2zS7k7TJuXZHy7J6H4Xw/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 12:19:39 INFO - Downloading https://queue.taskcluster.net/v1/task/fw2zS7k7TJuXZHy7J6H4Xw/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 12:19:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fw2zS7k7TJuXZHy7J6H4Xw/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 12:19:40 INFO - Downloaded 16324158 bytes. 12:19:40 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'] 12:19:40 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 12:19:43 INFO - Return code: 0 12:19:43 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 12:19:43 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')]} 12:19:43 INFO - trying https://queue.taskcluster.net/v1/task/fw2zS7k7TJuXZHy7J6H4Xw/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 12:19:43 INFO - Downloading https://queue.taskcluster.net/v1/task/fw2zS7k7TJuXZHy7J6H4Xw/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 12:19:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fw2zS7k7TJuXZHy7J6H4Xw/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 12:19:45 INFO - Downloaded 16324158 bytes. 12:19:45 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'] 12:19:45 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 12:19:48 INFO - Return code: 0 12:19: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')]} 12:19:48 INFO - trying https://queue.taskcluster.net/v1/task/fw2zS7k7TJuXZHy7J6H4Xw/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip 12:19:48 INFO - Downloading https://queue.taskcluster.net/v1/task/fw2zS7k7TJuXZHy7J6H4Xw/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 12:19:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fw2zS7k7TJuXZHy7J6H4Xw/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 12:19:49 INFO - Downloaded 14413723 bytes. 12:19:49 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'] 12:19:49 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 12:19:49 INFO - Return code: 0 12:19:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:19:49 INFO - trying https://queue.taskcluster.net/v1/task/fw2zS7k7TJuXZHy7J6H4Xw/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 12:19:49 INFO - Downloading https://queue.taskcluster.net/v1/task/fw2zS7k7TJuXZHy7J6H4Xw/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg 12:19:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fw2zS7k7TJuXZHy7J6H4Xw/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 12:19:53 INFO - Downloaded 111871695 bytes. 12:19:53 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/fw2zS7k7TJuXZHy7J6H4Xw/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 12:19:53 INFO - mkdir: /builds/slave/test/properties 12:19:53 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:19:53 INFO - Writing to file /builds/slave/test/properties/build_url 12:19:53 INFO - Contents: 12:19:53 INFO - build_url:https://queue.taskcluster.net/v1/task/fw2zS7k7TJuXZHy7J6H4Xw/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 12:19:53 INFO - Running post-action listener: _resource_record_post_action 12:19:53 INFO - Running post-action listener: set_extra_try_arguments 12:19:53 INFO - [mozharness: 2016-08-07 19:19:53.753035Z] Finished download-and-extract step (success) 12:19:53 INFO - [mozharness: 2016-08-07 19:19:53.753170Z] Running populate-webroot step. 12:19:53 INFO - Running pre-action listener: _resource_record_pre_action 12:19:53 INFO - Running main action method: populate_webroot 12:19:53 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:19:53 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:19:53 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:19:53 INFO - '--tppagecycles', 12:19:53 INFO - '7'], 12:19:53 INFO - 'tests': ['tsvgm']}}, 12:19:53 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 12:19:53 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:19:53 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 12:19:53 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 12:19:53 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:19:53 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 12:19:53 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:19:53 INFO - 'talos_options': ['--disable-e10s'], 12:19:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:19:53 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:19:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:19:53 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:19:53 INFO - 'talos_options': ['--disable-e10s'], 12:19:53 INFO - 'tests': ['damp', 'tps']}, 12:19:53 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:19:53 INFO - 'tests': ['damp', 'tps']}, 12:19:53 INFO - 'g3': {'talos_options': ['--disable-e10s'], 12:19:53 INFO - 'tests': ['dromaeo_dom']}, 12:19:53 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:19:53 INFO - 'g4': {'talos_options': ['--disable-e10s'], 12:19:53 INFO - 'tests': ['basic_compositor_video']}, 12:19:53 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 12:19:53 INFO - 'other': {'talos_options': ['--disable-e10s'], 12:19:53 INFO - 'tests': ['a11yr', 12:19:53 INFO - 'ts_paint', 12:19:53 INFO - 'tpaint', 12:19:53 INFO - 'sessionrestore', 12:19:53 INFO - 'sessionrestore_no_auto_restore', 12:19:53 INFO - 'tabpaint']}, 12:19:53 INFO - 'other-e10s': {'tests': ['a11yr', 12:19:53 INFO - 'ts_paint', 12:19:53 INFO - 'tpaint', 12:19:53 INFO - 'sessionrestore', 12:19:53 INFO - 'sessionrestore_no_auto_restore', 12:19:53 INFO - 'tabpaint']}, 12:19:53 INFO - 'other-e10s_l64': {'tests': ['a11yr', 12:19:53 INFO - 'ts_paint', 12:19:53 INFO - 'tpaint', 12:19:53 INFO - 'sessionrestore', 12:19:53 INFO - 'sessionrestore_no_auto_restore', 12:19:53 INFO - 'tabpaint']}, 12:19:53 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 12:19:53 INFO - 'ts_paint', 12:19:53 INFO - 'tpaint', 12:19:53 INFO - 'sessionrestore', 12:19:53 INFO - 'sessionrestore_no_auto_restore', 12:19:53 INFO - 'tabpaint']}, 12:19:53 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 12:19:53 INFO - 'tests': ['a11yr', 12:19:53 INFO - 'ts_paint', 12:19:53 INFO - 'tpaint', 12:19:53 INFO - 'sessionrestore', 12:19:53 INFO - 'sessionrestore_no_auto_restore', 12:19:53 INFO - 'tabpaint']}, 12:19:53 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 12:19:53 INFO - 'tests': ['a11yr', 12:19:53 INFO - 'ts_paint', 12:19:53 INFO - 'tpaint', 12:19:53 INFO - 'sessionrestore', 12:19:53 INFO - 'sessionrestore_no_auto_restore', 12:19:53 INFO - 'tabpaint']}, 12:19:53 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 12:19:53 INFO - 'tests': ['tsvgx', 12:19:53 INFO - 'tsvgr_opacity', 12:19:53 INFO - 'tart', 12:19:53 INFO - 'tscrollx', 12:19:53 INFO - 'cart']}, 12:19:53 INFO - 'svgr-e10s': {'tests': ['tsvgx', 12:19:53 INFO - 'tsvgr_opacity', 12:19:53 INFO - 'tart', 12:19:53 INFO - 'tscrollx', 12:19:53 INFO - 'cart']}, 12:19:53 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:19:53 INFO - 'talos_options': ['--disable-e10s'], 12:19:53 INFO - 'tests': ['tp5o']}, 12:19:53 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:19:53 INFO - 'tests': ['tp5o']}, 12:19:53 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:19:53 INFO - 'talos_options': ['--disable-e10s', 12:19:53 INFO - '--xperf_path', 12:19:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:19:53 INFO - 'tests': ['tp5n']}, 12:19:53 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:19:53 INFO - 'talos_options': ['--xperf_path', 12:19:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:19:53 INFO - 'tests': ['tp5n']}}, 12:19:53 INFO - 'talos.zip': {'path': '', 12:19:53 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:19:53 INFO - Running post-action listener: _resource_record_post_action 12:19:53 INFO - [mozharness: 2016-08-07 19:19:53.771924Z] Finished populate-webroot step (success) 12:19:53 INFO - [mozharness: 2016-08-07 19:19:53.771997Z] Running create-virtualenv step. 12:19:53 INFO - Running pre-action listener: _resource_record_pre_action 12:19:53 INFO - Running main action method: create_virtualenv 12:19:53 INFO - Creating virtualenv /builds/slave/test/build/venv 12:19:53 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 12:19:53 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:19:53 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:19:53 INFO - Using real prefix '/tools/python27' 12:19:53 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:19:54 INFO - Installing distribute.............................................................................................................................................................................................done. 12:19:57 INFO - Installing pip.................done. 12:19:57 INFO - Return code: 0 12:19:57 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:19:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:19:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:19:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:19:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:19:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:19:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:19:57 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 0x10499ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104a30618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fedb2d9faf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1048ffd30>, '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 0x104664db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1048f7b20>, '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.47pNUyM3s0/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.xAGJnQLTNj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2r/mjh615_91fs88xk2w8x_w5l800000w/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 12:19:57 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 12:19:57 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 12:19:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.47pNUyM3s0/Render', 12:19:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:19:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:19:57 INFO - 'HOME': '/Users/cltbld', 12:19:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:19:57 INFO - 'LOGNAME': 'cltbld', 12:19:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:19:57 INFO - 'MOZ_NO_REMOTE': '1', 12:19:57 INFO - 'NO_EM_RESTART': '1', 12:19:57 INFO - 'PAGER': '/bin/cat', 12:19:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:19:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:19:57 INFO - 'PWD': '/builds/slave/test', 12:19:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:19:57 INFO - 'SHELL': '/bin/bash', 12:19:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xAGJnQLTNj/Listeners', 12:19:57 INFO - 'TMPDIR': '/var/folders/2r/mjh615_91fs88xk2w8x_w5l800000w/T/', 12:19:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:19:57 INFO - 'USER': 'cltbld', 12:19:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:19:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:19:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:19:57 INFO - 'XPC_FLAGS': '0x0', 12:19:57 INFO - 'XPC_SERVICE_NAME': '0', 12:19:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:19:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:19:57 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 12:19:57 INFO - Cleaning up... 12:19:57 INFO - Return code: 0 12:19:57 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 12:19:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:19:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:19:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:19:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:19:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:19:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:19:57 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 0x10499ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104a30618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fedb2d9faf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1048ffd30>, '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 0x104664db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1048f7b20>, '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.47pNUyM3s0/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.xAGJnQLTNj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2r/mjh615_91fs88xk2w8x_w5l800000w/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 12:19:57 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 12:19:57 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 12:19:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.47pNUyM3s0/Render', 12:19:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:19:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:19:57 INFO - 'HOME': '/Users/cltbld', 12:19:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:19:57 INFO - 'LOGNAME': 'cltbld', 12:19:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:19:57 INFO - 'MOZ_NO_REMOTE': '1', 12:19:57 INFO - 'NO_EM_RESTART': '1', 12:19:57 INFO - 'PAGER': '/bin/cat', 12:19:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:19:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:19:57 INFO - 'PWD': '/builds/slave/test', 12:19:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:19:57 INFO - 'SHELL': '/bin/bash', 12:19:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xAGJnQLTNj/Listeners', 12:19:57 INFO - 'TMPDIR': '/var/folders/2r/mjh615_91fs88xk2w8x_w5l800000w/T/', 12:19:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:19:57 INFO - 'USER': 'cltbld', 12:19:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:19:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:19:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:19:57 INFO - 'XPC_FLAGS': '0x0', 12:19:57 INFO - 'XPC_SERVICE_NAME': '0', 12:19:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:19:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:19:58 INFO - Downloading/unpacking psutil>=3.1.1 12:19:58 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 12:19:58 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 12:19:58 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 12:19:58 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 12:19:58 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 12:19:58 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 12:20:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:20:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:20:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:20:01 INFO - Installing collected packages: psutil 12:20:01 INFO - Running setup.py install for psutil 12:20:01 INFO - building 'psutil._psutil_osx' extension 12:20:01 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 12:20:02 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 12:20:02 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 12:20:02 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 12:20:02 INFO - building 'psutil._psutil_posix' extension 12:20:02 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 12:20:02 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 12:20:02 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 12:20:02 INFO - ^ 12:20:02 INFO - 1 warning generated. 12:20:02 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 12:20:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:20:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:20:02 INFO - Successfully installed psutil 12:20:02 INFO - Cleaning up... 12:20:02 INFO - Return code: 0 12:20:02 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 12:20:02 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')]} 12:20:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:20:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:20:02 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')]} 12:20:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:20:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:20:02 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 0x10499ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104a30618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fedb2d9faf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1048ffd30>, '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 0x104664db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1048f7b20>, '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.47pNUyM3s0/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.xAGJnQLTNj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2r/mjh615_91fs88xk2w8x_w5l800000w/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 12:20:02 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 12:20:02 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 12:20:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.47pNUyM3s0/Render', 12:20:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:20:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:20:02 INFO - 'HOME': '/Users/cltbld', 12:20:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:20:02 INFO - 'LOGNAME': 'cltbld', 12:20:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:20:02 INFO - 'MOZ_NO_REMOTE': '1', 12:20:02 INFO - 'NO_EM_RESTART': '1', 12:20:02 INFO - 'PAGER': '/bin/cat', 12:20:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:20:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:20:02 INFO - 'PWD': '/builds/slave/test', 12:20:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:20:02 INFO - 'SHELL': '/bin/bash', 12:20:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xAGJnQLTNj/Listeners', 12:20:02 INFO - 'TMPDIR': '/var/folders/2r/mjh615_91fs88xk2w8x_w5l800000w/T/', 12:20:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:20:02 INFO - 'USER': 'cltbld', 12:20:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:20:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:20:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:20:02 INFO - 'XPC_FLAGS': '0x0', 12:20:02 INFO - 'XPC_SERVICE_NAME': '0', 12:20:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:20:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:20:03 INFO - Downloading/unpacking mozsystemmonitor==0.3 12:20:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:20:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:20:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:20:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:20:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:20:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:20:05 INFO - Downloading mozsystemmonitor-0.3.tar.gz 12:20:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:20:05 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 12:20:05 INFO - Installing collected packages: mozsystemmonitor 12:20:05 INFO - Running setup.py install for mozsystemmonitor 12:20:05 INFO - Successfully installed mozsystemmonitor 12:20:05 INFO - Cleaning up... 12:20:05 INFO - Return code: 0 12:20:05 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 12:20: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')]} 12:20:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:20:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:20: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')]} 12:20:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:20:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:20:05 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 0x10499ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104a30618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fedb2d9faf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1048ffd30>, '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 0x104664db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1048f7b20>, '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.47pNUyM3s0/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.xAGJnQLTNj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2r/mjh615_91fs88xk2w8x_w5l800000w/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 12:20:05 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 12:20:05 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 12:20:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.47pNUyM3s0/Render', 12:20:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:20:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:20:05 INFO - 'HOME': '/Users/cltbld', 12:20:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:20:05 INFO - 'LOGNAME': 'cltbld', 12:20:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:20:05 INFO - 'MOZ_NO_REMOTE': '1', 12:20:05 INFO - 'NO_EM_RESTART': '1', 12:20:05 INFO - 'PAGER': '/bin/cat', 12:20:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:20:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:20:05 INFO - 'PWD': '/builds/slave/test', 12:20:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:20:05 INFO - 'SHELL': '/bin/bash', 12:20:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xAGJnQLTNj/Listeners', 12:20:05 INFO - 'TMPDIR': '/var/folders/2r/mjh615_91fs88xk2w8x_w5l800000w/T/', 12:20:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:20:05 INFO - 'USER': 'cltbld', 12:20:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:20:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:20:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:20:05 INFO - 'XPC_FLAGS': '0x0', 12:20:05 INFO - 'XPC_SERVICE_NAME': '0', 12:20:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:20:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:20:06 INFO - Downloading/unpacking jsonschema==2.5.1 12:20:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:20:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:20:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:20:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:20:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:20:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:20:08 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:20:08 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 12:20: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 12:20: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 12:20: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 12:20: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 12:20: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 12:20: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 12:20:08 INFO - Downloading functools32-3.2.3-2.tar.gz 12:20:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:20:08 INFO - warning: no files found matching '*.txt' 12:20:08 INFO - no previously-included directories found matching 'build' 12:20:08 INFO - no previously-included directories found matching 'dist' 12:20:08 INFO - no previously-included directories found matching '.git*' 12:20:09 INFO - Installing collected packages: jsonschema, functools32 12:20:09 INFO - Running setup.py install for functools32 12:20:09 INFO - warning: no files found matching '*.txt' 12:20:09 INFO - no previously-included directories found matching 'build' 12:20:09 INFO - no previously-included directories found matching 'dist' 12:20:09 INFO - no previously-included directories found matching '.git*' 12:20:09 INFO - Successfully installed jsonschema functools32 12:20:09 INFO - Cleaning up... 12:20:09 INFO - Return code: 0 12:20:09 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 12:20:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:20:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:20:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:20:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:20:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:20:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:20:09 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 0x10499ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104a30618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fedb2d9faf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1048ffd30>, '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 0x104664db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1048f7b20>, '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.47pNUyM3s0/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.xAGJnQLTNj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2r/mjh615_91fs88xk2w8x_w5l800000w/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 12:20:09 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 12:20:09 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 12:20:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.47pNUyM3s0/Render', 12:20:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:20:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:20:09 INFO - 'HOME': '/Users/cltbld', 12:20:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:20:09 INFO - 'LOGNAME': 'cltbld', 12:20:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:20:09 INFO - 'MOZ_NO_REMOTE': '1', 12:20:09 INFO - 'NO_EM_RESTART': '1', 12:20:09 INFO - 'PAGER': '/bin/cat', 12:20:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:20:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:20:09 INFO - 'PWD': '/builds/slave/test', 12:20:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:20:09 INFO - 'SHELL': '/bin/bash', 12:20:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xAGJnQLTNj/Listeners', 12:20:09 INFO - 'TMPDIR': '/var/folders/2r/mjh615_91fs88xk2w8x_w5l800000w/T/', 12:20:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:20:09 INFO - 'USER': 'cltbld', 12:20:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:20:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:20:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:20:09 INFO - 'XPC_FLAGS': '0x0', 12:20:09 INFO - 'XPC_SERVICE_NAME': '0', 12:20:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:20:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:20:09 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 12:20:09 INFO - Cleaning up... 12:20:09 INFO - Return code: 0 12:20:09 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:20:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:20:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:20:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:20:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:20:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:20:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:20:09 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 0x10499ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104a30618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fedb2d9faf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1048ffd30>, '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 0x104664db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1048f7b20>, '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.47pNUyM3s0/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.xAGJnQLTNj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2r/mjh615_91fs88xk2w8x_w5l800000w/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 12:20:09 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 12:20:09 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 12:20:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.47pNUyM3s0/Render', 12:20:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:20:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:20:09 INFO - 'HOME': '/Users/cltbld', 12:20:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:20:09 INFO - 'LOGNAME': 'cltbld', 12:20:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:20:09 INFO - 'MOZ_NO_REMOTE': '1', 12:20:09 INFO - 'NO_EM_RESTART': '1', 12:20:09 INFO - 'PAGER': '/bin/cat', 12:20:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:20:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:20:09 INFO - 'PWD': '/builds/slave/test', 12:20:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:20:09 INFO - 'SHELL': '/bin/bash', 12:20:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xAGJnQLTNj/Listeners', 12:20:09 INFO - 'TMPDIR': '/var/folders/2r/mjh615_91fs88xk2w8x_w5l800000w/T/', 12:20:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:20:09 INFO - 'USER': 'cltbld', 12:20:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:20:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:20:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:20:09 INFO - 'XPC_FLAGS': '0x0', 12:20:09 INFO - 'XPC_SERVICE_NAME': '0', 12:20:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:20:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:20:09 INFO - Downloading/unpacking blobuploader==1.2.4 12:20:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:20:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:20:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:20:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:20:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:20:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:20:12 INFO - Downloading blobuploader-1.2.4.tar.gz 12:20:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:20:12 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:20:12 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 12:20:12 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 12:20:12 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 12:20:12 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 12:20:12 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 12:20:12 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 12:20:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:20:12 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:20:12 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 12:20:12 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 12:20:12 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 12:20:12 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 12:20:12 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 12:20:12 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 12:20:13 INFO - Downloading docopt-0.6.1.tar.gz 12:20:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:20:13 INFO - Installing collected packages: blobuploader, requests, docopt 12:20:13 INFO - Running setup.py install for blobuploader 12:20:13 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:20:13 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:20:13 INFO - Running setup.py install for requests 12:20:14 INFO - Running setup.py install for docopt 12:20:14 INFO - Successfully installed blobuploader requests docopt 12:20:14 INFO - Cleaning up... 12:20:14 INFO - Return code: 0 12:20:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:20:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:20:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:20:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:20:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:20:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:20:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:20:14 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 0x10499ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104a30618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fedb2d9faf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1048ffd30>, '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 0x104664db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1048f7b20>, '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.47pNUyM3s0/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.xAGJnQLTNj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2r/mjh615_91fs88xk2w8x_w5l800000w/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 12:20:14 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 12:20:14 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 12:20:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.47pNUyM3s0/Render', 12:20:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:20:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:20:14 INFO - 'HOME': '/Users/cltbld', 12:20:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:20:14 INFO - 'LOGNAME': 'cltbld', 12:20:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:20:14 INFO - 'MOZ_NO_REMOTE': '1', 12:20:14 INFO - 'NO_EM_RESTART': '1', 12:20:14 INFO - 'PAGER': '/bin/cat', 12:20:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:20:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:20:14 INFO - 'PWD': '/builds/slave/test', 12:20:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:20:14 INFO - 'SHELL': '/bin/bash', 12:20:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xAGJnQLTNj/Listeners', 12:20:14 INFO - 'TMPDIR': '/var/folders/2r/mjh615_91fs88xk2w8x_w5l800000w/T/', 12:20:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:20:14 INFO - 'USER': 'cltbld', 12:20:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:20:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:20:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:20:14 INFO - 'XPC_FLAGS': '0x0', 12:20:14 INFO - 'XPC_SERVICE_NAME': '0', 12:20:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:20:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:20:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:20:14 INFO - Running setup.py (path:/var/folders/2r/mjh615_91fs88xk2w8x_w5l800000w/T/pip-z5z7Xs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:20:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:20:14 INFO - Running setup.py (path:/var/folders/2r/mjh615_91fs88xk2w8x_w5l800000w/T/pip-Mukyho-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:20:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:20:14 INFO - Running setup.py (path:/var/folders/2r/mjh615_91fs88xk2w8x_w5l800000w/T/pip-SA8TiK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:20:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:20:14 INFO - Running setup.py (path:/var/folders/2r/mjh615_91fs88xk2w8x_w5l800000w/T/pip-T_3sYK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:20:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:20:15 INFO - Running setup.py (path:/var/folders/2r/mjh615_91fs88xk2w8x_w5l800000w/T/pip-VgkzON-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:20:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:20:15 INFO - Running setup.py (path:/var/folders/2r/mjh615_91fs88xk2w8x_w5l800000w/T/pip-khykHV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:20:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:20:15 INFO - Running setup.py (path:/var/folders/2r/mjh615_91fs88xk2w8x_w5l800000w/T/pip-hbxcef-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:20:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:20:15 INFO - Running setup.py (path:/var/folders/2r/mjh615_91fs88xk2w8x_w5l800000w/T/pip-fQ3lJn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:20:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:20:15 INFO - Running setup.py (path:/var/folders/2r/mjh615_91fs88xk2w8x_w5l800000w/T/pip-RNdX8E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:20:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:20:15 INFO - Running setup.py (path:/var/folders/2r/mjh615_91fs88xk2w8x_w5l800000w/T/pip-_qGHCP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:20:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:20:15 INFO - Running setup.py (path:/var/folders/2r/mjh615_91fs88xk2w8x_w5l800000w/T/pip-HTH3O9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:20:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:20:15 INFO - Running setup.py (path:/var/folders/2r/mjh615_91fs88xk2w8x_w5l800000w/T/pip-ZAtsAL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:20:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:20:15 INFO - Running setup.py (path:/var/folders/2r/mjh615_91fs88xk2w8x_w5l800000w/T/pip-7j3_es-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:20:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:20:16 INFO - Running setup.py (path:/var/folders/2r/mjh615_91fs88xk2w8x_w5l800000w/T/pip-h8bgEt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:20:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:20:16 INFO - Running setup.py (path:/var/folders/2r/mjh615_91fs88xk2w8x_w5l800000w/T/pip-Zif47o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:20:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:20:16 INFO - Running setup.py (path:/var/folders/2r/mjh615_91fs88xk2w8x_w5l800000w/T/pip-422D8y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:20:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:20:16 INFO - Running setup.py (path:/var/folders/2r/mjh615_91fs88xk2w8x_w5l800000w/T/pip-NHVJ4z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:20:16 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:20:16 INFO - Running setup.py install for manifestparser 12:20:16 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:20:16 INFO - Running setup.py install for mozcrash 12:20:16 INFO - Running setup.py install for mozdebug 12:20:16 INFO - Running setup.py install for mozdevice 12:20:17 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:20:17 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:20:17 INFO - Running setup.py install for mozfile 12:20:17 INFO - Running setup.py install for mozhttpd 12:20:17 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:20:17 INFO - Running setup.py install for mozinfo 12:20:17 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:20:17 INFO - Running setup.py install for mozInstall 12:20:17 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:20:17 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:20:17 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:20:17 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:20:17 INFO - Running setup.py install for mozleak 12:20:17 INFO - Running setup.py install for mozlog 12:20:17 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:20:17 INFO - Running setup.py install for moznetwork 12:20:18 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:20:18 INFO - Running setup.py install for mozprocess 12:20:18 INFO - Running setup.py install for mozprofile 12:20:18 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:20:18 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:20:18 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:20:18 INFO - Running setup.py install for mozrunner 12:20:18 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:20:18 INFO - Running setup.py install for mozscreenshot 12:20:18 INFO - Running setup.py install for moztest 12:20:18 INFO - Running setup.py install for mozversion 12:20:19 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:20:19 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:20:19 INFO - Cleaning up... 12:20:19 INFO - Return code: 0 12:20:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:20:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:20:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:20:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:20:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:20:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:20:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:20:19 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 0x10499ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104a30618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fedb2d9faf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1048ffd30>, '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 0x104664db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1048f7b20>, '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.47pNUyM3s0/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.xAGJnQLTNj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2r/mjh615_91fs88xk2w8x_w5l800000w/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 12:20:19 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 12:20:19 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 12:20:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.47pNUyM3s0/Render', 12:20:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:20:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:20:19 INFO - 'HOME': '/Users/cltbld', 12:20:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:20:19 INFO - 'LOGNAME': 'cltbld', 12:20:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:20:19 INFO - 'MOZ_NO_REMOTE': '1', 12:20:19 INFO - 'NO_EM_RESTART': '1', 12:20:19 INFO - 'PAGER': '/bin/cat', 12:20:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:20:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:20:19 INFO - 'PWD': '/builds/slave/test', 12:20:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:20:19 INFO - 'SHELL': '/bin/bash', 12:20:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xAGJnQLTNj/Listeners', 12:20:19 INFO - 'TMPDIR': '/var/folders/2r/mjh615_91fs88xk2w8x_w5l800000w/T/', 12:20:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:20:19 INFO - 'USER': 'cltbld', 12:20:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:20:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:20:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:20:19 INFO - 'XPC_FLAGS': '0x0', 12:20:19 INFO - 'XPC_SERVICE_NAME': '0', 12:20:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:20:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:20:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:20:19 INFO - Running setup.py (path:/var/folders/2r/mjh615_91fs88xk2w8x_w5l800000w/T/pip-ElNNIb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:20:19 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)) 12:20:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:20:19 INFO - Running setup.py (path:/var/folders/2r/mjh615_91fs88xk2w8x_w5l800000w/T/pip-wbMGqK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:20:19 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)) 12:20:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:20:19 INFO - Running setup.py (path:/var/folders/2r/mjh615_91fs88xk2w8x_w5l800000w/T/pip-x7c5dw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:20:19 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)) 12:20:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:20:19 INFO - Running setup.py (path:/var/folders/2r/mjh615_91fs88xk2w8x_w5l800000w/T/pip-KuScc6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:20:19 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)) 12:20:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:20:19 INFO - Running setup.py (path:/var/folders/2r/mjh615_91fs88xk2w8x_w5l800000w/T/pip-NnMRMD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:20:19 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)) 12:20:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:20:19 INFO - Running setup.py (path:/var/folders/2r/mjh615_91fs88xk2w8x_w5l800000w/T/pip-WyfzM_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:20:19 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)) 12:20:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:20:19 INFO - Running setup.py (path:/var/folders/2r/mjh615_91fs88xk2w8x_w5l800000w/T/pip-nzi6Co-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:20:20 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)) 12:20:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:20:20 INFO - Running setup.py (path:/var/folders/2r/mjh615_91fs88xk2w8x_w5l800000w/T/pip-dOQF_j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:20:20 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)) 12:20:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:20:20 INFO - Running setup.py (path:/var/folders/2r/mjh615_91fs88xk2w8x_w5l800000w/T/pip-Mow8Y6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:20:20 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)) 12:20:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:20:20 INFO - Running setup.py (path:/var/folders/2r/mjh615_91fs88xk2w8x_w5l800000w/T/pip-6x1WoJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:20:20 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)) 12:20:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:20:20 INFO - Running setup.py (path:/var/folders/2r/mjh615_91fs88xk2w8x_w5l800000w/T/pip-muNTmW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:20:20 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)) 12:20:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:20:20 INFO - Running setup.py (path:/var/folders/2r/mjh615_91fs88xk2w8x_w5l800000w/T/pip-mGo7Nf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:20:20 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)) 12:20:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:20:20 INFO - Running setup.py (path:/var/folders/2r/mjh615_91fs88xk2w8x_w5l800000w/T/pip-ACL5XW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:20:20 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)) 12:20:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:20:20 INFO - Running setup.py (path:/var/folders/2r/mjh615_91fs88xk2w8x_w5l800000w/T/pip-Pp6TVg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:20:20 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)) 12:20:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:20:20 INFO - Running setup.py (path:/var/folders/2r/mjh615_91fs88xk2w8x_w5l800000w/T/pip-KZsrEJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:20:20 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)) 12:20:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:20:20 INFO - Running setup.py (path:/var/folders/2r/mjh615_91fs88xk2w8x_w5l800000w/T/pip-Tmqz4t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:20:21 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)) 12:20:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:20:21 INFO - Running setup.py (path:/var/folders/2r/mjh615_91fs88xk2w8x_w5l800000w/T/pip-2oGiZL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:20:21 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)) 12:20:21 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)) 12:20:21 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)) 12:20:21 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)) 12:20:21 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)) 12:20:21 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)) 12:20:21 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:20:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:20:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:20:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:20:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:20:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:20:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:20:23 INFO - Downloading blessings-1.6.tar.gz 12:20:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:20:23 INFO - Installing collected packages: blessings 12:20:23 INFO - Running setup.py install for blessings 12:20:23 INFO - Successfully installed blessings 12:20:23 INFO - Cleaning up... 12:20:23 INFO - Return code: 0 12:20:23 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:20:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:20:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:20:24 INFO - Reading from file tmpfile_stdout 12:20:24 INFO - Current package versions: 12:20:24 INFO - blessings == 1.6 12:20:24 INFO - blobuploader == 1.2.4 12:20:24 INFO - docopt == 0.6.1 12:20:24 INFO - functools32 == 3.2.3-2 12:20:24 INFO - jsonschema == 2.5.1 12:20:24 INFO - manifestparser == 1.1 12:20:24 INFO - mozInstall == 1.12 12:20:24 INFO - mozcrash == 0.17 12:20:24 INFO - mozdebug == 0.1 12:20:24 INFO - mozdevice == 0.48 12:20:24 INFO - mozfile == 1.2 12:20:24 INFO - mozhttpd == 0.7 12:20:24 INFO - mozinfo == 0.9 12:20:24 INFO - mozleak == 0.1 12:20:24 INFO - mozlog == 3.3 12:20:24 INFO - moznetwork == 0.27 12:20:24 INFO - mozprocess == 0.23 12:20:24 INFO - mozprofile == 0.28 12:20:24 INFO - mozrunner == 6.12 12:20:24 INFO - mozscreenshot == 0.1 12:20:24 INFO - mozsystemmonitor == 0.3 12:20:24 INFO - moztest == 0.7 12:20:24 INFO - mozversion == 1.4 12:20:24 INFO - psutil == 3.1.1 12:20:24 INFO - requests == 1.2.3 12:20:24 INFO - wsgiref == 0.1.2 12:20:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:20: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')]} 12:20:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:20:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:20: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')]} 12:20:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:20:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:20:24 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 0x10499ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104a30618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fedb2d9faf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1048ffd30>, '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 0x104664db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1048f7b20>, '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.47pNUyM3s0/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.xAGJnQLTNj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2r/mjh615_91fs88xk2w8x_w5l800000w/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 12:20:24 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 12:20:24 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 12:20:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.47pNUyM3s0/Render', 12:20:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:20:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:20:24 INFO - 'HOME': '/Users/cltbld', 12:20:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:20:24 INFO - 'LOGNAME': 'cltbld', 12:20:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:20:24 INFO - 'MOZ_NO_REMOTE': '1', 12:20:24 INFO - 'NO_EM_RESTART': '1', 12:20:24 INFO - 'PAGER': '/bin/cat', 12:20:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:20:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:20:24 INFO - 'PWD': '/builds/slave/test', 12:20:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:20:24 INFO - 'SHELL': '/bin/bash', 12:20:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xAGJnQLTNj/Listeners', 12:20:24 INFO - 'TMPDIR': '/var/folders/2r/mjh615_91fs88xk2w8x_w5l800000w/T/', 12:20:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:20:24 INFO - 'USER': 'cltbld', 12:20:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:20:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:20:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:20:24 INFO - 'XPC_FLAGS': '0x0', 12:20:24 INFO - 'XPC_SERVICE_NAME': '0', 12:20:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:20:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:20:24 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)) 12:20:24 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)) 12:20:24 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)) 12:20:24 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)) 12:20:24 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)) 12:20:24 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)) 12:20:24 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)) 12:20:24 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)) 12:20:24 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)) 12:20:24 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)) 12:20:24 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)) 12:20:24 INFO - Cleaning up... 12:20:24 INFO - Return code: 0 12:20:24 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:20: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')]} 12:20:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:20:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:20: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')]} 12:20:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:20:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:20:24 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 0x10499ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104a30618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fedb2d9faf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1048ffd30>, '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 0x104664db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1048f7b20>, '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.47pNUyM3s0/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.xAGJnQLTNj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2r/mjh615_91fs88xk2w8x_w5l800000w/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 12:20:24 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 12:20:24 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 12:20:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.47pNUyM3s0/Render', 12:20:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:20:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:20:24 INFO - 'HOME': '/Users/cltbld', 12:20:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:20:24 INFO - 'LOGNAME': 'cltbld', 12:20:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:20:24 INFO - 'MOZ_NO_REMOTE': '1', 12:20:24 INFO - 'NO_EM_RESTART': '1', 12:20:24 INFO - 'PAGER': '/bin/cat', 12:20:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:20:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:20:24 INFO - 'PWD': '/builds/slave/test', 12:20:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:20:24 INFO - 'SHELL': '/bin/bash', 12:20:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xAGJnQLTNj/Listeners', 12:20:24 INFO - 'TMPDIR': '/var/folders/2r/mjh615_91fs88xk2w8x_w5l800000w/T/', 12:20:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:20:24 INFO - 'USER': 'cltbld', 12:20:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:20:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:20:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:20:24 INFO - 'XPC_FLAGS': '0x0', 12:20:24 INFO - 'XPC_SERVICE_NAME': '0', 12:20:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:20:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:20:24 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 12:20:24 INFO - Cleaning up... 12:20:24 INFO - Return code: 0 12:20:24 INFO - Running post-action listener: _resource_record_post_action 12:20:24 INFO - Running post-action listener: _start_resource_monitoring 12:20:24 INFO - Starting resource monitoring. 12:20:24 INFO - [mozharness: 2016-08-07 19:20:24.752893Z] Finished create-virtualenv step (success) 12:20:24 INFO - [mozharness: 2016-08-07 19:20:24.753792Z] Running install step. 12:20:24 INFO - Running pre-action listener: _resource_record_pre_action 12:20:24 INFO - Running main action method: install 12:20:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:20:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:20:25 INFO - Reading from file tmpfile_stdout 12:20:25 INFO - Detecting whether we're running mozinstall >=1.0... 12:20:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:20:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:20:25 INFO - Reading from file tmpfile_stdout 12:20:25 INFO - Output received: 12:20:25 INFO - Usage: mozinstall [options] installer 12:20:25 INFO - Options: 12:20:25 INFO - -h, --help show this help message and exit 12:20:25 INFO - -d DEST, --destination=DEST 12:20:25 INFO - Directory to install application into. [default: 12:20:25 INFO - "/builds/slave/test"] 12:20:25 INFO - --app=APP Application being installed. [default: firefox] 12:20:25 INFO - mkdir: /builds/slave/test/build/application 12:20:25 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'] 12:20:25 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 12:20:59 INFO - Reading from file tmpfile_stdout 12:20:59 INFO - Output received: 12:20:59 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 12:20:59 INFO - Running post-action listener: _resource_record_post_action 12:20:59 INFO - [mozharness: 2016-08-07 19:20:59.728621Z] Finished install step (success) 12:20:59 INFO - [mozharness: 2016-08-07 19:20:59.728763Z] Running run-tests step. 12:20:59 INFO - Running pre-action listener: _resource_record_pre_action 12:20:59 INFO - Running main action method: run_tests 12:20:59 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 12:20:59 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 12:20:59 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 12:20:59 INFO - 2016-08-07 12:20:59.743 screenresolution[1650:10163] starting screenresolution argv=screenresolution get 12:20:59 INFO - 2016-08-07 12:20:59.745 screenresolution[1650:10163] Display 0: 1600x1200x32@60 12:20:59 INFO - 2016-08-07 12:20:59.751 screenresolution[1651:10165] starting screenresolution argv=screenresolution list 12:20:59 INFO - Available Modes on Display 0 12:20:59 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 12:20:59 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 12:20:59 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 12:20:59 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 12:20:59 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 12:20:59 INFO - Intel Iris: 12:20:59 INFO - Chipset Model: Intel Iris 12:20:59 INFO - Type: GPU 12:20:59 INFO - Bus: Built-In 12:20:59 INFO - VRAM (Dynamic, Max): 1536 MB 12:20:59 INFO - Vendor: Intel (0x8086) 12:20:59 INFO - Device ID: 0x0a2e 12:20:59 INFO - Revision ID: 0x0009 12:20:59 INFO - Displays: 12:20:59 INFO - Display: 12:20:59 INFO - Resolution: 1600 x 1200 @ 60 Hz 12:20:59 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 12:20:59 INFO - Display Serial Number: 1600x1200 60 12:20:59 INFO - Main Display: Yes 12:20:59 INFO - Mirror: Off 12:20:59 INFO - Online: Yes 12:20:59 INFO - Rotation: Supported 12:20:59 INFO - Return code: 0 12:20:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:20:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:20:59 INFO - Python 2.7.3 12:20:59 INFO - Return code: 0 12:20:59 INFO - grabbing minidump binary from tooltool 12:20:59 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')]} 12:20:59 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 0x1048ffd30>, '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 0x104664db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1048f7b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:20:59 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 12:20:59 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 12:20:59 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 12:21:00 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:21:00 INFO - Return code: 0 12:21:00 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 12:21:00 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:21:00 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:21:00 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 12:21:00 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:21:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fw2zS7k7TJuXZHy7J6H4Xw/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0358', '--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 12:21:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/fw2zS7k7TJuXZHy7J6H4Xw/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0358 --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 12:21:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.47pNUyM3s0/Render', 12:21:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:21:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:21:00 INFO - 'HOME': '/Users/cltbld', 12:21:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:21:00 INFO - 'LOGNAME': 'cltbld', 12:21:00 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:21:00 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 12:21:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:21:00 INFO - 'MOZ_NO_REMOTE': '1', 12:21:00 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:21:00 INFO - 'NO_EM_RESTART': '1', 12:21:00 INFO - 'PAGER': '/bin/cat', 12:21:00 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:21:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:21:00 INFO - 'PWD': '/builds/slave/test', 12:21:00 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:21:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:21:00 INFO - 'SHELL': '/bin/bash', 12:21:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xAGJnQLTNj/Listeners', 12:21:00 INFO - 'TMPDIR': '/var/folders/2r/mjh615_91fs88xk2w8x_w5l800000w/T/', 12:21:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:21:00 INFO - 'USER': 'cltbld', 12:21:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:21:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:21:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:21:00 INFO - 'XPC_FLAGS': '0x0', 12:21:00 INFO - 'XPC_SERVICE_NAME': '0', 12:21:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:21:00 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fw2zS7k7TJuXZHy7J6H4Xw/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0358', '--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 12:21:00 INFO - mozversion application_buildid: 20160807091052 12:21:00 INFO - mozversion application_changeset: 204b39c31233c082553493f52bfe8c3ebcc404ff 12:21:00 INFO - mozversion application_display_name: Nightly 12:21:00 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:21:00 INFO - mozversion application_name: Firefox 12:21:00 INFO - mozversion application_remotingname: firefox 12:21:00 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 12:21:00 INFO - mozversion application_vendor: Mozilla 12:21:00 INFO - mozversion application_version: 51.0a1 12:21:00 INFO - mozversion platform_buildid: 20160807091052 12:21:00 INFO - mozversion platform_changeset: 204b39c31233c082553493f52bfe8c3ebcc404ff 12:21:00 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 12:21:00 INFO - mozversion platform_version: 51.0a1 12:21:00 INFO - using testdate: 1470597660 12:21:00 INFO - actual date: 1470597660 12:21:00 INFO - starting webserver on 'localhost:49272' 12:21:00 INFO - SUITE-START | Running 2 tests 12:21:00 INFO - TEST-START | dromaeo_css 12:21:00 INFO - operating with platform_type : mac_ 12:21:00 INFO - Initialising browser for dromaeo_css test... 12:21:00 INFO - TEST-INFO | started process 1661 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/2r/mjh615_91fs88xk2w8x_w5l800000w/T/tmpguQ7Vl/profile http://localhost:49272/getInfo.html) 12:21:03 INFO - PROCESS | 1661 | __metrics Screen width/height:1600/1200 12:21:03 INFO - PROCESS | 1661 | colorDepth:24 12:21:03 INFO - PROCESS | 1661 | Browser inner width/height: 1024/689 12:21:03 INFO - PROCESS | 1661 | __metrics 12:21:03 ERROR - PROCESS | 1661 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 12:21:04 INFO - TEST-INFO | 1661: exit 0 12:21:04 INFO - Browser initialized. 12:21:04 INFO - Running cycle 1/1 for dromaeo_css test... 12:21:04 INFO - TEST-INFO | started process 1665 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/2r/mjh615_91fs88xk2w8x_w5l800000w/T/tmpguQ7Vl/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:21:16 INFO - PROCESS | 1665 | RSS: Main: 254533632 12:21:16 INFO - PROCESS | 1665 | 12:22:05 INFO - PROCESS | 1665 | 1470597725986 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] 12:24:19 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49272/tests/dromaeo/cssquery-ext.html) 12:24:20 INFO - PROCESS | 1665 | RSS: Main: 268083200 12:24:20 INFO - PROCESS | 1665 | 12:27:22 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-ext.html (next: http://localhost:49272/tests/dromaeo/cssquery-jquery.html) 12:27:23 INFO - PROCESS | 1665 | RSS: Main: 279977984 12:27:23 INFO - PROCESS | 1665 | 12:30:25 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49272/tests/dromaeo/cssquery-mootools.html) 12:30:25 INFO - PROCESS | 1665 | RSS: Main: 287457280 12:30:25 INFO - PROCESS | 1665 | 12:33:27 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49272/tests/dromaeo/cssquery-prototype.html) 12:33:28 INFO - PROCESS | 1665 | RSS: Main: 288542720 12:33:28 INFO - PROCESS | 1665 | 12:36:31 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49272/tests/dromaeo/cssquery-yui.html) 12:36:31 INFO - PROCESS | 1665 | RSS: Main: 291885056 12:36:31 INFO - PROCESS | 1665 | 12:39:34 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-yui.html (next: http://localhost:49272/tests/dromaeo/cssquery-dojo.html) 12:39:35 INFO - PROCESS | 1665 | RSS: Main: 292016128 12:39:35 INFO - PROCESS | 1665 | 12:39:35 INFO - PROCESS | 1665 | __start_tp_report 12:39:35 INFO - PROCESS | 1665 | _x_x_mozilla_page_load 12:39:35 INFO - PROCESS | 1665 | _x_x_mozilla_page_load_details 12:39:35 INFO - PROCESS | 1665 | |i|pagename|runs| 12:39:35 INFO - PROCESS | 1665 | |0;dojo.html;3468.0982944434445;3495.1262184453885;3498.2653642735027;3498.527698760668;3507.8070706111153;5798.6230894991795;5896.410358964102;5906.645601263922;6015.759369625221;6019.097135429688;5877.353491115984;5926.703664816752;5937.88124237515;5950.434708702677;5980.760769569223;3893.5911729268446;4217.578242175789;4233.957660423403;4545.52272011439;5490.560755139599;4481.708688935225;5504.4770746778995;5518.889622207554;5536.169574563827;5554.472325129106;4768.49930757269;4799.544043315879;5296.973515132399;5304.310439642861;5348.197770334442;5320.574354051667;5338.91991620126;5347.812826551052;5395.622306438551;5417.891642167135;5318.25544423781;5333.280007199017;5374.677519348852;5384.273123128367;5394.73026348681;5774.191613174159;5849.970750146222;5918.911216331715;5937.020391635375;5941.732622032019;5468.535174510172;5911.113333000041;6239.500839932794;6248.31268560458;6278.49772018242;6245.937540624581;6315.74737010519;6322.810315690536;6334.619922804646;6335.3981371769605;5907.645541267495;5971.462568368825;6002.429769171922;6021.397860213943;6085.908711369333;6312;6337.397947195009;6349.841253968688;6350.650714210763;6361.522885783585;6316.399942005502;6336.619802811846;6338.397852204125;6338.714757835908;6365.61806291624;6259.1550140730415;6261.96869015652;6271.310155882849;6289.371062893674;6327.588706734047;6170.568060235741;6175.44421002103;6251.437370636573;6317.3366796486625;6328.050792381087;6241.625502469867;6252.687365631791;6266.342034086447;6289.654069026156;6296.590721603173;5029.346184995927;5069.645124841226;5095.592352611782;5109.718965456861;5139.665921715076;4551.0442807010895;4552.453705555355;4584.037352156084;4613.838515651936;4640.095181439587;5896.941030589725;5985.072313791369;6025.066114752132;6040.09398590215;6040.973034584131;5729;6051.850148471776;6257;6286.277078136073;6300.527460440485;5940.524758019348;6028.5478589106;6031;6048.788292409745;6077.453029227302;5564.10974244119;5579.13523403873;5585.888282234332;5597.104463285936;5598.58010649203;6244.906326405198;6296.5277604178955;6340.239171299474;6450.4839612830865;6464.806055818333;6291.528135389955;6296.024116261987;6316.810495685137;6355.1420558224045;6378.394052564999;6439.098526206241;6490.902636460552;6494.6103233806125;6503.772367967098;6505;4977.726225057511;6223.751049957951;6305.432511073842;6341.682915854281;6345.555811093179;5226.477352264743;6247.875042499216;6331.556791024584;6331.873362532816;6364.363563643598;6237.688115594293;6268.968655156695;6293.433590976834;6298.779542715983;6322.49420046386;5123.820666276662;6130.264368275835;6142.109394137914;6197.938020619736;6300.558960872695;5460.31746031746;5987.952108381103;6131.743695906945;6203.96898015507;6220.911340515301;6260.467860231749;6265.122882796321;6268.435840774352;6287.528435367274;6292.998183280236;5100;6116.944513560587;6141.393954534099;6193.287771906108;6203.751849926133 12:39:35 INFO - PROCESS | 1665 | |1;ext.html;477.8805298675329;527.7651445106927;531.8829857431364;539.9514043736064;572.0646742575888;39147.217055658904;41979.580204197984;42031.89840507977;42074.57925420745;42179.94550136248;42088;42615.78692106543;42641.786791066;42683.78658106705;42804.35793463101;9659.227261819038;9779.217662586976;9825.06661867125;9826.968168342328;9863.556139973682;9717.125458708715;9789.755256118582;9797;9801.656942007032;9818.214542836591;9736.172425343855;9769.804603907918;9772.95113524435;9832.115109640132;9865.309428339982;9749.463779492125;9775.755606109833;9794.706158815246;9807.509624518745;9827.410355378628;9731;9758.414495130315;9774.511274436321;9811.362261453054;9818.80362392748;40375.7981210095;40557.39163912544;40868;41023.7948810254;41026.38460423096;3046.192758918888;3263.200515873626;3450.24279670055;3450.6204317525053;3491.1621210909198;29774.851125744448;31021;31193.22016949572;31409.528857067162;31564.684353156405;3035.575019497272;3035.894993749621;3040.878364865425;3048.2988912550018;3132.859021344045;410488;432489;433747;437644;437799;28441;33710.83144584261;34084.97745067652;34320.48519272213;34388.14029649279;35284;35421.291574168376;35642.465363019575;35897.282054358766;36139.09652258662;15966.680666386606;16308.83691163097;16402.671946561;16426.917865410596;16435.753463698053;12455.377231138407;12523.185992910432;12537.43581538833;12538.686532836751;12558;16035.679286414206;16106.436274730562;19601.31395401154;19735.506612334808;19791.40625781229;8175.182481751777;8268.421210515206;8306;8308.376871734523;8360.83278334442;877.2937785082942;908.7228395339353;985.5269470654126;1024.7557848312172;1035.7410647338165;30652.84673576618;30742.231444214074;30960.341164058882;31074.223144421117;31372;908.3732224764891;1017.1862509991977;1069.4813015687384;1180.6340034589134;1194.199886076331;12797;13353.198808071547;15255.618609534851;16086;16641.334346625998;630187;634744;637767;638684;640017;46541.30188047182;46598.76700616475;46963.5303646966;46991.65041747899;47130.528694712615;1224.5469176404788;1351.1690310459194;1388.6042477893955;1412.237391808412;1420.5241244183314;26447.206583802516;29026.854865725538;29845.55231671483;30595.694043060175;31038.844805775825;53766.429853461326;53962.92074158573;54065.648358791346;54085.459145409615;54269;578116;582776;582814;583078.0846095912;583345;27727.44545109127;28099.157025289274;28102.71897281001;28129.43741125207;28180;48717.51282487271;49156.508434915195;50751;50905.74547127241;51597.7420112897;40037.39943900786;40495;41194;41210;41573;41076;41234.38148427716;41295;42338.36492452677;42663.36004959866;34079.659203407646;38976.80511597424;39179.80410098045;39372;40018;26716.465670686088;32579.18552036218;33195.66804332023;34982.12544686403;35551;23336.416589585395;25822.741772582784;26023.349416264744;26235.52527902212;26328 12:39:35 INFO - PROCESS | 1665 | |2;jquery.html;356.1790073879708;375.4255988337843;384.70954429405805;389.38865980410765;400.1816285695752;17797.48721358686;18675.626487470243;19305.32431364901;20100.597988040267;21515.569688606218;16823.91588042058;20471.283505077325;20710.48223794406;20885.47786305343;20998.16007359704;5927.644341339523;6023.488003519706;6047.516198704115;6085.95370200803;6151.569390142692;4178.122594255195;5290.312259406272;5809;5993.940060599403;6047.213862197908;5553.555715542767;6363.331850155736;6686.063951046833;6703.832404189886;6865.279145689706;5302.787888484456;6070.6661133637635;6128.57100003;6751.9662401688165;6778.694958726845;4964.851054468371;5901.763929442817;5929.73316200772;5964.850878728066;5977.970110149465;25303.87348063248;25357.74642253572;25617.847196876184;26021.869890650425;26294.73705262942;2078.002558771783;2251;2465.8890349934118;2841.1476557032806;3010.3377257003426;10042.849357259574;10294.022067903537;10314.38113713172;10859.457027148612;15727.44953926607;1568.2942675795937;1686.3676121454455;1862.143414029548;1883.6326916251337;1952.453313072342;115590;116519;118576.22135667971;122950.38524807498;123806;10676.359418434919;11543.88456115445;11725.35510546911;11808.76382472363;11906.880931190577;14729.189894555688;14744.336504857307;14769;14782.26088695561;14784.556463306119;8323;8529.360297977677;8549.829003419896;8557.786055348666;8702.390832641655;6934.4452443804375;8359.164083591591;8435.536045517556;8451.788705282417;8642.135786421308;4565.543445655408;4570.542945705402;4580.610648094949;4592.5407459254475;4632.25883858581;1595.0907982450124;1940.8059194080479;1955.4817973237105;1964.0768838645813;2016.3446879763842;832.6544484039177;876.9956150219335;905.569200662951;933.3793027636682;967.3132076225818;21282.467938301666;21426.357209283433;21716.891415543138;21809.255259579197;21851.672224916638;880.0407555764248;980.4852452462515;988.1748739802202;988.6243227573476;998.9750256243652;10980.670579882617;11496.96527312546;11506.88493115075;11511.48198331077;11589.6523104307;595233;607486;609859;616903;618019;136320;141033;151489;153050;161082.1945890263;961.1974001708512;1006.9949650251701;1035.4201647077662;1037.7561273100816;1049.522467277387;19165.616687666447;19510;19821.702674459608;19869.602607947472;19935.800641993395;45668.77165614151;47898;54253.45746542484;58644.70677646584;59743.40256597378;86006;86940;87672;87992.56003719941;88297.11702883146;8148.959255203686;8179.83640327202;8311.750647480585;8342.416030877781;8494.362922780692;11195;12254.693632658898;12328.260304381765;12630.621081367573;13897;10243.436610986468;11478.196526243082;11822.586209482626;11879.287242765462;11975.700607484883;10185.08334249921;11040.447977600927;11505.194636375374;11563.6530904073;11844.940775296069;11791.469383877575;11804.76390472203;12089.939550302191;12092.93953530262;12105.939470302592;8200.958995204986;8280.83438331242;8286.627101780314;8385.329173666214;8462.915370846213;7546.094468663796;8788.340874434316;11452.770944581229;11560.728319884975;11726.296422214695 12:39:35 INFO - PROCESS | 1665 | |3;mootools.html;1526.458107371883;1569.2232344989231;1666.8582021315408;1779.2616064333301;1890.13998630623;7878.566678832662;8127.756167314983;8291.46105503142;8863.867041994376;8898.332625053123;8294.419390642657;8492.872606910885;8603.268722158607;8620.482771033743;8628.525431101287;2066.6486697261503;2118.1315660579166;2121.1303365620097;2131.7761635028332;2136.594047131048;1960;2313.144136669435;2314.2478694424294;2369.5142495788323;2378.0368950574957;2341;2349.9412514687097;2354.811615070799;2359.079958816063;2368.111958015744;2296.253717541789;2296.655501674754;2306.988465057681;2307.157887371106;2320.9303720888315;2354.2584086012853;2356.4697942962866;2357.9410514737096;2360.44529535559;2362.4802543440414;8727.170918762708;8744.300455963508;8757;8758.430702004349;8782.209601135928;5151.150060240056;5250.921236181461;5305.708186049766;5307.044731948247;5317.46825317469;2843.3744576193203;3045.9390812183856;3403.268297316089;3413.7781044232047;3593.7484376093685;1038.039813172812;1046.8796088449774;1050.6056607704463;1052.8315469524916;1074.6614816332908;11392.487338069806;11484.081273498183;11588.01501872342;11611.361375124365;11626.1861669684;4496.168208881302;4634.467036290802;4834.492378300298;4867.269909513601;4871.14754917888;9978.550965206583;9994.750131246778;10000.0999910007;10004.199244136125;10028.147607453302;5311.946880531145;5318.734063296897;5328.307320048369;5339.759710813023;5347.224652425377;4038.7778672173313;4278.657707383401;4559.726416415026;4691.601213896857;4729.84118890867;3889.669378102893;3923.843046278117;3996.5603783583783;4010.358342665218;4040.252553277653;1267.9366031698378;1295.9611211663664;1297.8377702787152;1306.8627794081674;1312.068431413688;868.8957325121025;921.161742814036;949.6486300069018;974.444566597047;978.2907392140642;5781.479666830005;5900.126352798941;5983.521318294526;6086.439333862085;6165.753369865245;440.3087153169493;442.52207615774887;448.4372112998166;453.7005576319613;1005.3910103281971;3997.2205419942834;4001.4691576167697;4078.7348822326453;4101.589841015934;4120.17596480705;10249.9487502562;10650.893491065146;10656.200784941006;10662.253642244968;10715.624953126604;10527.157827373792;10589.099926506333;10594.735131621772;10617.256792024484;10630.25588208818;7732.342750866127;7820.413468989848;7919.445638805229;8055.234752698484;8096.149904260085;5757.971210143923;5802.622829516068;5971.820845374646;5995.940040599713;6050.971334872994;9638.228941684789;9932.404055756677;9956.800863982824;10116.84824727615;10135.7466063349;9611.711648650551;9891.752706182404;10066.245031622511;10124.34191777532;10244.334118282586;6871.725130994704;7174.246704095995;7242.637868106468;7370.5946172961;7424.109106907205;8121.959390203011;8342.791430214293;8350.665973361241;8377.70678026266;8385.454945428528;7388.371988381048;7503.587302698404;7511.887321690288;7586.468947173645;7639.159692433716;7248.238934911969;7274.599897005715;7364;7430.888536672062;7436;6888.827779305558;6892.207396149507;6949.895751563832;6963.477739169683;6975.162980442379;4805.3512775774825;4905.313256144214;4927.961778684564;5072.771725272298;5133.230015497706;4173.770442625685;4261.446012018418;4525.818967241274;5010.098182327216;5152.407473140637 12:39:35 INFO - PROCESS | 1665 | |4;prototype.html;255.42401883752137;262.9592413175958;303.5689321163947;311.5389223948558;312.43917168682214;4950.801967921278;5497.175423686439;5559.527440167585;5709.857253568663;5735.713214339282;4870.561649451549;5088.829569199077;5248.950209958014;5422.647527910693;5713.942860571393;3417.367786959408;4217.43064686268;4321.481422229321;4364.170807546564;4368.039031413084;3734.514513113305;3932.9803350983207;4210.136921930997;4238.749568877173;4364.88695382677;3611.9277614447697;3896.7919944817054;4216.241076606209;4225.6830737694645;4238.8766976751185;3299.7790817397595;3697.8335974881193;3841.7898362016153;4202.2646036943415;4249.830006799724;2844.815087019337;3599.226166374216;3627.5102861113673;3631.800250986195;3635.4546817977252;4754.809807607691;5494.2857428534435;5534.0315444797;5554.389017208104;5561.388247292794;4006.399040144002;4249.897574770435;4844.588210002119;4853.660243782937;4859.757012149378;5548.4174161712845;5557.777688892439;5687.7156142192725;5979.19280897082;5981;3357.9664203358143;3614.8554057837655;3634.436662317345;3971.900702482461;3990.68074554035;6184.628922264678;6205.410486003822;6263.78076767311;6293.514061945598;6299.181126438279;3512.051746028558;3861.4940173332425;3913.5303763548554;3999.64003239704;4051.4125451809323;3567.554055743032;4047.5226542311843;4069.5320038195987;4077.4699289092823;4094.201630682048;4379.693421460467;4407.294832826797;4414.426124603845;4825.348577942003;4855.44162421319;4870.712269218264;5230.895382092337;5674.773009079673;6030.216071910623;6100.444386681368;1162.4187906046977;1307.5750381125981;1341.745068436994;1386.9445222191;1392.9065683438453;832.6669332267021;851.7947104846572;908.9909100909039;916.1113719691888;933.5809569454391;5490.588205884575;5513.228148059275;5513.58648101394;5525.143602741581;5553.416891226363;5325.3609566851455;6075.513958883279;6092.817215483543;6145.631262124287;6167.581456265084;4818.6626936114835;4832.323474713543;5175.054596480127;5250.816221432308;5509.3664228613425;2352.7647235276336;2401.4836810085917;2484;2558.3348329434107;2643.8810253538636;4379.846705365297;4738.668293219442;4930.457649658535;5253.868653283698;5362.410134885159;5191.299174611455;5285.788568457218;5307.363116426053;5816.360200377955;6371.630099528624;5446.786396026363;5553.083741182741;6025.457708806316;6385.361463853577;6446.903296450463;5444.891102178013;5792.710364481674;6180.721867515883;6282.963311053625;6313.042956683443;5167.741612919263;5559.33288005442;6068.787592434243;6098.756049758137;6166.290876549254;5794.565407594363;5920.934231838138;6321.431071203614;6354.491640668828;6455.741770329134;3453.8791142309897;3753.6434038767366;4036.5156181258435;4073.6537394321813;4085.8774236772942;5254.65844720092;5694.804091140742;5924.526037917042;6150.507959363151;6222.719977600928;4980.352554167935;5982.248165843761;6019.4883434908525;6040.577159598786;6046.486048685911;6044.304904935989;6056.636601803906;6072.969635151972;6094.299155597163;6102.511799056154;5016.849494515171;5485.5589262777685;5563.942850858324;5627.43725627434;5939.227900372924;4973.104841128632;5706.6005379624685;6108.541859360477;6117.694115294306;6144.692765361625;5046.798128074836;5173.3533308336455;5561.833145005657;5901.91147132802;5961 12:39:35 INFO - PROCESS | 1665 | |5;yui.html;648.5913874259217;704.936555709986;796.2634563029197;797.7845981584976;855.3841234311295;15235.771463428044;15604.141772202523;15864.127472988981;15897.761533576977;15940.92029539852;13765.518206862762;14168.716625667481;14302.57092287233;14317.642058948531;14368.20974846383;808.3250485844327;828.8590939540293;860.1785295043235;885.5350940756123;885.9468431894107;685.4447897203281;774.8643987302228;824.8391563645091;849.5454931611589;860.9698660546882;921.5208091792264;924.2005665099707;926.9212116970066;930.9022552631977;931.2968708624978;893.4683863101444;922.9584668689926;924.8936372317169;925.1165137293935;925.1765928323797;563.7857614106613;682.0042737603105;686.5571706249441;686.7493364921768;688.9311068893121;14319.355628996616;14458.783118253235;14516.637084072878;14789;14846.554603361916;14469.131852088909;14776.704465910621;14822.40710371584;14831.70336593262;14954.700905981928;9779.315447918649;10550;11669.416529173592;11940.880591194064;11975.700607484796;3848.9230215395814;3857.0743021674875;3880.6701430378453;3886.261610294035;3920.862769803043;116380;117189;117801;118787;120208;11215.943920280346;11221.831672524919;11464.312141271384;11523.884761152449;11782.234154779911;19672.90163549173;23506;23814.880925595262;23882.641760373608;23900.163494277618;7481.289277518627;8117.391195660349;8268.917310826935;8291.668333266602;8486.915130848736;4470.731756094645;4569.588737013684;4577.22187228172;4580.7938642761155;4582.564656357641;3014.125903487964;3391.9152021199175;3510.543629328222;3551.698105661048;3569.39320315547;616.8341833933869;673.1215763428675;673.4174938678008;677.9325040884107;742.9591372474566;605.5700452678559;668.4385116502161;686.5503095472474;689.8137502874196;694.5207806613421;9394.483303418241;9738.123568878835;9838.376667849867;9917.057879501435;9959.502024898726;570.6775671745534;633.1515768869737;633.3160186998031;656.3633275722541;663.4592806862488;4528.184926713157;4799.424069111659;4801.159797035505;4814.665291047953;4957.157283261854;101119;125510.74489255174;140830.88753668702;151621;166284.16857915875;32588.93457720561;138527.84416467522;139866;140313;141867;73999;85575.572122139;107862.3820642691;113361;116873;9046.321525885453;9172.35793494449;9278.675246366345;9291.888215347886;9450.669226577036;40222.79888600538;44684.55315446934;49686.00627987492;50196.74901625468;51856;47105;94958;100684.49657751665;101292;102002.48998754959;11862.881371186522;11955.625103112905;12073.637790866289;12323.630291091282;12493.625191244277;11085.612003579836;13364.866351336752;13542.932285338511;13871.4451421942;13945.093568917988;12199.207051541622;12460.190087644274;12501.93749031249;12594.496220151092;12955.481780728665;12410.910668774663;12600.810987835006;12748.235105893305;12867.549635762703;13140.408681609159;11932.940335298268;12249.571265005681;12336.62990110298;12764;12779.680507987374;10156.986962436362;10272.794544108927;10276.640317588848;10450;10689.732756681145;9222.139488706875;9433.716988490356;10637.215795771963;10918.781624367628;10955.397453140155 12:39:35 INFO - PROCESS | 1665 | __end_tp_report 12:39:35 INFO - PROCESS | 1665 | __start_cc_report 12:39:35 INFO - PROCESS | 1665 | _x_x_mozilla_cycle_collect,419 12:39:35 INFO - PROCESS | 1665 | __end_cc_report 12:39:35 INFO - PROCESS | 1665 | __startTimestamp1470598775089__endTimestamp 12:39:35 INFO - PROCESS | 1665 | 12:39:35 INFO - PROCESS | 1665 | ------- Summary: start ------- 12:39:35 INFO - PROCESS | 1665 | Number of tests: 6 12:39:35 INFO - PROCESS | 1665 | 12:39:35 INFO - PROCESS | 1665 | [#0] dojo.html Cycles:165 Average:5815.03 Median:6051.85 stddev:685.92 (11.3%) stddev-sans-first:662.86 12:39:35 INFO - PROCESS | 1665 | Values: 3468.1 3495.1 3498.3 3498.5 3507.8 5798.6 5896.4 5906.6 6015.8 6019.1 5877.4 5926.7 5937.9 5950.4 5980.8 3893.6 4217.6 4234.0 4545.5 5490.6 4481.7 5504.5 5518.9 5536.2 5554.5 4768.5 4799.5 5297.0 5304.3 5348.2 5320.6 5338.9 5347.8 5395.6 5417.9 5318.3 5333.3 5374.7 5384.3 5394.7 5774.2 5850.0 5918.9 5937.0 5941.7 5468.5 5911.1 6239.5 6248.3 6278.5 6245.9 6315.7 6322.8 6334.6 6335.4 5907.6 5971.5 6002.4 6021.4 6085.9 6312.0 6337.4 6349.8 6350.7 6361.5 6316.4 6336.6 6338.4 6338.7 6365.6 6259.2 6262.0 6271.3 6289.4 6327.6 6170.6 6175.4 6251.4 6317.3 6328.1 6241.6 6252.7 6266.3 6289.7 6296.6 5029.3 5069.6 5095.6 5109.7 5139.7 4551.0 4552.5 4584.0 4613.8 4640.1 5896.9 5985.1 6025.1 6040.1 6041.0 5729.0 6051.9 6257.0 6286.3 6300.5 5940.5 6028.5 6031.0 6048.8 6077.5 5564.1 5579.1 5585.9 5597.1 5598.6 6244.9 6296.5 6340.2 6450.5 6464.8 6291.5 6296.0 6316.8 6355.1 6378.4 6439.1 6490.9 6494.6 6503.8 6505.0 4977.7 6223.8 6305.4 6341.7 6345.6 5226.5 6247.9 6331.6 6331.9 6364.4 6237.7 6269.0 6293.4 6298.8 6322.5 5123.8 6130.3 6142.1 6197.9 6300.6 5460.3 5988.0 6131.7 6204.0 6220.9 6260.5 6265.1 6268.4 6287.5 6293.0 5100.0 6116.9 6141.4 6193.3 6203.8 12:39:35 INFO - PROCESS | 1665 | 12:39:35 INFO - PROCESS | 1665 | [#1] ext.html Cycles:180 Average:67257.89 Median:40712.70 stddev:148840.04 (365.6%) stddev-sans-first:149173.13 12:39:35 INFO - PROCESS | 1665 | Values: 477.9 527.8 531.9 540.0 572.1 39147.2 41979.6 42031.9 42074.6 42179.9 42088.0 42615.8 42641.8 42683.8 42804.4 9659.2 9779.2 9825.1 9827.0 9863.6 9717.1 9789.8 9797.0 9801.7 9818.2 9736.2 9769.8 9773.0 9832.1 9865.3 9749.5 9775.8 9794.7 9807.5 9827.4 9731.0 9758.4 9774.5 9811.4 9818.8 40375.8 40557.4 40868.0 41023.8 41026.4 3046.2 3263.2 3450.2 3450.6 3491.2 29774.9 31021.0 31193.2 31409.5 31564.7 3035.6 3035.9 3040.9 3048.3 3132.9 410488.0 432489.0 433747.0 437644.0 437799.0 28441.0 33710.8 34085.0 34320.5 34388.1 35284.0 35421.3 35642.5 35897.3 36139.1 15966.7 16308.8 16402.7 16426.9 16435.8 12455.4 12523.2 12537.4 12538.7 12558.0 16035.7 16106.4 19601.3 19735.5 19791.4 8175.2 8268.4 8306.0 8308.4 8360.8 877.3 908.7 985.5 1024.8 1035.7 30652.8 30742.2 30960.3 31074.2 31372.0 908.4 1017.2 1069.5 1180.6 1194.2 12797.0 13353.2 15255.6 16086.0 16641.3 630187.0 634744.0 637767.0 638684.0 640017.0 46541.3 46598.8 46963.5 46991.7 47130.5 1224.5 1351.2 1388.6 1412.2 1420.5 26447.2 29026.9 29845.6 30595.7 31038.8 53766.4 53962.9 54065.6 54085.5 54269.0 578116.0 582776.0 582814.0 583078.1 583345.0 27727.4 28099.2 28102.7 28129.4 28180.0 48717.5 49156.5 50751.0 50905.7 51597.7 40037.4 40495.0 41194.0 41210.0 41573.0 41076.0 41234.4 41295.0 42338.4 42663.4 34079.7 38976.8 39179.8 39372.0 40018.0 26716.5 32579.2 33195.7 34982.1 35551.0 23336.4 25822.7 26023.3 26235.5 26328.0 12:39:35 INFO - PROCESS | 1665 | 12:39:35 INFO - PROCESS | 1665 | [#2] jquery.html Cycles:180 Average:36346.33 Median:25330.81 stddev:102350.31 (404.1%) stddev-sans-first:102601.75 12:39:35 INFO - PROCESS | 1665 | Values: 356.2 375.4 384.7 389.4 400.2 17797.5 18675.6 19305.3 20100.6 21515.6 16823.9 20471.3 20710.5 20885.5 20998.2 5927.6 6023.5 6047.5 6086.0 6151.6 4178.1 5290.3 5809.0 5993.9 6047.2 5553.6 6363.3 6686.1 6703.8 6865.3 5302.8 6070.7 6128.6 6752.0 6778.7 4964.9 5901.8 5929.7 5964.9 5978.0 25303.9 25357.7 25617.8 26021.9 26294.7 2078.0 2251.0 2465.9 2841.1 3010.3 10042.8 10294.0 10314.4 10859.5 15727.4 1568.3 1686.4 1862.1 1883.6 1952.5 115590.0 116519.0 118576.2 122950.4 123806.0 10676.4 11543.9 11725.4 11808.8 11906.9 14729.2 14744.3 14769.0 14782.3 14784.6 8323.0 8529.4 8549.8 8557.8 8702.4 6934.4 8359.2 8435.5 8451.8 8642.1 4565.5 4570.5 4580.6 4592.5 4632.3 1595.1 1940.8 1955.5 1964.1 2016.3 832.7 877.0 905.6 933.4 967.3 21282.5 21426.4 21716.9 21809.3 21851.7 880.0 980.5 988.2 988.6 999.0 10980.7 11497.0 11506.9 11511.5 11589.7 595233.0 607486.0 609859.0 616903.0 618019.0 136320.0 141033.0 151489.0 153050.0 161082.2 961.2 1007.0 1035.4 1037.8 1049.5 19165.6 19510.0 19821.7 19869.6 19935.8 45668.8 47898.0 54253.5 58644.7 59743.4 86006.0 86940.0 87672.0 87992.6 88297.1 8149.0 8179.8 8311.8 8342.4 8494.4 11195.0 12254.7 12328.3 12630.6 13897.0 10243.4 11478.2 11822.6 11879.3 11975.7 10185.1 11040.4 11505.2 11563.7 11844.9 11791.5 11804.8 12089.9 12092.9 12105.9 8201.0 8280.8 8286.6 8385.3 8462.9 7546.1 8788.3 11452.8 11560.7 11726.3 12:39:35 INFO - PROCESS | 1665 | 12:39:35 INFO - PROCESS | 1665 | [#3] mootools.html Cycles:180 Average:5642.73 Median:4663.03 stddev:3192.90 (68.5%) stddev-sans-first:3186.87 12:39:35 INFO - PROCESS | 1665 | Values: 1526.5 1569.2 1666.9 1779.3 1890.1 7878.6 8127.8 8291.5 8863.9 8898.3 8294.4 8492.9 8603.3 8620.5 8628.5 2066.6 2118.1 2121.1 2131.8 2136.6 1960.0 2313.1 2314.2 2369.5 2378.0 2341.0 2349.9 2354.8 2359.1 2368.1 2296.3 2296.7 2307.0 2307.2 2320.9 2354.3 2356.5 2357.9 2360.4 2362.5 8727.2 8744.3 8757.0 8758.4 8782.2 5151.2 5250.9 5305.7 5307.0 5317.5 2843.4 3045.9 3403.3 3413.8 3593.7 1038.0 1046.9 1050.6 1052.8 1074.7 11392.5 11484.1 11588.0 11611.4 11626.2 4496.2 4634.5 4834.5 4867.3 4871.1 9978.6 9994.8 10000.1 10004.2 10028.1 5311.9 5318.7 5328.3 5339.8 5347.2 4038.8 4278.7 4559.7 4691.6 4729.8 3889.7 3923.8 3996.6 4010.4 4040.3 1267.9 1296.0 1297.8 1306.9 1312.1 868.9 921.2 949.6 974.4 978.3 5781.5 5900.1 5983.5 6086.4 6165.8 440.3 442.5 448.4 453.7 1005.4 3997.2 4001.5 4078.7 4101.6 4120.2 10249.9 10650.9 10656.2 10662.3 10715.6 10527.2 10589.1 10594.7 10617.3 10630.3 7732.3 7820.4 7919.4 8055.2 8096.1 5758.0 5802.6 5971.8 5995.9 6051.0 9638.2 9932.4 9956.8 10116.8 10135.7 9611.7 9891.8 10066.2 10124.3 10244.3 6871.7 7174.2 7242.6 7370.6 7424.1 8122.0 8342.8 8350.7 8377.7 8385.5 7388.4 7503.6 7511.9 7586.5 7639.2 7248.2 7274.6 7364.0 7430.9 7436.0 6888.8 6892.2 6949.9 6963.5 6975.2 4805.4 4905.3 4928.0 5072.8 5133.2 4173.8 4261.4 4525.8 5010.1 5152.4 12:39:35 INFO - PROCESS | 1665 | 12:39:35 INFO - PROCESS | 1665 | [#4] prototype.html Cycles:180 Average:4682.23 Median:5252.34 stddev:1517.10 (28.9%) stddev-sans-first:1484.53 12:39:35 INFO - PROCESS | 1665 | Values: 255.4 263.0 303.6 311.5 312.4 4950.8 5497.2 5559.5 5709.9 5735.7 4870.6 5088.8 5249.0 5422.6 5713.9 3417.4 4217.4 4321.5 4364.2 4368.0 3734.5 3933.0 4210.1 4238.7 4364.9 3611.9 3896.8 4216.2 4225.7 4238.9 3299.8 3697.8 3841.8 4202.3 4249.8 2844.8 3599.2 3627.5 3631.8 3635.5 4754.8 5494.3 5534.0 5554.4 5561.4 4006.4 4249.9 4844.6 4853.7 4859.8 5548.4 5557.8 5687.7 5979.2 5981.0 3358.0 3614.9 3634.4 3971.9 3990.7 6184.6 6205.4 6263.8 6293.5 6299.2 3512.1 3861.5 3913.5 3999.6 4051.4 3567.6 4047.5 4069.5 4077.5 4094.2 4379.7 4407.3 4414.4 4825.3 4855.4 4870.7 5230.9 5674.8 6030.2 6100.4 1162.4 1307.6 1341.7 1386.9 1392.9 832.7 851.8 909.0 916.1 933.6 5490.6 5513.2 5513.6 5525.1 5553.4 5325.4 6075.5 6092.8 6145.6 6167.6 4818.7 4832.3 5175.1 5250.8 5509.4 2352.8 2401.5 2484.0 2558.3 2643.9 4379.8 4738.7 4930.5 5253.9 5362.4 5191.3 5285.8 5307.4 5816.4 6371.6 5446.8 5553.1 6025.5 6385.4 6446.9 5444.9 5792.7 6180.7 6283.0 6313.0 5167.7 5559.3 6068.8 6098.8 6166.3 5794.6 5920.9 6321.4 6354.5 6455.7 3453.9 3753.6 4036.5 4073.7 4085.9 5254.7 5694.8 5924.5 6150.5 6222.7 4980.4 5982.2 6019.5 6040.6 6046.5 6044.3 6056.6 6073.0 6094.3 6102.5 5016.8 5485.6 5563.9 5627.4 5939.2 4973.1 5706.6 6108.5 6117.7 6144.7 5046.8 5173.4 5561.8 5901.9 5961.0 12:39:35 INFO - PROCESS | 1665 | 12:39:35 INFO - PROCESS | 1665 | [#5] yui.html Cycles:180 Average:23582.29 Median:3531.12 stddev:38473.10 (1089.5%) stddev-sans-first:38542.49 12:39:35 INFO - PROCESS | 1665 | Values: 648.6 704.9 796.3 797.8 855.4 15235.8 15604.1 15864.1 15897.8 15940.9 13765.5 14168.7 14302.6 14317.6 14368.2 808.3 828.9 860.2 885.5 885.9 685.4 774.9 824.8 849.5 861.0 921.5 924.2 926.9 930.9 931.3 893.5 923.0 924.9 925.1 925.2 563.8 682.0 686.6 686.7 688.9 14319.4 14458.8 14516.6 14789.0 14846.6 14469.1 14776.7 14822.4 14831.7 14954.7 9779.3 10550.0 11669.4 11940.9 11975.7 3848.9 3857.1 3880.7 3886.3 3920.9 116380.0 117189.0 117801.0 118787.0 120208.0 11215.9 11221.8 11464.3 11523.9 11782.2 19672.9 23506.0 23814.9 23882.6 23900.2 7481.3 8117.4 8268.9 8291.7 8486.9 4470.7 4569.6 4577.2 4580.8 4582.6 3014.1 3391.9 3510.5 3551.7 3569.4 616.8 673.1 673.4 677.9 743.0 605.6 668.4 686.6 689.8 694.5 9394.5 9738.1 9838.4 9917.1 9959.5 570.7 633.2 633.3 656.4 663.5 4528.2 4799.4 4801.2 4814.7 4957.2 101119.0 125510.7 140830.9 151621.0 166284.2 32588.9 138527.8 139866.0 140313.0 141867.0 73999.0 85575.6 107862.4 113361.0 116873.0 9046.3 9172.4 9278.7 9291.9 9450.7 40222.8 44684.6 49686.0 50196.7 51856.0 47105.0 94958.0 100684.5 101292.0 102002.5 11862.9 11955.6 12073.6 12323.6 12493.6 11085.6 13364.9 13542.9 13871.4 13945.1 12199.2 12460.2 12501.9 12594.5 12955.5 12410.9 12600.8 12748.2 12867.5 13140.4 11932.9 12249.6 12336.6 12764.0 12779.7 10157.0 10272.8 10276.6 10450.0 10689.7 9222.1 9433.7 10637.2 10918.8 10955.4 12:39:35 INFO - PROCESS | 1665 | -------- Summary: end -------- 12:39:35 INFO - PROCESS | 1665 | 12:39:35 INFO - TEST-INFO | 1665: exit 0 12:39:35 INFO - TEST-OK | dromaeo_css | took 1115398ms 12:39:35 INFO - TEST-START | kraken 12:39:35 INFO - operating with platform_type : mac_ 12:39:35 INFO - Initialising browser for kraken test... 12:39:35 INFO - TEST-INFO | started process 1673 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/2r/mjh615_91fs88xk2w8x_w5l800000w/T/tmpJytKdw/profile http://localhost:49272/getInfo.html) 12:39:38 INFO - PROCESS | 1673 | __metrics Screen width/height:1600/1200 12:39:38 INFO - PROCESS | 1673 | colorDepth:24 12:39:38 INFO - PROCESS | 1673 | Browser inner width/height: 1024/689 12:39:38 INFO - PROCESS | 1673 | __metrics 12:39:38 ERROR - PROCESS | 1673 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 12:39:39 INFO - TEST-INFO | 1673: exit 0 12:39:39 INFO - Browser initialized. 12:39:39 INFO - Running cycle 1/1 for kraken test... 12:39:39 INFO - TEST-INFO | started process 1675 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/2r/mjh615_91fs88xk2w8x_w5l800000w/T/tmpJytKdw/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:39:51 INFO - PROCESS | 1675 | RSS: Main: 254468096 12:39:51 INFO - PROCESS | 1675 | 12:39:54 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-beat-detection) 12:39:54 INFO - PROCESS | 1675 | RSS: Main: 267988992 12:39:54 INFO - PROCESS | 1675 | 12:39:57 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-dft) 12:39:58 INFO - PROCESS | 1675 | RSS: Main: 276115456 12:39:58 INFO - PROCESS | 1675 | 12:40:01 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-fft) 12:40:02 INFO - PROCESS | 1675 | RSS: Main: 278929408 12:40:02 INFO - PROCESS | 1675 | 12:40:04 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-oscillator) 12:40:04 INFO - PROCESS | 1675 | RSS: Main: 280432640 12:40:04 INFO - PROCESS | 1675 | 12:40:06 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:40:07 INFO - PROCESS | 1675 | RSS: Main: 282030080 12:40:07 INFO - PROCESS | 1675 | 12:40:10 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-darkroom) 12:40:11 INFO - PROCESS | 1675 | RSS: Main: 282091520 12:40:11 INFO - PROCESS | 1675 | 12:40:13 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-desaturate) 12:40:14 INFO - PROCESS | 1675 | RSS: Main: 281735168 12:40:14 INFO - PROCESS | 1675 | 12:40:17 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49272/tests/kraken/driver.html?testName=json-parse-financial) 12:40:18 INFO - PROCESS | 1675 | RSS: Main: 282456064 12:40:18 INFO - PROCESS | 1675 | 12:40:19 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49272/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:40:20 INFO - PROCESS | 1675 | RSS: Main: 282337280 12:40:20 INFO - PROCESS | 1675 | 12:40:22 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:40:23 INFO - PROCESS | 1675 | RSS: Main: 282443776 12:40:23 INFO - PROCESS | 1675 | 12:40:25 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:40:26 INFO - PROCESS | 1675 | RSS: Main: 282505216 12:40:26 INFO - PROCESS | 1675 | 12:40:28 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:40:29 INFO - PROCESS | 1675 | RSS: Main: 282411008 12:40:29 INFO - PROCESS | 1675 | 12:40:32 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:40:33 INFO - PROCESS | 1675 | RSS: Main: 283025408 12:40:33 INFO - PROCESS | 1675 | 12:40:34 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49272/tests/kraken/driver.html?testName=ai-astar) 12:40:35 INFO - PROCESS | 1675 | RSS: Main: 284049408 12:40:35 INFO - PROCESS | 1675 | 12:40:35 INFO - PROCESS | 1675 | __start_tp_report 12:40:35 INFO - PROCESS | 1675 | _x_x_mozilla_page_load 12:40:35 INFO - PROCESS | 1675 | _x_x_mozilla_page_load_details 12:40:35 INFO - PROCESS | 1675 | |i|pagename|runs| 12:40:35 INFO - PROCESS | 1675 | |0;ai-astar;105;118;108;117;116;117;114;118;116;118 12:40:35 INFO - PROCESS | 1675 | |1;audio-beat-detection;141;112;124;187;142;135;142;134;159;109 12:40:35 INFO - PROCESS | 1675 | |2;audio-dft;261;266;237;199;195;195;196;203;192;195 12:40:35 INFO - PROCESS | 1675 | |3;audio-fft;70;84;75;143;69;81;82;63;136;60 12:40:35 INFO - PROCESS | 1675 | |4;audio-oscillator;70;72;116;73;71;86;111;69;71;127 12:40:35 INFO - PROCESS | 1675 | |5;imaging-gaussian-blur;91;93;133;88;91;87;92;90;90;88 12:40:35 INFO - PROCESS | 1675 | |6;imaging-darkroom;96;97;121;97;96;136;109;98;96;102 12:40:35 INFO - PROCESS | 1675 | |7;imaging-desaturate;90;96;96;93;90;90;99;93;124;87 12:40:35 INFO - PROCESS | 1675 | |8;json-parse-financial;58;58;56;56;87;88;50;54;57;86 12:40:35 INFO - PROCESS | 1675 | |9;json-stringify-tinderbox;68;72;89;67;78;90;108;105;87;71 12:40:35 INFO - PROCESS | 1675 | |10;stanford-crypto-aes;88;85;93;84;85;83;85;85;88;84 12:40:35 INFO - PROCESS | 1675 | |11;stanford-crypto-ccm;154;157;147;140;139;138;140;158;140;154 12:40:35 INFO - PROCESS | 1675 | |12;stanford-crypto-pbkdf2;166;171;167;168;171;166;175;173;224;166 12:40:35 INFO - PROCESS | 1675 | |13;stanford-crypto-sha256-iterative;80;90;89;88;74;68;67;79;84;88 12:40:35 INFO - PROCESS | 1675 | __end_tp_report 12:40:35 INFO - PROCESS | 1675 | __start_cc_report 12:40:35 INFO - PROCESS | 1675 | _x_x_mozilla_cycle_collect,1045 12:40:35 INFO - PROCESS | 1675 | __end_cc_report 12:40:35 INFO - PROCESS | 1675 | __startTimestamp1470598835163__endTimestamp 12:40:35 INFO - PROCESS | 1675 | 12:40:35 INFO - PROCESS | 1675 | ------- Summary: start ------- 12:40:35 INFO - PROCESS | 1675 | Number of tests: 14 12:40:35 INFO - PROCESS | 1675 | 12:40:35 INFO - PROCESS | 1675 | [#0] ai-astar Cycles:10 Average:114.70 Median:117.00 stddev:4.55 (3.9%) stddev-sans-first:3.19 12:40:35 INFO - PROCESS | 1675 | Values: 105.0 118.0 108.0 117.0 116.0 117.0 114.0 118.0 116.0 118.0 12:40:35 INFO - PROCESS | 1675 | 12:40:35 INFO - PROCESS | 1675 | [#1] audio-beat-detection Cycles:10 Average:138.50 Median:141.50 stddev:22.65 (16.0%) stddev-sans-first:24.01 12:40:35 INFO - PROCESS | 1675 | Values: 141.0 112.0 124.0 187.0 142.0 135.0 142.0 134.0 159.0 109.0 12:40:35 INFO - PROCESS | 1675 | 12:40:35 INFO - PROCESS | 1675 | [#2] audio-dft Cycles:10 Average:213.90 Median:201.00 stddev:29.21 (14.5%) stddev-sans-first:25.53 12:40:35 INFO - PROCESS | 1675 | Values: 261.0 266.0 237.0 199.0 195.0 195.0 196.0 203.0 192.0 195.0 12:40:35 INFO - PROCESS | 1675 | 12:40:35 INFO - PROCESS | 1675 | [#3] audio-fft Cycles:10 Average:86.30 Median:72.50 stddev:29.18 (40.3%) stddev-sans-first:30.35 12:40:35 INFO - PROCESS | 1675 | Values: 70.0 84.0 75.0 143.0 69.0 81.0 82.0 63.0 136.0 60.0 12:40:35 INFO - PROCESS | 1675 | 12:40:35 INFO - PROCESS | 1675 | [#4] audio-oscillator Cycles:10 Average:86.60 Median:71.00 stddev:22.52 (31.7%) stddev-sans-first:23.07 12:40:35 INFO - PROCESS | 1675 | Values: 70.0 72.0 116.0 73.0 71.0 86.0 111.0 69.0 71.0 127.0 12:40:35 INFO - PROCESS | 1675 | 12:40:35 INFO - PROCESS | 1675 | [#5] imaging-gaussian-blur Cycles:10 Average:94.30 Median:90.50 stddev:13.73 (15.2%) stddev-sans-first:14.51 12:40:35 INFO - PROCESS | 1675 | Values: 91.0 93.0 133.0 88.0 91.0 87.0 92.0 90.0 90.0 88.0 12:40:35 INFO - PROCESS | 1675 | 12:40:35 INFO - PROCESS | 1675 | [#6] imaging-darkroom Cycles:10 Average:104.80 Median:96.00 stddev:13.59 (14.2%) stddev-sans-first:14.03 12:40:35 INFO - PROCESS | 1675 | Values: 96.0 97.0 121.0 97.0 96.0 136.0 109.0 98.0 96.0 102.0 12:40:35 INFO - PROCESS | 1675 | 12:40:35 INFO - PROCESS | 1675 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:93.00 stddev:10.54 (11.3%) stddev-sans-first:10.97 12:40:35 INFO - PROCESS | 1675 | Values: 90.0 96.0 96.0 93.0 90.0 90.0 99.0 93.0 124.0 87.0 12:40:35 INFO - PROCESS | 1675 | 12:40:35 INFO - PROCESS | 1675 | [#8] json-parse-financial Cycles:10 Average:65.00 Median:58.00 stddev:15.36 (26.5%) stddev-sans-first:16.08 12:40:35 INFO - PROCESS | 1675 | Values: 58.0 58.0 56.0 56.0 87.0 88.0 50.0 54.0 57.0 86.0 12:40:35 INFO - PROCESS | 1675 | 12:40:35 INFO - PROCESS | 1675 | [#9] json-stringify-tinderbox Cycles:10 Average:83.50 Median:75.00 stddev:14.83 (19.8%) stddev-sans-first:14.63 12:40:35 INFO - PROCESS | 1675 | Values: 68.0 72.0 89.0 67.0 78.0 90.0 108.0 105.0 87.0 71.0 12:40:35 INFO - PROCESS | 1675 | 12:40:35 INFO - PROCESS | 1675 | [#10] stanford-crypto-aes Cycles:10 Average:86.00 Median:85.00 stddev:2.94 (3.5%) stddev-sans-first:3.03 12:40:35 INFO - PROCESS | 1675 | Values: 88.0 85.0 93.0 84.0 85.0 83.0 85.0 85.0 88.0 84.0 12:40:35 INFO - PROCESS | 1675 | 12:40:35 INFO - PROCESS | 1675 | [#11] stanford-crypto-ccm Cycles:10 Average:146.70 Median:150.50 stddev:8.23 (5.5%) stddev-sans-first:8.30 12:40:35 INFO - PROCESS | 1675 | Values: 154.0 157.0 147.0 140.0 139.0 138.0 140.0 158.0 140.0 154.0 12:40:35 INFO - PROCESS | 1675 | 12:40:35 INFO - PROCESS | 1675 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:174.70 Median:171.00 stddev:17.61 (10.3%) stddev-sans-first:18.40 12:40:35 INFO - PROCESS | 1675 | Values: 166.0 171.0 167.0 168.0 171.0 166.0 175.0 173.0 224.0 166.0 12:40:35 INFO - PROCESS | 1675 | 12:40:35 INFO - PROCESS | 1675 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:80.70 Median:86.00 stddev:8.63 (10.0%) stddev-sans-first:9.15 12:40:35 INFO - PROCESS | 1675 | Values: 80.0 90.0 89.0 88.0 74.0 68.0 67.0 79.0 84.0 88.0 12:40:35 INFO - PROCESS | 1675 | -------- Summary: end -------- 12:40:35 INFO - PROCESS | 1675 | 12:40:36 INFO - TEST-INFO | 1675: exit 0 12:40:36 INFO - TEST-OK | kraken | took 60414ms 12:40:36 INFO - SUITE-END | took 1175s 12:40:36 INFO - Completed test suite (00:19:35) 12:40:36 INFO - javascript benchmark 12:40:36 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7349.190210677136, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3468.0982944434445, 3495.1262184453885, 3498.2653642735027, 3498.527698760668, 3507.8070706111153, 5798.6230894991795, 5896.410358964102, 5906.645601263922, 6015.759369625221, 6019.097135429688, 5877.353491115984, 5926.703664816752, 5937.88124237515, 5950.434708702677, 5980.760769569223, 3893.5911729268446, 4217.578242175789, 4233.957660423403, 4545.52272011439, 5490.560755139599, 4481.708688935225, 5504.4770746778995, 5518.889622207554, 5536.169574563827, 5554.472325129106, 4768.49930757269, 4799.544043315879, 5296.973515132399, 5304.310439642861, 5348.197770334442, 5320.574354051667, 5338.91991620126, 5347.812826551052, 5395.622306438551, 5417.891642167135, 5318.25544423781, 5333.280007199017, 5374.677519348852, 5384.273123128367, 5394.73026348681, 5774.191613174159, 5849.970750146222, 5918.911216331715, 5937.020391635375, 5941.732622032019, 5468.535174510172, 5911.113333000041, 6239.500839932794, 6248.31268560458, 6278.49772018242, 6245.937540624581, 6315.74737010519, 6322.810315690536, 6334.619922804646, 6335.3981371769605, 5907.645541267495, 5971.462568368825, 6002.429769171922, 6021.397860213943, 6085.908711369333, 6312.0, 6337.397947195009, 6349.841253968688, 6350.650714210763, 6361.522885783585, 6316.399942005502, 6336.619802811846, 6338.397852204125, 6338.714757835908, 6365.61806291624, 6259.1550140730415, 6261.96869015652, 6271.310155882849, 6289.371062893674, 6327.588706734047, 6170.568060235741, 6175.44421002103, 6251.437370636573, 6317.3366796486625, 6328.050792381087, 6241.625502469867, 6252.687365631791, 6266.342034086447, 6289.654069026156, 6296.590721603173, 5029.346184995927, 5069.645124841226, 5095.592352611782, 5109.718965456861, 5139.665921715076, 4551.0442807010895, 4552.453705555355, 4584.037352156084, 4613.838515651936, 4640.095181439587, 5896.941030589725, 5985.072313791369, 6025.066114752132, 6040.09398590215, 6040.973034584131, 5729.0, 6051.850148471776, 6257.0, 6286.277078136073, 6300.527460440485, 5940.524758019348, 6028.5478589106, 6031.0, 6048.788292409745, 6077.453029227302, 5564.10974244119, 5579.13523403873, 5585.888282234332, 5597.104463285936, 5598.58010649203, 6244.906326405198, 6296.5277604178955, 6340.239171299474, 6450.4839612830865, 6464.806055818333, 6291.528135389955, 6296.024116261987, 6316.810495685137, 6355.1420558224045, 6378.394052564999, 6439.098526206241, 6490.902636460552, 6494.6103233806125, 6503.772367967098, 6505.0, 4977.726225057511, 6223.751049957951, 6305.432511073842, 6341.682915854281, 6345.555811093179, 5226.477352264743, 6247.875042499216, 6331.556791024584, 6331.873362532816, 6364.363563643598, 6237.688115594293, 6268.968655156695, 6293.433590976834, 6298.779542715983, 6322.49420046386, 5123.820666276662, 6130.264368275835, 6142.109394137914, 6197.938020619736, 6300.558960872695, 5460.31746031746, 5987.952108381103, 6131.743695906945, 6203.96898015507, 6220.911340515301, 6260.467860231749, 6265.122882796321, 6268.435840774352, 6287.528435367274, 6292.998183280236, 5100.0, 6116.944513560587, 6141.393954534099, 6193.287771906108, 6203.751849926133], "value": 5772.481553406171, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [477.8805298675329, 527.7651445106927, 531.8829857431364, 539.9514043736064, 572.0646742575888, 39147.217055658904, 41979.580204197984, 42031.89840507977, 42074.57925420745, 42179.94550136248, 42088.0, 42615.78692106543, 42641.786791066, 42683.78658106705, 42804.35793463101, 9659.227261819038, 9779.217662586976, 9825.06661867125, 9826.968168342328, 9863.556139973682, 9717.125458708715, 9789.755256118582, 9797.0, 9801.656942007032, 9818.214542836591, 9736.172425343855, 9769.804603907918, 9772.95113524435, 9832.115109640132, 9865.309428339982, 9749.463779492125, 9775.755606109833, 9794.706158815246, 9807.509624518745, 9827.410355378628, 9731.0, 9758.414495130315, 9774.511274436321, 9811.362261453054, 9818.80362392748, 40375.7981210095, 40557.39163912544, 40868.0, 41023.7948810254, 41026.38460423096, 3046.192758918888, 3263.200515873626, 3450.24279670055, 3450.6204317525053, 3491.1621210909198, 29774.851125744448, 31021.0, 31193.22016949572, 31409.528857067162, 31564.684353156405, 3035.575019497272, 3035.894993749621, 3040.878364865425, 3048.2988912550018, 3132.859021344045, 410488.0, 432489.0, 433747.0, 437644.0, 437799.0, 28441.0, 33710.83144584261, 34084.97745067652, 34320.48519272213, 34388.14029649279, 35284.0, 35421.291574168376, 35642.465363019575, 35897.282054358766, 36139.09652258662, 15966.680666386606, 16308.83691163097, 16402.671946561, 16426.917865410596, 16435.753463698053, 12455.377231138407, 12523.185992910432, 12537.43581538833, 12538.686532836751, 12558.0, 16035.679286414206, 16106.436274730562, 19601.31395401154, 19735.506612334808, 19791.40625781229, 8175.182481751777, 8268.421210515206, 8306.0, 8308.376871734523, 8360.83278334442, 877.2937785082942, 908.7228395339353, 985.5269470654126, 1024.7557848312172, 1035.7410647338165, 30652.84673576618, 30742.231444214074, 30960.341164058882, 31074.223144421117, 31372.0, 908.3732224764891, 1017.1862509991977, 1069.4813015687384, 1180.6340034589134, 1194.199886076331, 12797.0, 13353.198808071547, 15255.618609534851, 16086.0, 16641.334346625998, 630187.0, 634744.0, 637767.0, 638684.0, 640017.0, 46541.30188047182, 46598.76700616475, 46963.5303646966, 46991.65041747899, 47130.528694712615, 1224.5469176404788, 1351.1690310459194, 1388.6042477893955, 1412.237391808412, 1420.5241244183314, 26447.206583802516, 29026.854865725538, 29845.55231671483, 30595.694043060175, 31038.844805775825, 53766.429853461326, 53962.92074158573, 54065.648358791346, 54085.459145409615, 54269.0, 578116.0, 582776.0, 582814.0, 583078.0846095912, 583345.0, 27727.44545109127, 28099.157025289274, 28102.71897281001, 28129.43741125207, 28180.0, 48717.51282487271, 49156.508434915195, 50751.0, 50905.74547127241, 51597.7420112897, 40037.39943900786, 40495.0, 41194.0, 41210.0, 41573.0, 41076.0, 41234.38148427716, 41295.0, 42338.36492452677, 42663.36004959866, 34079.659203407646, 38976.80511597424, 39179.80410098045, 39372.0, 40018.0, 26716.465670686088, 32579.18552036218, 33195.66804332023, 34982.12544686403, 35551.0, 23336.416589585395, 25822.741772582784, 26023.349416264744, 26235.52527902212, 26328.0], "value": 19409.46164071251, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [356.1790073879708, 375.4255988337843, 384.70954429405805, 389.38865980410765, 400.1816285695752, 17797.48721358686, 18675.626487470243, 19305.32431364901, 20100.597988040267, 21515.569688606218, 16823.91588042058, 20471.283505077325, 20710.48223794406, 20885.47786305343, 20998.16007359704, 5927.644341339523, 6023.488003519706, 6047.516198704115, 6085.95370200803, 6151.569390142692, 4178.122594255195, 5290.312259406272, 5809.0, 5993.940060599403, 6047.213862197908, 5553.555715542767, 6363.331850155736, 6686.063951046833, 6703.832404189886, 6865.279145689706, 5302.787888484456, 6070.6661133637635, 6128.57100003, 6751.9662401688165, 6778.694958726845, 4964.851054468371, 5901.763929442817, 5929.73316200772, 5964.850878728066, 5977.970110149465, 25303.87348063248, 25357.74642253572, 25617.847196876184, 26021.869890650425, 26294.73705262942, 2078.002558771783, 2251.0, 2465.8890349934118, 2841.1476557032806, 3010.3377257003426, 10042.849357259574, 10294.022067903537, 10314.38113713172, 10859.457027148612, 15727.44953926607, 1568.2942675795937, 1686.3676121454455, 1862.143414029548, 1883.6326916251337, 1952.453313072342, 115590.0, 116519.0, 118576.22135667971, 122950.38524807498, 123806.0, 10676.359418434919, 11543.88456115445, 11725.35510546911, 11808.76382472363, 11906.880931190577, 14729.189894555688, 14744.336504857307, 14769.0, 14782.26088695561, 14784.556463306119, 8323.0, 8529.360297977677, 8549.829003419896, 8557.786055348666, 8702.390832641655, 6934.4452443804375, 8359.164083591591, 8435.536045517556, 8451.788705282417, 8642.135786421308, 4565.543445655408, 4570.542945705402, 4580.610648094949, 4592.5407459254475, 4632.25883858581, 1595.0907982450124, 1940.8059194080479, 1955.4817973237105, 1964.0768838645813, 2016.3446879763842, 832.6544484039177, 876.9956150219335, 905.569200662951, 933.3793027636682, 967.3132076225818, 21282.467938301666, 21426.357209283433, 21716.891415543138, 21809.255259579197, 21851.672224916638, 880.0407555764248, 980.4852452462515, 988.1748739802202, 988.6243227573476, 998.9750256243652, 10980.670579882617, 11496.96527312546, 11506.88493115075, 11511.48198331077, 11589.6523104307, 595233.0, 607486.0, 609859.0, 616903.0, 618019.0, 136320.0, 141033.0, 151489.0, 153050.0, 161082.1945890263, 961.1974001708512, 1006.9949650251701, 1035.4201647077662, 1037.7561273100816, 1049.522467277387, 19165.616687666447, 19510.0, 19821.702674459608, 19869.602607947472, 19935.800641993395, 45668.77165614151, 47898.0, 54253.45746542484, 58644.70677646584, 59743.40256597378, 86006.0, 86940.0, 87672.0, 87992.56003719941, 88297.11702883146, 8148.959255203686, 8179.83640327202, 8311.750647480585, 8342.416030877781, 8494.362922780692, 11195.0, 12254.693632658898, 12328.260304381765, 12630.621081367573, 13897.0, 10243.436610986468, 11478.196526243082, 11822.586209482626, 11879.287242765462, 11975.700607484883, 10185.08334249921, 11040.447977600927, 11505.194636375374, 11563.6530904073, 11844.940775296069, 11791.469383877575, 11804.76390472203, 12089.939550302191, 12092.93953530262, 12105.939470302592, 8200.958995204986, 8280.83438331242, 8286.627101780314, 8385.329173666214, 8462.915370846213, 7546.094468663796, 8788.340874434316, 11452.770944581229, 11560.728319884975, 11726.296422214695], "value": 9785.841266238935, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1526.458107371883, 1569.2232344989231, 1666.8582021315408, 1779.2616064333301, 1890.13998630623, 7878.566678832662, 8127.756167314983, 8291.46105503142, 8863.867041994376, 8898.332625053123, 8294.419390642657, 8492.872606910885, 8603.268722158607, 8620.482771033743, 8628.525431101287, 2066.6486697261503, 2118.1315660579166, 2121.1303365620097, 2131.7761635028332, 2136.594047131048, 1960.0, 2313.144136669435, 2314.2478694424294, 2369.5142495788323, 2378.0368950574957, 2341.0, 2349.9412514687097, 2354.811615070799, 2359.079958816063, 2368.111958015744, 2296.253717541789, 2296.655501674754, 2306.988465057681, 2307.157887371106, 2320.9303720888315, 2354.2584086012853, 2356.4697942962866, 2357.9410514737096, 2360.44529535559, 2362.4802543440414, 8727.170918762708, 8744.300455963508, 8757.0, 8758.430702004349, 8782.209601135928, 5151.150060240056, 5250.921236181461, 5305.708186049766, 5307.044731948247, 5317.46825317469, 2843.3744576193203, 3045.9390812183856, 3403.268297316089, 3413.7781044232047, 3593.7484376093685, 1038.039813172812, 1046.8796088449774, 1050.6056607704463, 1052.8315469524916, 1074.6614816332908, 11392.487338069806, 11484.081273498183, 11588.01501872342, 11611.361375124365, 11626.1861669684, 4496.168208881302, 4634.467036290802, 4834.492378300298, 4867.269909513601, 4871.14754917888, 9978.550965206583, 9994.750131246778, 10000.0999910007, 10004.199244136125, 10028.147607453302, 5311.946880531145, 5318.734063296897, 5328.307320048369, 5339.759710813023, 5347.224652425377, 4038.7778672173313, 4278.657707383401, 4559.726416415026, 4691.601213896857, 4729.84118890867, 3889.669378102893, 3923.843046278117, 3996.5603783583783, 4010.358342665218, 4040.252553277653, 1267.9366031698378, 1295.9611211663664, 1297.8377702787152, 1306.8627794081674, 1312.068431413688, 868.8957325121025, 921.161742814036, 949.6486300069018, 974.444566597047, 978.2907392140642, 5781.479666830005, 5900.126352798941, 5983.521318294526, 6086.439333862085, 6165.753369865245, 440.3087153169493, 442.52207615774887, 448.4372112998166, 453.7005576319613, 1005.3910103281971, 3997.2205419942834, 4001.4691576167697, 4078.7348822326453, 4101.589841015934, 4120.17596480705, 10249.9487502562, 10650.893491065146, 10656.200784941006, 10662.253642244968, 10715.624953126604, 10527.157827373792, 10589.099926506333, 10594.735131621772, 10617.256792024484, 10630.25588208818, 7732.342750866127, 7820.413468989848, 7919.445638805229, 8055.234752698484, 8096.149904260085, 5757.971210143923, 5802.622829516068, 5971.820845374646, 5995.940040599713, 6050.971334872994, 9638.228941684789, 9932.404055756677, 9956.800863982824, 10116.84824727615, 10135.7466063349, 9611.711648650551, 9891.752706182404, 10066.245031622511, 10124.34191777532, 10244.334118282586, 6871.725130994704, 7174.246704095995, 7242.637868106468, 7370.5946172961, 7424.109106907205, 8121.959390203011, 8342.791430214293, 8350.665973361241, 8377.70678026266, 8385.454945428528, 7388.371988381048, 7503.587302698404, 7511.887321690288, 7586.468947173645, 7639.159692433716, 7248.238934911969, 7274.599897005715, 7364.0, 7430.888536672062, 7436.0, 6888.827779305558, 6892.207396149507, 6949.895751563832, 6963.477739169683, 6975.162980442379, 4805.3512775774825, 4905.313256144214, 4927.961778684564, 5072.771725272298, 5133.230015497706, 4173.770442625685, 4261.446012018418, 4525.818967241274, 5010.098182327216, 5152.407473140637], "value": 4479.280883404309, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [255.42401883752137, 262.9592413175958, 303.5689321163947, 311.5389223948558, 312.43917168682214, 4950.801967921278, 5497.175423686439, 5559.527440167585, 5709.857253568663, 5735.713214339282, 4870.561649451549, 5088.829569199077, 5248.950209958014, 5422.647527910693, 5713.942860571393, 3417.367786959408, 4217.43064686268, 4321.481422229321, 4364.170807546564, 4368.039031413084, 3734.514513113305, 3932.9803350983207, 4210.136921930997, 4238.749568877173, 4364.88695382677, 3611.9277614447697, 3896.7919944817054, 4216.241076606209, 4225.6830737694645, 4238.8766976751185, 3299.7790817397595, 3697.8335974881193, 3841.7898362016153, 4202.2646036943415, 4249.830006799724, 2844.815087019337, 3599.226166374216, 3627.5102861113673, 3631.800250986195, 3635.4546817977252, 4754.809807607691, 5494.2857428534435, 5534.0315444797, 5554.389017208104, 5561.388247292794, 4006.399040144002, 4249.897574770435, 4844.588210002119, 4853.660243782937, 4859.757012149378, 5548.4174161712845, 5557.777688892439, 5687.7156142192725, 5979.19280897082, 5981.0, 3357.9664203358143, 3614.8554057837655, 3634.436662317345, 3971.900702482461, 3990.68074554035, 6184.628922264678, 6205.410486003822, 6263.78076767311, 6293.514061945598, 6299.181126438279, 3512.051746028558, 3861.4940173332425, 3913.5303763548554, 3999.64003239704, 4051.4125451809323, 3567.554055743032, 4047.5226542311843, 4069.5320038195987, 4077.4699289092823, 4094.201630682048, 4379.693421460467, 4407.294832826797, 4414.426124603845, 4825.348577942003, 4855.44162421319, 4870.712269218264, 5230.895382092337, 5674.773009079673, 6030.216071910623, 6100.444386681368, 1162.4187906046977, 1307.5750381125981, 1341.745068436994, 1386.9445222191, 1392.9065683438453, 832.6669332267021, 851.7947104846572, 908.9909100909039, 916.1113719691888, 933.5809569454391, 5490.588205884575, 5513.228148059275, 5513.58648101394, 5525.143602741581, 5553.416891226363, 5325.3609566851455, 6075.513958883279, 6092.817215483543, 6145.631262124287, 6167.581456265084, 4818.6626936114835, 4832.323474713543, 5175.054596480127, 5250.816221432308, 5509.3664228613425, 2352.7647235276336, 2401.4836810085917, 2484.0, 2558.3348329434107, 2643.8810253538636, 4379.846705365297, 4738.668293219442, 4930.457649658535, 5253.868653283698, 5362.410134885159, 5191.299174611455, 5285.788568457218, 5307.363116426053, 5816.360200377955, 6371.630099528624, 5446.786396026363, 5553.083741182741, 6025.457708806316, 6385.361463853577, 6446.903296450463, 5444.891102178013, 5792.710364481674, 6180.721867515883, 6282.963311053625, 6313.042956683443, 5167.741612919263, 5559.33288005442, 6068.787592434243, 6098.756049758137, 6166.290876549254, 5794.565407594363, 5920.934231838138, 6321.431071203614, 6354.491640668828, 6455.741770329134, 3453.8791142309897, 3753.6434038767366, 4036.5156181258435, 4073.6537394321813, 4085.8774236772942, 5254.65844720092, 5694.804091140742, 5924.526037917042, 6150.507959363151, 6222.719977600928, 4980.352554167935, 5982.248165843761, 6019.4883434908525, 6040.577159598786, 6046.486048685911, 6044.304904935989, 6056.636601803906, 6072.969635151972, 6094.299155597163, 6102.511799056154, 5016.849494515171, 5485.5589262777685, 5563.942850858324, 5627.43725627434, 5939.227900372924, 4973.104841128632, 5706.6005379624685, 6108.541859360477, 6117.694115294306, 6144.692765361625, 5046.798128074836, 5173.3533308336455, 5561.833145005657, 5901.91147132802, 5961.0], "value": 4187.109054311235, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [648.5913874259217, 704.936555709986, 796.2634563029197, 797.7845981584976, 855.3841234311295, 15235.771463428044, 15604.141772202523, 15864.127472988981, 15897.761533576977, 15940.92029539852, 13765.518206862762, 14168.716625667481, 14302.57092287233, 14317.642058948531, 14368.20974846383, 808.3250485844327, 828.8590939540293, 860.1785295043235, 885.5350940756123, 885.9468431894107, 685.4447897203281, 774.8643987302228, 824.8391563645091, 849.5454931611589, 860.9698660546882, 921.5208091792264, 924.2005665099707, 926.9212116970066, 930.9022552631977, 931.2968708624978, 893.4683863101444, 922.9584668689926, 924.8936372317169, 925.1165137293935, 925.1765928323797, 563.7857614106613, 682.0042737603105, 686.5571706249441, 686.7493364921768, 688.9311068893121, 14319.355628996616, 14458.783118253235, 14516.637084072878, 14789.0, 14846.554603361916, 14469.131852088909, 14776.704465910621, 14822.40710371584, 14831.70336593262, 14954.700905981928, 9779.315447918649, 10550.0, 11669.416529173592, 11940.880591194064, 11975.700607484796, 3848.9230215395814, 3857.0743021674875, 3880.6701430378453, 3886.261610294035, 3920.862769803043, 116380.0, 117189.0, 117801.0, 118787.0, 120208.0, 11215.943920280346, 11221.831672524919, 11464.312141271384, 11523.884761152449, 11782.234154779911, 19672.90163549173, 23506.0, 23814.880925595262, 23882.641760373608, 23900.163494277618, 7481.289277518627, 8117.391195660349, 8268.917310826935, 8291.668333266602, 8486.915130848736, 4470.731756094645, 4569.588737013684, 4577.22187228172, 4580.7938642761155, 4582.564656357641, 3014.125903487964, 3391.9152021199175, 3510.543629328222, 3551.698105661048, 3569.39320315547, 616.8341833933869, 673.1215763428675, 673.4174938678008, 677.9325040884107, 742.9591372474566, 605.5700452678559, 668.4385116502161, 686.5503095472474, 689.8137502874196, 694.5207806613421, 9394.483303418241, 9738.123568878835, 9838.376667849867, 9917.057879501435, 9959.502024898726, 570.6775671745534, 633.1515768869737, 633.3160186998031, 656.3633275722541, 663.4592806862488, 4528.184926713157, 4799.424069111659, 4801.159797035505, 4814.665291047953, 4957.157283261854, 101119.0, 125510.74489255174, 140830.88753668702, 151621.0, 166284.16857915875, 32588.93457720561, 138527.84416467522, 139866.0, 140313.0, 141867.0, 73999.0, 85575.572122139, 107862.3820642691, 113361.0, 116873.0, 9046.321525885453, 9172.35793494449, 9278.675246366345, 9291.888215347886, 9450.669226577036, 40222.79888600538, 44684.55315446934, 49686.00627987492, 50196.74901625468, 51856.0, 47105.0, 94958.0, 100684.49657751665, 101292.0, 102002.48998754959, 11862.881371186522, 11955.625103112905, 12073.637790866289, 12323.630291091282, 12493.625191244277, 11085.612003579836, 13364.866351336752, 13542.932285338511, 13871.4451421942, 13945.093568917988, 12199.207051541622, 12460.190087644274, 12501.93749031249, 12594.496220151092, 12955.481780728665, 12410.910668774663, 12600.810987835006, 12748.235105893305, 12867.549635762703, 13140.408681609159, 11932.940335298268, 12249.571265005681, 12336.62990110298, 12764.0, 12779.680507987374, 10156.986962436362, 10272.794544108927, 10276.640317588848, 10450.0, 10689.732756681145, 9222.139488706875, 9433.716988490356, 10637.215795771963, 10918.781624367628, 10955.397453140155], "value": 7661.174754335238, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1571.5, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 118.0, 108.0, 117.0, 116.0, 117.0, 114.0, 118.0, 116.0, 118.0], "value": 114.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 112.0, 124.0, 187.0, 142.0, 135.0, 142.0, 134.0, 159.0, 109.0], "value": 138.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [261.0, 266.0, 237.0, 199.0, 195.0, 195.0, 196.0, 203.0, 192.0, 195.0], "value": 213.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 84.0, 75.0, 143.0, 69.0, 81.0, 82.0, 63.0, 136.0, 60.0], "value": 86.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 72.0, 116.0, 73.0, 71.0, 86.0, 111.0, 69.0, 71.0, 127.0], "value": 86.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 93.0, 133.0, 88.0, 91.0, 87.0, 92.0, 90.0, 90.0, 88.0], "value": 94.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 97.0, 121.0, 97.0, 96.0, 136.0, 109.0, 98.0, 96.0, 102.0], "value": 104.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 96.0, 96.0, 93.0, 90.0, 90.0, 99.0, 93.0, 124.0, 87.0], "value": 95.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 58.0, 56.0, 56.0, 87.0, 88.0, 50.0, 54.0, 57.0, 86.0], "value": 65.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 72.0, 89.0, 67.0, 78.0, 90.0, 108.0, 105.0, 87.0, 71.0], "value": 83.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 85.0, 93.0, 84.0, 85.0, 83.0, 85.0, 85.0, 88.0, 84.0], "value": 86.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 157.0, 147.0, 140.0, 139.0, 138.0, 140.0, 158.0, 140.0, 154.0], "value": 146.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 171.0, 167.0, 168.0, 171.0, 166.0, 175.0, 173.0, 224.0, 166.0], "value": 174.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 90.0, 89.0, 88.0, 74.0, 68.0, 67.0, 79.0, 84.0, 88.0], "value": 80.7, "unit": "score"}]}]} 12:40:36 INFO - Return code: 0 12:40:36 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 12:40:36 ERROR - # TBPL SUCCESS # 12:40:36 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 12:40:36 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 12:40:36 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 12:40:36 INFO - 2016-08-07 12:40:36.478 screenresolution[1680:12754] starting screenresolution argv=screenresolution get 12:40:36 INFO - 2016-08-07 12:40:36.481 screenresolution[1680:12754] Display 0: 1600x1200x32@60 12:40:36 INFO - 2016-08-07 12:40:36.487 screenresolution[1681:12757] starting screenresolution argv=screenresolution list 12:40:36 INFO - Available Modes on Display 0 12:40:36 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 12:40:36 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 12:40:36 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 12:40:36 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 12:40:36 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 12:40:36 INFO - Intel Iris: 12:40:36 INFO - Chipset Model: Intel Iris 12:40:36 INFO - Type: GPU 12:40:36 INFO - Bus: Built-In 12:40:36 INFO - VRAM (Dynamic, Max): 1536 MB 12:40:36 INFO - Vendor: Intel (0x8086) 12:40:36 INFO - Device ID: 0x0a2e 12:40:36 INFO - Revision ID: 0x0009 12:40:36 INFO - Displays: 12:40:36 INFO - Display: 12:40:36 INFO - Resolution: 1600 x 1200 @ 60 Hz 12:40:36 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 12:40:36 INFO - Display Serial Number: 1600x1200 60 12:40:36 INFO - Main Display: Yes 12:40:36 INFO - Mirror: Off 12:40:36 INFO - Online: Yes 12:40:36 INFO - Rotation: Supported 12:40:36 INFO - Return code: 0 12:40:36 INFO - Running post-action listener: _resource_record_post_action 12:40:36 INFO - [mozharness: 2016-08-07 19:40:36.728087Z] Finished run-tests step (success) 12:40:36 INFO - Running post-run listener: _resource_record_post_run 12:40:36 INFO - Total resource usage - Wall time: 1211s; CPU: 54.0%; Read bytes: 31734784; Write bytes: 708342272; Read time: 191; Write time: 2053 12:40:36 INFO - TinderboxPrint: CPU usage
54.1% 12:40:36 INFO - TinderboxPrint: I/O read bytes / time
31,734,784 / 191 12:40:36 INFO - TinderboxPrint: I/O write bytes / time
708,342,272 / 2,053 12:40:36 INFO - TinderboxPrint: CPU idle
2,222.3 (45.9%) 12:40:36 INFO - TinderboxPrint: CPU system
977.1 (20.2%) 12:40:36 INFO - TinderboxPrint: CPU user
1,646.2 (34.0%) 12:40:36 INFO - TinderboxPrint: Swap in / out
434,470,912 / 0 12:40:36 INFO - install - Wall time: 35s; CPU: 54.0%; Read bytes: 385808896; Write bytes: 381698048; Read time: 29292; Write time: 856 12:40:36 INFO - run-tests - Wall time: 1177s; CPU: 54.0%; Read bytes: 30813184; Write bytes: 297079296; Read time: 180; Write time: 1127 12:40:37 INFO - Running post-run listener: _upload_blobber_files 12:40:37 INFO - Blob upload gear active. 12:40:37 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:40:37 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 12:40:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 12:40:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 12:40:37 INFO - (blobuploader) - INFO - Open directory for files ... 12:40:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 12:40:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:40:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:40:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 12:40:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:40:38 INFO - (blobuploader) - INFO - Done attempting. 12:40:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 12:40:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:40:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:40:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 12:40:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:40:39 INFO - (blobuploader) - INFO - Done attempting. 12:40:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 12:40:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:40:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:40:41 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 12:40:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:40:41 INFO - (blobuploader) - INFO - Done attempting. 12:40:41 INFO - (blobuploader) - INFO - Iteration through files over. 12:40:41 INFO - Return code: 0 12:40:41 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:40:41 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:40:41 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8e6ac482394a52e97742c9fd12d7dd224eaf72e0cacb002a9699f2117fa1df244342f0b2a643da05a3504f8da1d9eb762510ff4f4e634568107a2a6b9283d018", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e99257e1961b0f0cc26caa517466ab14e890910e4b8e169dbea9494fb8009b088d9056ba0071707b99782c37e89f0a2d3fc862f084cbb28f26abdc2ab0a8085c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e1e1ac75c0eb3c68de1daa8201229eb46d0e596d46215f9e31d1cc6c78ffeef48c7a8e29e216b854c9fe98bb0dd607e6d91c8a77318473773c90747b738b3160"} 12:40:41 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:40:41 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:40:41 INFO - Contents: 12:40:41 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8e6ac482394a52e97742c9fd12d7dd224eaf72e0cacb002a9699f2117fa1df244342f0b2a643da05a3504f8da1d9eb762510ff4f4e634568107a2a6b9283d018", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e99257e1961b0f0cc26caa517466ab14e890910e4b8e169dbea9494fb8009b088d9056ba0071707b99782c37e89f0a2d3fc862f084cbb28f26abdc2ab0a8085c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e1e1ac75c0eb3c68de1daa8201229eb46d0e596d46215f9e31d1cc6c78ffeef48c7a8e29e216b854c9fe98bb0dd607e6d91c8a77318473773c90747b738b3160"} 12:40:41 INFO - Running post-run listener: copy_logs_to_upload_dir 12:40:41 INFO - Copying logs to upload dir... 12:40:41 INFO - mkdir: /builds/slave/test/build/upload/logs 12:40:41 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1265.178979 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2016-08-07 12:40:41.480319) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-07 12:40:41.484494) ========= 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.47pNUyM3s0/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.xAGJnQLTNj/Listeners TMPDIR=/var/folders/2r/mjh615_91fs88xk2w8x_w5l800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8e6ac482394a52e97742c9fd12d7dd224eaf72e0cacb002a9699f2117fa1df244342f0b2a643da05a3504f8da1d9eb762510ff4f4e634568107a2a6b9283d018", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e99257e1961b0f0cc26caa517466ab14e890910e4b8e169dbea9494fb8009b088d9056ba0071707b99782c37e89f0a2d3fc862f084cbb28f26abdc2ab0a8085c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e1e1ac75c0eb3c68de1daa8201229eb46d0e596d46215f9e31d1cc6c78ffeef48c7a8e29e216b854c9fe98bb0dd607e6d91c8a77318473773c90747b738b3160"} build_url:https://queue.taskcluster.net/v1/task/fw2zS7k7TJuXZHy7J6H4Xw/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010867 build_url: 'https://queue.taskcluster.net/v1/task/fw2zS7k7TJuXZHy7J6H4Xw/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8e6ac482394a52e97742c9fd12d7dd224eaf72e0cacb002a9699f2117fa1df244342f0b2a643da05a3504f8da1d9eb762510ff4f4e634568107a2a6b9283d018", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e99257e1961b0f0cc26caa517466ab14e890910e4b8e169dbea9494fb8009b088d9056ba0071707b99782c37e89f0a2d3fc862f084cbb28f26abdc2ab0a8085c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e1e1ac75c0eb3c68de1daa8201229eb46d0e596d46215f9e31d1cc6c78ffeef48c7a8e29e216b854c9fe98bb0dd607e6d91c8a77318473773c90747b738b3160"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-07 12:40:41.518759) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-07 12:40:41.519219) ========= 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.47pNUyM3s0/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.xAGJnQLTNj/Listeners TMPDIR=/var/folders/2r/mjh615_91fs88xk2w8x_w5l800000w/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.005189 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-07 12:40:41.568909) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-07 12:40:41.569222) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-07 12:40:41.569596) ========= ========= Total master_lag: 0.19 =========