builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0052 starttime: 1470814884.16 results: success (0) buildid: 20160809224115 builduid: dd3e6a1f26b54a0d898f40d384e76a14 revision: 3269dd1a824d1b42cb021d1fb6858885179940b0 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-10 00:41:24.160089) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-10 00:41:24.160564) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-10 00:41:24.160866) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-10 00:41:24.186580) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-10 00:41:24.186978) ========= 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.98Q0OeKug0/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.ggLe7WHkAi/Listeners TMPDIR=/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-08-10 00:41:24-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 13.4M=0.001s 2016-08-10 00:41:24 (13.4 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.140543 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-10 00:41:24.350181) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-10 00:41:24.350503) ========= 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.98Q0OeKug0/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.ggLe7WHkAi/Listeners TMPDIR=/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/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.028550 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-10 00:41:24.399667) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-08-10 00:41:24.400024) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 3269dd1a824d1b42cb021d1fb6858885179940b0 --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 3269dd1a824d1b42cb021d1fb6858885179940b0 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.98Q0OeKug0/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.ggLe7WHkAi/Listeners TMPDIR=/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-08-10 00:41:24,473 truncating revision to first 12 chars 2016-08-10 00:41:24,473 Setting DEBUG logging. 2016-08-10 00:41:24,474 attempt 1/10 2016-08-10 00:41:24,474 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/3269dd1a824d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-10 00:41:26,027 unpacking tar archive at: fx-team-3269dd1a824d/testing/mozharness/ program finished with exit code 0 elapsedTime=1.802639 ========= master_lag: 0.51 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-08-10 00:41:26.716622) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-10 00:41:26.716992) ========= script_repo_revision: 3269dd1a824d1b42cb021d1fb6858885179940b0 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-10 00:41:26.717427) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-10 00:41:26.717743) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-10 00:41:26.736751) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2016-08-10 00:41:26.737157) ========= /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.98Q0OeKug0/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.ggLe7WHkAi/Listeners TMPDIR=/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/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 00:41:26 INFO - MultiFileLogger online at 20160810 00:41:26 in /builds/slave/test 00:41:26 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 00:41:26 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 00:41:26 INFO - {'append_to_log': False, 00:41:26 INFO - 'base_work_dir': '/builds/slave/test', 00:41:26 INFO - 'blob_upload_branch': 'Fx-Team', 00:41:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 00:41:26 INFO - 'branch': 'Fx-Team', 00:41:26 INFO - 'buildbot_json_path': 'buildprops.json', 00:41:26 INFO - 'config_files': ('talos/mac_config.py',), 00:41:26 INFO - 'default_actions': ('clobber', 00:41:26 INFO - 'read-buildbot-config', 00:41:26 INFO - 'download-and-extract', 00:41:26 INFO - 'populate-webroot', 00:41:26 INFO - 'create-virtualenv', 00:41:26 INFO - 'install', 00:41:26 INFO - 'run-tests'), 00:41:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 00:41:26 INFO - 'download_minidump_stackwalk': True, 00:41:26 INFO - 'download_symbols': 'ondemand', 00:41:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 00:41:26 INFO - 'tooltool.py': '/tools/tooltool.py', 00:41:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 00:41:26 INFO - '/tools/misc-python/virtualenv.py')}, 00:41:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 00:41:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 00:41:26 INFO - 'installer_path': 'installer.exe', 00:41:26 INFO - 'log_level': 'info', 00:41:26 INFO - 'log_name': 'talos', 00:41:26 INFO - 'log_to_console': True, 00:41:26 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 00:41:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 00:41:26 INFO - 'opt_config_files': (), 00:41:26 INFO - 'pip_index': False, 00:41:26 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 00:41:26 INFO - 'cmd': ('bash', 00:41:26 INFO - '-c', 00:41:26 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 00:41:26 INFO - 'enabled': True, 00:41:26 INFO - 'halt_on_failure': False, 00:41:26 INFO - 'name': 'check_screen_resolution'},), 00:41:26 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 00:41:26 INFO - 'cmd': ('bash', 00:41:26 INFO - '-c', 00:41:26 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 00:41:26 INFO - 'enabled': True, 00:41:26 INFO - 'halt_on_failure': False, 00:41:26 INFO - 'name': 'check_screen_resolution'},), 00:41:26 INFO - 'run_cmd_checks_enabled': True, 00:41:26 INFO - 'sps_profile': False, 00:41:26 INFO - 'sps_profile_interval': 0, 00:41:26 INFO - 'suite': 'dromaeojs-e10s', 00:41:26 INFO - 'system_bits': '32', 00:41:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 00:41:26 INFO - 'title': 't-yosemite-r7-0052', 00:41:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 00:41:26 INFO - 'use_talos_json': True, 00:41:26 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 00:41:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 00:41:26 INFO - 'work_dir': 'build'} 00:41:26 INFO - [mozharness: 2016-08-10 07:41:26.928495Z] Running clobber step. 00:41:26 INFO - Running pre-action listener: _resource_record_pre_action 00:41:26 INFO - Running main action method: clobber 00:41:26 INFO - rmtree: /builds/slave/test/build 00:41:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 00:41:29 INFO - Running post-action listener: _resource_record_post_action 00:41:29 INFO - [mozharness: 2016-08-10 07:41:29.126181Z] Finished clobber step (success) 00:41:29 INFO - [mozharness: 2016-08-10 07:41:29.126349Z] Running read-buildbot-config step. 00:41:29 INFO - Running pre-action listener: _resource_record_pre_action 00:41:29 INFO - Running main action method: read_buildbot_config 00:41:29 INFO - Using buildbot properties: 00:41:29 INFO - { 00:41:29 INFO - "project": "", 00:41:29 INFO - "product": "firefox", 00:41:29 INFO - "script_repo_revision": "production", 00:41:29 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 00:41:29 INFO - "repository": "", 00:41:29 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 00:41:29 INFO - "buildid": "20160809224115", 00:41:29 INFO - "pgo_build": "False", 00:41:29 INFO - "basedir": "/builds/slave/test", 00:41:29 INFO - "buildnumber": 5, 00:41:29 INFO - "slavename": "t-yosemite-r7-0052", 00:41:29 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 00:41:29 INFO - "platform": "yosemite_r7", 00:41:29 INFO - "scheduler": "tests-fx-team-macosx64-talos-7-3600", 00:41:29 INFO - "branch": "fx-team", 00:41:29 INFO - "repo_path": "integration/fx-team", 00:41:29 INFO - "revision": "3269dd1a824d1b42cb021d1fb6858885179940b0", 00:41:29 INFO - "stage_platform": "macosx64", 00:41:29 INFO - "builduid": "dd3e6a1f26b54a0d898f40d384e76a14", 00:41:29 INFO - "slavebuilddir": "test" 00:41:29 INFO - } 00:41:29 INFO - Found installer url https://queue.taskcluster.net/v1/task/BFTouO-CRQG2-L1bIZXezQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg. 00:41:29 INFO - Running post-action listener: _resource_record_post_action 00:41:29 INFO - [mozharness: 2016-08-10 07:41:29.129750Z] Finished read-buildbot-config step (success) 00:41:29 INFO - [mozharness: 2016-08-10 07:41:29.129832Z] Running download-and-extract step. 00:41:29 INFO - Running pre-action listener: _resource_record_pre_action 00:41:29 INFO - Running main action method: download_and_extract 00:41:29 INFO - mkdir: /builds/slave/test/build/tests 00:41:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:41:29 INFO - trying https://queue.taskcluster.net/v1/task/BFTouO-CRQG2-L1bIZXezQ/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json 00:41:29 INFO - Downloading https://queue.taskcluster.net/v1/task/BFTouO-CRQG2-L1bIZXezQ/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 00:41:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/BFTouO-CRQG2-L1bIZXezQ/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 00:41:30 INFO - Downloaded 1199 bytes. 00:41:30 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 00:41:30 INFO - Using the following test package requirements: 00:41:30 INFO - {u'common': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 00:41:30 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 00:41:30 INFO - u'firefox-51.0a1.en-US.mac.cppunittest.tests.zip'], 00:41:30 INFO - u'gtest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 00:41:30 INFO - u'firefox-51.0a1.en-US.mac.gtest.tests.zip'], 00:41:30 INFO - u'jittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 00:41:30 INFO - u'jsshell-mac.zip'], 00:41:30 INFO - u'mochitest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 00:41:30 INFO - u'firefox-51.0a1.en-US.mac.mochitest.tests.zip'], 00:41:30 INFO - u'mozbase': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 00:41:30 INFO - u'reftest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 00:41:30 INFO - u'firefox-51.0a1.en-US.mac.reftest.tests.zip'], 00:41:30 INFO - u'talos': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 00:41:30 INFO - u'firefox-51.0a1.en-US.mac.talos.tests.zip'], 00:41:30 INFO - u'web-platform': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 00:41:30 INFO - u'firefox-51.0a1.en-US.mac.web-platform.tests.zip'], 00:41:30 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 00:41:30 INFO - u'firefox-51.0a1.en-US.mac.xpcshell.tests.zip']} 00:41:30 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip'] for test suite category: common 00:41:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:41:30 INFO - trying https://queue.taskcluster.net/v1/task/BFTouO-CRQG2-L1bIZXezQ/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 00:41:30 INFO - Downloading https://queue.taskcluster.net/v1/task/BFTouO-CRQG2-L1bIZXezQ/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 00:41:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/BFTouO-CRQG2-L1bIZXezQ/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 00:41:31 INFO - Downloaded 16325982 bytes. 00:41:31 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'] 00:41:31 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 00:41:34 INFO - Return code: 0 00:41:34 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 00:41:34 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')]} 00:41:34 INFO - trying https://queue.taskcluster.net/v1/task/BFTouO-CRQG2-L1bIZXezQ/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 00:41:34 INFO - Downloading https://queue.taskcluster.net/v1/task/BFTouO-CRQG2-L1bIZXezQ/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 00:41:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/BFTouO-CRQG2-L1bIZXezQ/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 00:41:35 INFO - Downloaded 16325982 bytes. 00:41:35 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'] 00:41:35 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 00:41:38 INFO - Return code: 0 00:41: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')]} 00:41:38 INFO - trying https://queue.taskcluster.net/v1/task/BFTouO-CRQG2-L1bIZXezQ/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip 00:41:38 INFO - Downloading https://queue.taskcluster.net/v1/task/BFTouO-CRQG2-L1bIZXezQ/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 00:41:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/BFTouO-CRQG2-L1bIZXezQ/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 00:41:39 INFO - Downloaded 14413723 bytes. 00:41:39 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'] 00:41:39 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 00:41:40 INFO - Return code: 0 00:41:40 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')]} 00:41:40 INFO - trying https://queue.taskcluster.net/v1/task/BFTouO-CRQG2-L1bIZXezQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 00:41:40 INFO - Downloading https://queue.taskcluster.net/v1/task/BFTouO-CRQG2-L1bIZXezQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg 00:41:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/BFTouO-CRQG2-L1bIZXezQ/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 00:41:42 INFO - Downloaded 110876544 bytes. 00:41:42 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/BFTouO-CRQG2-L1bIZXezQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 00:41:42 INFO - mkdir: /builds/slave/test/properties 00:41:42 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 00:41:42 INFO - Writing to file /builds/slave/test/properties/build_url 00:41:42 INFO - Contents: 00:41:42 INFO - build_url:https://queue.taskcluster.net/v1/task/BFTouO-CRQG2-L1bIZXezQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 00:41:43 INFO - Running post-action listener: _resource_record_post_action 00:41:43 INFO - Running post-action listener: set_extra_try_arguments 00:41:43 INFO - [mozharness: 2016-08-10 07:41:43.609069Z] Finished download-and-extract step (success) 00:41:43 INFO - [mozharness: 2016-08-10 07:41:43.609245Z] Running populate-webroot step. 00:41:43 INFO - Running pre-action listener: _resource_record_pre_action 00:41:43 INFO - Running main action method: populate_webroot 00:41:43 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 00:41:43 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 00:41:43 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 00:41:43 INFO - '--tppagecycles', 00:41:43 INFO - '7'], 00:41:43 INFO - 'tests': ['tsvgm']}}, 00:41:43 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 00:41:43 INFO - 'tests': ['tresize', 'tcanvasmark']}, 00:41:43 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 00:41:43 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 00:41:43 INFO - 'tests': ['dromaeo_css', 'kraken']}, 00:41:43 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 00:41:43 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:41:43 INFO - 'talos_options': ['--disable-e10s'], 00:41:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:41:43 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:41:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:41:43 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:41:43 INFO - 'talos_options': ['--disable-e10s'], 00:41:43 INFO - 'tests': ['damp', 'tps']}, 00:41:43 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:41:43 INFO - 'tests': ['damp', 'tps']}, 00:41:43 INFO - 'g3': {'talos_options': ['--disable-e10s'], 00:41:43 INFO - 'tests': ['dromaeo_dom']}, 00:41:43 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 00:41:43 INFO - 'g4': {'talos_options': ['--disable-e10s'], 00:41:43 INFO - 'tests': ['basic_compositor_video']}, 00:41:43 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 00:41:43 INFO - 'other': {'talos_options': ['--disable-e10s'], 00:41:43 INFO - 'tests': ['a11yr', 00:41:43 INFO - 'ts_paint', 00:41:43 INFO - 'tpaint', 00:41:43 INFO - 'sessionrestore', 00:41:43 INFO - 'sessionrestore_no_auto_restore', 00:41:43 INFO - 'tabpaint']}, 00:41:43 INFO - 'other-e10s': {'tests': ['a11yr', 00:41:43 INFO - 'ts_paint', 00:41:43 INFO - 'tpaint', 00:41:43 INFO - 'sessionrestore', 00:41:43 INFO - 'sessionrestore_no_auto_restore', 00:41:43 INFO - 'tabpaint']}, 00:41:43 INFO - 'other-e10s_l64': {'tests': ['a11yr', 00:41:43 INFO - 'ts_paint', 00:41:43 INFO - 'tpaint', 00:41:43 INFO - 'sessionrestore', 00:41:43 INFO - 'sessionrestore_no_auto_restore', 00:41:43 INFO - 'tabpaint']}, 00:41:43 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 00:41:43 INFO - 'ts_paint', 00:41:43 INFO - 'tpaint', 00:41:43 INFO - 'sessionrestore', 00:41:43 INFO - 'sessionrestore_no_auto_restore', 00:41:43 INFO - 'tabpaint']}, 00:41:43 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 00:41:43 INFO - 'tests': ['a11yr', 00:41:43 INFO - 'ts_paint', 00:41:43 INFO - 'tpaint', 00:41:43 INFO - 'sessionrestore', 00:41:43 INFO - 'sessionrestore_no_auto_restore', 00:41:43 INFO - 'tabpaint']}, 00:41:43 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 00:41:43 INFO - 'tests': ['a11yr', 00:41:43 INFO - 'ts_paint', 00:41:43 INFO - 'tpaint', 00:41:43 INFO - 'sessionrestore', 00:41:43 INFO - 'sessionrestore_no_auto_restore', 00:41:43 INFO - 'tabpaint']}, 00:41:43 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 00:41:43 INFO - 'tests': ['tsvgx', 00:41:43 INFO - 'tsvgr_opacity', 00:41:43 INFO - 'tart', 00:41:43 INFO - 'tscrollx', 00:41:43 INFO - 'cart']}, 00:41:43 INFO - 'svgr-e10s': {'tests': ['tsvgx', 00:41:43 INFO - 'tsvgr_opacity', 00:41:43 INFO - 'tart', 00:41:43 INFO - 'tscrollx', 00:41:43 INFO - 'cart']}, 00:41:43 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:41:43 INFO - 'talos_options': ['--disable-e10s'], 00:41:43 INFO - 'tests': ['tp5o']}, 00:41:43 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:41:43 INFO - 'tests': ['tp5o']}, 00:41:43 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:41:43 INFO - 'talos_options': ['--disable-e10s', 00:41:43 INFO - '--xperf_path', 00:41:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:41:43 INFO - 'tests': ['tp5n']}, 00:41:43 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:41:43 INFO - 'talos_options': ['--xperf_path', 00:41:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:41:43 INFO - 'tests': ['tp5n']}}, 00:41:43 INFO - 'talos.zip': {'path': '', 00:41:43 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 00:41:43 INFO - Running post-action listener: _resource_record_post_action 00:41:43 INFO - [mozharness: 2016-08-10 07:41:43.628665Z] Finished populate-webroot step (success) 00:41:43 INFO - [mozharness: 2016-08-10 07:41:43.628804Z] Running create-virtualenv step. 00:41:43 INFO - Running pre-action listener: _resource_record_pre_action 00:41:43 INFO - Running main action method: create_virtualenv 00:41:43 INFO - Creating virtualenv /builds/slave/test/build/venv 00:41:43 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 00:41:43 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 00:41:43 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 00:41:43 INFO - Using real prefix '/tools/python27' 00:41:43 INFO - New python executable in /builds/slave/test/build/venv/bin/python 00:41:44 INFO - Installing distribute.............................................................................................................................................................................................done. 00:41:47 INFO - Installing pip.................done. 00:41:47 INFO - Return code: 0 00:41:47 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 00:41:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:41:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:41:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:41:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:41:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:41:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:41:47 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 0x104481a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104516618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff0e0d61930>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1043e5d30>, '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 0x10414adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1043ddb20>, '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.98Q0OeKug0/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.ggLe7WHkAi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/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 00:41:47 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 00:41:47 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 00:41:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.98Q0OeKug0/Render', 00:41:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:41:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:41:47 INFO - 'HOME': '/Users/cltbld', 00:41:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:41:47 INFO - 'LOGNAME': 'cltbld', 00:41:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:41:47 INFO - 'MOZ_NO_REMOTE': '1', 00:41:47 INFO - 'NO_EM_RESTART': '1', 00:41:47 INFO - 'PAGER': '/bin/cat', 00:41:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:41:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:41:47 INFO - 'PWD': '/builds/slave/test', 00:41:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:41:47 INFO - 'SHELL': '/bin/bash', 00:41:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ggLe7WHkAi/Listeners', 00:41:47 INFO - 'TMPDIR': '/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/', 00:41:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:41:47 INFO - 'USER': 'cltbld', 00:41:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:41:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:41:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:41:47 INFO - 'XPC_FLAGS': '0x0', 00:41:47 INFO - 'XPC_SERVICE_NAME': '0', 00:41:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:41:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:41:47 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 00:41:47 INFO - Cleaning up... 00:41:47 INFO - Return code: 0 00:41:47 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 00:41:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:41:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:41:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:41:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:41:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:41:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:41:47 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 0x104481a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104516618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff0e0d61930>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1043e5d30>, '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 0x10414adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1043ddb20>, '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.98Q0OeKug0/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.ggLe7WHkAi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/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 00:41:47 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 00:41:47 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 00:41:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.98Q0OeKug0/Render', 00:41:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:41:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:41:47 INFO - 'HOME': '/Users/cltbld', 00:41:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:41:47 INFO - 'LOGNAME': 'cltbld', 00:41:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:41:47 INFO - 'MOZ_NO_REMOTE': '1', 00:41:47 INFO - 'NO_EM_RESTART': '1', 00:41:47 INFO - 'PAGER': '/bin/cat', 00:41:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:41:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:41:47 INFO - 'PWD': '/builds/slave/test', 00:41:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:41:47 INFO - 'SHELL': '/bin/bash', 00:41:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ggLe7WHkAi/Listeners', 00:41:47 INFO - 'TMPDIR': '/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/', 00:41:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:41:47 INFO - 'USER': 'cltbld', 00:41:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:41:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:41:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:41:47 INFO - 'XPC_FLAGS': '0x0', 00:41:47 INFO - 'XPC_SERVICE_NAME': '0', 00:41:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:41:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:41:47 INFO - Downloading/unpacking psutil>=3.1.1 00:41:47 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 00:41:47 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 00:41:47 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 00:41:47 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 00:41:47 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 00:41:47 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 00:41:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 00:41:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:41:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:41:51 INFO - Installing collected packages: psutil 00:41:51 INFO - Running setup.py install for psutil 00:41:51 INFO - building 'psutil._psutil_osx' extension 00:41:51 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 00:41:51 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 00:41:51 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 00:41:52 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 00:41:52 INFO - building 'psutil._psutil_posix' extension 00:41:52 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 00:41:52 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 00:41:52 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 00:41:52 INFO - ^ 00:41:52 INFO - 1 warning generated. 00:41:52 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 00:41:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:41:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:41:52 INFO - Successfully installed psutil 00:41:52 INFO - Cleaning up... 00:41:52 INFO - Return code: 0 00:41:52 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 00:41:52 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')]} 00:41:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:41:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:41:52 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')]} 00:41:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:41:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:41:52 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 0x104481a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104516618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff0e0d61930>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1043e5d30>, '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 0x10414adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1043ddb20>, '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.98Q0OeKug0/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.ggLe7WHkAi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/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 00:41:52 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 00:41:52 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 00:41:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.98Q0OeKug0/Render', 00:41:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:41:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:41:52 INFO - 'HOME': '/Users/cltbld', 00:41:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:41:52 INFO - 'LOGNAME': 'cltbld', 00:41:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:41:52 INFO - 'MOZ_NO_REMOTE': '1', 00:41:52 INFO - 'NO_EM_RESTART': '1', 00:41:52 INFO - 'PAGER': '/bin/cat', 00:41:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:41:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:41:52 INFO - 'PWD': '/builds/slave/test', 00:41:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:41:52 INFO - 'SHELL': '/bin/bash', 00:41:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ggLe7WHkAi/Listeners', 00:41:52 INFO - 'TMPDIR': '/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/', 00:41:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:41:52 INFO - 'USER': 'cltbld', 00:41:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:41:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:41:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:41:52 INFO - 'XPC_FLAGS': '0x0', 00:41:52 INFO - 'XPC_SERVICE_NAME': '0', 00:41:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:41:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:41:52 INFO - Downloading/unpacking mozsystemmonitor==0.3 00:41:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:41:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:41:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:41:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:41:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:41:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:41:55 INFO - Downloading mozsystemmonitor-0.3.tar.gz 00:41:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 00:41:55 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 00:41:55 INFO - Installing collected packages: mozsystemmonitor 00:41:55 INFO - Running setup.py install for mozsystemmonitor 00:41:55 INFO - Successfully installed mozsystemmonitor 00:41:55 INFO - Cleaning up... 00:41:55 INFO - Return code: 0 00:41:55 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 00:41:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:41:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:41:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:41:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:41:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:41:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:41:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x104481a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104516618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff0e0d61930>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1043e5d30>, '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 0x10414adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1043ddb20>, '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.98Q0OeKug0/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.ggLe7WHkAi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/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 00:41:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 00:41:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 00:41:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.98Q0OeKug0/Render', 00:41:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:41:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:41:55 INFO - 'HOME': '/Users/cltbld', 00:41:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:41:55 INFO - 'LOGNAME': 'cltbld', 00:41:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:41:55 INFO - 'MOZ_NO_REMOTE': '1', 00:41:55 INFO - 'NO_EM_RESTART': '1', 00:41:55 INFO - 'PAGER': '/bin/cat', 00:41:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:41:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:41:55 INFO - 'PWD': '/builds/slave/test', 00:41:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:41:55 INFO - 'SHELL': '/bin/bash', 00:41:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ggLe7WHkAi/Listeners', 00:41:55 INFO - 'TMPDIR': '/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/', 00:41:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:41:55 INFO - 'USER': 'cltbld', 00:41:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:41:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:41:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:41:55 INFO - 'XPC_FLAGS': '0x0', 00:41:55 INFO - 'XPC_SERVICE_NAME': '0', 00:41:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:41:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:41:55 INFO - Downloading/unpacking jsonschema==2.5.1 00:41:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:41:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:41:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:41:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:41:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:41:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:41:58 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 00:41:58 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 00:41: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 00:41: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 00:41: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 00:41: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 00:41: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 00:41: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 00:41:58 INFO - Downloading functools32-3.2.3-2.tar.gz 00:41:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 00:41:58 INFO - warning: no files found matching '*.txt' 00:41:58 INFO - no previously-included directories found matching 'build' 00:41:58 INFO - no previously-included directories found matching 'dist' 00:41:58 INFO - no previously-included directories found matching '.git*' 00:41:58 INFO - Installing collected packages: jsonschema, functools32 00:41:58 INFO - Running setup.py install for functools32 00:41:58 INFO - warning: no files found matching '*.txt' 00:41:58 INFO - no previously-included directories found matching 'build' 00:41:58 INFO - no previously-included directories found matching 'dist' 00:41:58 INFO - no previously-included directories found matching '.git*' 00:41:58 INFO - Successfully installed jsonschema functools32 00:41:58 INFO - Cleaning up... 00:41:58 INFO - Return code: 0 00:41:58 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 00:41:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:41:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:41:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:41:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:41:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:41:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:41:58 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 0x104481a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104516618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff0e0d61930>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1043e5d30>, '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 0x10414adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1043ddb20>, '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.98Q0OeKug0/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.ggLe7WHkAi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/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 00:41:58 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 00:41:58 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 00:41:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.98Q0OeKug0/Render', 00:41:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:41:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:41:58 INFO - 'HOME': '/Users/cltbld', 00:41:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:41:58 INFO - 'LOGNAME': 'cltbld', 00:41:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:41:58 INFO - 'MOZ_NO_REMOTE': '1', 00:41:58 INFO - 'NO_EM_RESTART': '1', 00:41:58 INFO - 'PAGER': '/bin/cat', 00:41:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:41:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:41:58 INFO - 'PWD': '/builds/slave/test', 00:41:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:41:58 INFO - 'SHELL': '/bin/bash', 00:41:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ggLe7WHkAi/Listeners', 00:41:58 INFO - 'TMPDIR': '/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/', 00:41:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:41:58 INFO - 'USER': 'cltbld', 00:41:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:41:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:41:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:41:58 INFO - 'XPC_FLAGS': '0x0', 00:41:58 INFO - 'XPC_SERVICE_NAME': '0', 00:41:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:41:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:41:59 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 00:41:59 INFO - Cleaning up... 00:41:59 INFO - Return code: 0 00:41:59 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 00:41: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')]} 00:41:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:41:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:41: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')]} 00:41:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:41:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:41:59 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 0x104481a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104516618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff0e0d61930>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1043e5d30>, '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 0x10414adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1043ddb20>, '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.98Q0OeKug0/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.ggLe7WHkAi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/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 00:41:59 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 00:41:59 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 00:41:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.98Q0OeKug0/Render', 00:41:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:41:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:41:59 INFO - 'HOME': '/Users/cltbld', 00:41:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:41:59 INFO - 'LOGNAME': 'cltbld', 00:41:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:41:59 INFO - 'MOZ_NO_REMOTE': '1', 00:41:59 INFO - 'NO_EM_RESTART': '1', 00:41:59 INFO - 'PAGER': '/bin/cat', 00:41:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:41:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:41:59 INFO - 'PWD': '/builds/slave/test', 00:41:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:41:59 INFO - 'SHELL': '/bin/bash', 00:41:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ggLe7WHkAi/Listeners', 00:41:59 INFO - 'TMPDIR': '/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/', 00:41:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:41:59 INFO - 'USER': 'cltbld', 00:41:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:41:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:41:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:41:59 INFO - 'XPC_FLAGS': '0x0', 00:41:59 INFO - 'XPC_SERVICE_NAME': '0', 00:41:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:41:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:41:59 INFO - Downloading/unpacking blobuploader==1.2.4 00:41:59 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 00:41:59 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 00:41:59 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 00:41:59 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 00:41:59 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 00:41:59 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 00:42:01 INFO - Downloading blobuploader-1.2.4.tar.gz 00:42:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 00:42:01 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 00:42:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:42:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:42:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:42:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:42:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:42:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:42:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 00:42:02 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 00:42:02 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 00:42:02 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 00:42:02 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 00:42:02 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 00:42:02 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 00:42:02 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 00:42:03 INFO - Downloading docopt-0.6.1.tar.gz 00:42:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 00:42:03 INFO - Installing collected packages: blobuploader, requests, docopt 00:42:03 INFO - Running setup.py install for blobuploader 00:42:03 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 00:42:03 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 00:42:03 INFO - Running setup.py install for requests 00:42:03 INFO - Running setup.py install for docopt 00:42:03 INFO - Successfully installed blobuploader requests docopt 00:42:03 INFO - Cleaning up... 00:42:04 INFO - Return code: 0 00:42:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:42:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:42:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:42:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:42:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:42:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:42:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:42:04 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 0x104481a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104516618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff0e0d61930>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1043e5d30>, '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 0x10414adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1043ddb20>, '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.98Q0OeKug0/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.ggLe7WHkAi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/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 00:42:04 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 00:42:04 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 00:42:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.98Q0OeKug0/Render', 00:42:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:42:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:42:04 INFO - 'HOME': '/Users/cltbld', 00:42:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:42:04 INFO - 'LOGNAME': 'cltbld', 00:42:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:42:04 INFO - 'MOZ_NO_REMOTE': '1', 00:42:04 INFO - 'NO_EM_RESTART': '1', 00:42:04 INFO - 'PAGER': '/bin/cat', 00:42:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:42:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:42:04 INFO - 'PWD': '/builds/slave/test', 00:42:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:42:04 INFO - 'SHELL': '/bin/bash', 00:42:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ggLe7WHkAi/Listeners', 00:42:04 INFO - 'TMPDIR': '/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/', 00:42:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:42:04 INFO - 'USER': 'cltbld', 00:42:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:42:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:42:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:42:04 INFO - 'XPC_FLAGS': '0x0', 00:42:04 INFO - 'XPC_SERVICE_NAME': '0', 00:42:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:42:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:42:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 00:42:04 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-qI9EMF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 00:42:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 00:42:04 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-Vr1wIr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 00:42:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 00:42:04 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-EwfOBu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 00:42:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 00:42:04 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-28uOHJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 00:42:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 00:42:04 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-Rla7PI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 00:42:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 00:42:04 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-rUufh0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 00:42:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 00:42:04 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-gKYwj2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 00:42:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 00:42:05 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-rgm8pF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 00:42:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 00:42:05 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-GbagOJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 00:42:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 00:42:05 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-Ic9UoG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 00:42:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 00:42:05 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-SFY8ND-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 00:42:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 00:42:05 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-llG31c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 00:42:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 00:42:05 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-4hCmGu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 00:42:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 00:42:05 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-s1OQ9g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 00:42:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 00:42:05 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-zv5Gfh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 00:42:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 00:42:05 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-JkoXG2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 00:42:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 00:42:06 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-DRIjc_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 00:42:06 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 00:42:06 INFO - Running setup.py install for manifestparser 00:42:06 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 00:42:06 INFO - Running setup.py install for mozcrash 00:42:06 INFO - Running setup.py install for mozdebug 00:42:06 INFO - Running setup.py install for mozdevice 00:42:06 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 00:42:06 INFO - Installing dm script to /builds/slave/test/build/venv/bin 00:42:06 INFO - Running setup.py install for mozfile 00:42:06 INFO - Running setup.py install for mozhttpd 00:42:06 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 00:42:06 INFO - Running setup.py install for mozinfo 00:42:07 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 00:42:07 INFO - Running setup.py install for mozInstall 00:42:07 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 00:42:07 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 00:42:07 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 00:42:07 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 00:42:07 INFO - Running setup.py install for mozleak 00:42:07 INFO - Running setup.py install for mozlog 00:42:07 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 00:42:07 INFO - Running setup.py install for moznetwork 00:42:07 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 00:42:07 INFO - Running setup.py install for mozprocess 00:42:07 INFO - Running setup.py install for mozprofile 00:42:08 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 00:42:08 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 00:42:08 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 00:42:08 INFO - Running setup.py install for mozrunner 00:42:08 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 00:42:08 INFO - Running setup.py install for mozscreenshot 00:42:08 INFO - Running setup.py install for moztest 00:42:08 INFO - Running setup.py install for mozversion 00:42:08 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 00:42:08 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 00:42:08 INFO - Cleaning up... 00:42:08 INFO - Return code: 0 00:42:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:42:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:42:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:42:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:42:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:42:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:42:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:42:08 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 0x104481a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104516618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff0e0d61930>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1043e5d30>, '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 0x10414adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1043ddb20>, '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.98Q0OeKug0/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.ggLe7WHkAi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/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 00:42:08 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 00:42:08 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 00:42:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.98Q0OeKug0/Render', 00:42:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:42:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:42:08 INFO - 'HOME': '/Users/cltbld', 00:42:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:42:08 INFO - 'LOGNAME': 'cltbld', 00:42:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:42:08 INFO - 'MOZ_NO_REMOTE': '1', 00:42:08 INFO - 'NO_EM_RESTART': '1', 00:42:08 INFO - 'PAGER': '/bin/cat', 00:42:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:42:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:42:08 INFO - 'PWD': '/builds/slave/test', 00:42:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:42:08 INFO - 'SHELL': '/bin/bash', 00:42:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ggLe7WHkAi/Listeners', 00:42:08 INFO - 'TMPDIR': '/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/', 00:42:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:42:08 INFO - 'USER': 'cltbld', 00:42:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:42:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:42:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:42:08 INFO - 'XPC_FLAGS': '0x0', 00:42:08 INFO - 'XPC_SERVICE_NAME': '0', 00:42:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:42:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:42:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 00:42:08 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-dYAkhG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 00:42:09 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)) 00:42:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 00:42:09 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-pHNnIj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 00:42:09 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)) 00:42:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 00:42:09 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-tH0UrK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 00:42:09 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)) 00:42:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 00:42:09 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-NXIFz8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 00:42:09 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)) 00:42:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 00:42:09 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-L3vOgb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 00:42:09 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)) 00:42:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 00:42:09 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-datPdZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 00:42:09 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)) 00:42:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 00:42:09 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-wNAAvT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 00:42:09 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)) 00:42:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 00:42:09 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-FaLfwH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 00:42:09 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)) 00:42:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 00:42:09 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-zOLl34-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 00:42:09 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)) 00:42:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 00:42:09 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-XAlqcH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 00:42:10 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)) 00:42:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 00:42:10 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-HLB6Z1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 00:42:10 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)) 00:42:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 00:42:10 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-XqO7ng-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 00:42:10 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)) 00:42:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 00:42:10 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-8MLBdG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 00:42:10 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)) 00:42:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 00:42:10 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-IiCW0X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 00:42:10 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)) 00:42:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 00:42:10 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-L_JnGu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 00:42:10 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)) 00:42:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 00:42:10 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-hblv7x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 00:42:10 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)) 00:42:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 00:42:10 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-PFsA18-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 00:42:10 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)) 00:42:10 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)) 00:42:10 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)) 00:42:10 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)) 00:42:10 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)) 00:42:10 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)) 00:42:10 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 00:42:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:42:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:42:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:42:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:42:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:42:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:42:13 INFO - Downloading blessings-1.6.tar.gz 00:42:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 00:42:13 INFO - Installing collected packages: blessings 00:42:13 INFO - Running setup.py install for blessings 00:42:13 INFO - Successfully installed blessings 00:42:13 INFO - Cleaning up... 00:42:13 INFO - Return code: 0 00:42:13 INFO - Done creating virtualenv /builds/slave/test/build/venv. 00:42:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 00:42:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 00:42:13 INFO - Reading from file tmpfile_stdout 00:42:13 INFO - Current package versions: 00:42:13 INFO - blessings == 1.6 00:42:13 INFO - blobuploader == 1.2.4 00:42:13 INFO - docopt == 0.6.1 00:42:13 INFO - functools32 == 3.2.3-2 00:42:13 INFO - jsonschema == 2.5.1 00:42:13 INFO - manifestparser == 1.1 00:42:13 INFO - mozInstall == 1.12 00:42:13 INFO - mozcrash == 0.17 00:42:13 INFO - mozdebug == 0.1 00:42:13 INFO - mozdevice == 0.48 00:42:13 INFO - mozfile == 1.2 00:42:13 INFO - mozhttpd == 0.7 00:42:13 INFO - mozinfo == 0.9 00:42:13 INFO - mozleak == 0.1 00:42:13 INFO - mozlog == 3.3 00:42:13 INFO - moznetwork == 0.27 00:42:13 INFO - mozprocess == 0.23 00:42:13 INFO - mozprofile == 0.28 00:42:13 INFO - mozrunner == 6.12 00:42:13 INFO - mozscreenshot == 0.1 00:42:13 INFO - mozsystemmonitor == 0.3 00:42:13 INFO - moztest == 0.7 00:42:13 INFO - mozversion == 1.4 00:42:13 INFO - psutil == 3.1.1 00:42:13 INFO - requests == 1.2.3 00:42:13 INFO - wsgiref == 0.1.2 00:42:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:42:13 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')]} 00:42:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:42:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:42:13 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')]} 00:42:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:42:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:42:13 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 0x104481a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104516618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff0e0d61930>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1043e5d30>, '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 0x10414adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1043ddb20>, '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.98Q0OeKug0/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.ggLe7WHkAi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/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 00:42:13 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 00:42:13 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 00:42:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.98Q0OeKug0/Render', 00:42:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:42:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:42:13 INFO - 'HOME': '/Users/cltbld', 00:42:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:42:13 INFO - 'LOGNAME': 'cltbld', 00:42:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:42:13 INFO - 'MOZ_NO_REMOTE': '1', 00:42:13 INFO - 'NO_EM_RESTART': '1', 00:42:13 INFO - 'PAGER': '/bin/cat', 00:42:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:42:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:42:13 INFO - 'PWD': '/builds/slave/test', 00:42:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:42:13 INFO - 'SHELL': '/bin/bash', 00:42:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ggLe7WHkAi/Listeners', 00:42:13 INFO - 'TMPDIR': '/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/', 00:42:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:42:13 INFO - 'USER': 'cltbld', 00:42:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:42:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:42:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:42:13 INFO - 'XPC_FLAGS': '0x0', 00:42:13 INFO - 'XPC_SERVICE_NAME': '0', 00:42:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:42:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:42:14 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)) 00:42:14 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)) 00:42:14 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)) 00:42:14 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)) 00:42:14 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)) 00:42:14 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)) 00:42:14 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)) 00:42:14 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)) 00:42:14 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)) 00:42:14 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)) 00:42:14 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)) 00:42:14 INFO - Cleaning up... 00:42:14 INFO - Return code: 0 00:42:14 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 00:42: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')]} 00:42:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:42:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:42: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')]} 00:42:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:42:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:42:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104481a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104516618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff0e0d61930>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1043e5d30>, '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 0x10414adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1043ddb20>, '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.98Q0OeKug0/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.ggLe7WHkAi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/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 00:42:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 00:42:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 00:42:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.98Q0OeKug0/Render', 00:42:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:42:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:42:14 INFO - 'HOME': '/Users/cltbld', 00:42:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:42:14 INFO - 'LOGNAME': 'cltbld', 00:42:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:42:14 INFO - 'MOZ_NO_REMOTE': '1', 00:42:14 INFO - 'NO_EM_RESTART': '1', 00:42:14 INFO - 'PAGER': '/bin/cat', 00:42:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:42:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:42:14 INFO - 'PWD': '/builds/slave/test', 00:42:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:42:14 INFO - 'SHELL': '/bin/bash', 00:42:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ggLe7WHkAi/Listeners', 00:42:14 INFO - 'TMPDIR': '/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/', 00:42:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:42:14 INFO - 'USER': 'cltbld', 00:42:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:42:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:42:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:42:14 INFO - 'XPC_FLAGS': '0x0', 00:42:14 INFO - 'XPC_SERVICE_NAME': '0', 00:42:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:42:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:42:14 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 00:42:14 INFO - Cleaning up... 00:42:14 INFO - Return code: 0 00:42:14 INFO - Running post-action listener: _resource_record_post_action 00:42:14 INFO - Running post-action listener: _start_resource_monitoring 00:42:14 INFO - Starting resource monitoring. 00:42:14 INFO - [mozharness: 2016-08-10 07:42:14.386556Z] Finished create-virtualenv step (success) 00:42:14 INFO - [mozharness: 2016-08-10 07:42:14.387571Z] Running install step. 00:42:14 INFO - Running pre-action listener: _resource_record_pre_action 00:42:14 INFO - Running main action method: install 00:42:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 00:42:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 00:42:14 INFO - Reading from file tmpfile_stdout 00:42:14 INFO - Detecting whether we're running mozinstall >=1.0... 00:42:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 00:42:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 00:42:14 INFO - Reading from file tmpfile_stdout 00:42:14 INFO - Output received: 00:42:14 INFO - Usage: mozinstall [options] installer 00:42:14 INFO - Options: 00:42:14 INFO - -h, --help show this help message and exit 00:42:14 INFO - -d DEST, --destination=DEST 00:42:14 INFO - Directory to install application into. [default: 00:42:14 INFO - "/builds/slave/test"] 00:42:14 INFO - --app=APP Application being installed. [default: firefox] 00:42:14 INFO - mkdir: /builds/slave/test/build/application 00:42:14 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'] 00:42:14 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 00:42:49 INFO - Reading from file tmpfile_stdout 00:42:49 INFO - Output received: 00:42:49 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 00:42:49 INFO - Running post-action listener: _resource_record_post_action 00:42:49 INFO - [mozharness: 2016-08-10 07:42:49.196488Z] Finished install step (success) 00:42:49 INFO - [mozharness: 2016-08-10 07:42:49.196622Z] Running run-tests step. 00:42:49 INFO - Running pre-action listener: _resource_record_pre_action 00:42:49 INFO - Running main action method: run_tests 00:42:49 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 00:42:49 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 00:42:49 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 00:42:49 INFO - 2016-08-10 00:42:49.210 screenresolution[1641:7352] starting screenresolution argv=screenresolution get 00:42:49 INFO - 2016-08-10 00:42:49.213 screenresolution[1641:7352] Display 0: 1600x1200x32@60 00:42:49 INFO - 2016-08-10 00:42:49.219 screenresolution[1642:7354] starting screenresolution argv=screenresolution list 00:42:49 INFO - Available Modes on Display 0 00:42:49 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 00:42:49 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 00:42:49 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 00:42:49 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 00:42:49 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 00:42:49 INFO - Intel Iris: 00:42:49 INFO - Chipset Model: Intel Iris 00:42:49 INFO - Type: GPU 00:42:49 INFO - Bus: Built-In 00:42:49 INFO - VRAM (Dynamic, Max): 1536 MB 00:42:49 INFO - Vendor: Intel (0x8086) 00:42:49 INFO - Device ID: 0x0a2e 00:42:49 INFO - Revision ID: 0x0009 00:42:49 INFO - Displays: 00:42:49 INFO - Display: 00:42:49 INFO - Resolution: 1600 x 1200 @ 60 Hz 00:42:49 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 00:42:49 INFO - Display Serial Number: 1600x1200 60 00:42:49 INFO - Main Display: Yes 00:42:49 INFO - Mirror: Off 00:42:49 INFO - Online: Yes 00:42:49 INFO - Rotation: Supported 00:42:49 INFO - Return code: 0 00:42:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 00:42:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 00:42:49 INFO - Python 2.7.3 00:42:49 INFO - Return code: 0 00:42:49 INFO - grabbing minidump binary from tooltool 00:42: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')]} 00:42:49 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 0x1043e5d30>, '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 0x10414adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1043ddb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 00:42:49 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 00:42:49 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 00:42:49 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 00:42:49 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 00:42:49 INFO - Return code: 0 00:42:49 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 00:42:49 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 00:42:49 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 00:42:49 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 00:42:49 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 00:42:49 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/BFTouO-CRQG2-L1bIZXezQ/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0052', '--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 00:42:49 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/BFTouO-CRQG2-L1bIZXezQ/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0052 --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 00:42:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.98Q0OeKug0/Render', 00:42:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:42:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:42:49 INFO - 'HOME': '/Users/cltbld', 00:42:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:42:49 INFO - 'LOGNAME': 'cltbld', 00:42:49 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 00:42:49 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 00:42:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:42:49 INFO - 'MOZ_NO_REMOTE': '1', 00:42:49 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 00:42:49 INFO - 'NO_EM_RESTART': '1', 00:42:49 INFO - 'PAGER': '/bin/cat', 00:42:49 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:42:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:42:49 INFO - 'PWD': '/builds/slave/test', 00:42:49 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 00:42:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:42:49 INFO - 'SHELL': '/bin/bash', 00:42:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ggLe7WHkAi/Listeners', 00:42:49 INFO - 'TMPDIR': '/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/', 00:42:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:42:49 INFO - 'USER': 'cltbld', 00:42:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:42:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:42:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:42:49 INFO - 'XPC_FLAGS': '0x0', 00:42:49 INFO - 'XPC_SERVICE_NAME': '0', 00:42:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:42:49 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/BFTouO-CRQG2-L1bIZXezQ/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0052', '--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 00:42:49 INFO - mozversion application_buildid: 20160809224115 00:42:49 INFO - mozversion application_changeset: 3269dd1a824d1b42cb021d1fb6858885179940b0 00:42:49 INFO - mozversion application_display_name: Nightly 00:42:49 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 00:42:49 INFO - mozversion application_name: Firefox 00:42:49 INFO - mozversion application_remotingname: firefox 00:42:49 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 00:42:49 INFO - mozversion application_vendor: Mozilla 00:42:49 INFO - mozversion application_version: 51.0a1 00:42:49 INFO - mozversion platform_buildid: 20160809224115 00:42:49 INFO - mozversion platform_changeset: 3269dd1a824d1b42cb021d1fb6858885179940b0 00:42:49 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 00:42:49 INFO - mozversion platform_version: 51.0a1 00:42:49 INFO - using testdate: 1470814969 00:42:49 INFO - actual date: 1470814969 00:42:49 INFO - starting webserver on 'localhost:49266' 00:42:49 INFO - SUITE-START | Running 2 tests 00:42:49 INFO - TEST-START | dromaeo_css 00:42:49 INFO - operating with platform_type : mac_ 00:42:49 INFO - Initialising browser for dromaeo_css test... 00:42:49 INFO - TEST-INFO | started process 1652 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/tmpezdKv2/profile http://localhost:49266/getInfo.html) 00:42:52 INFO - PROCESS | 1652 | __metrics Screen width/height:1600/1200 00:42:52 INFO - PROCESS | 1652 | colorDepth:24 00:42:52 INFO - PROCESS | 1652 | Browser inner width/height: 1024/689 00:42:52 INFO - PROCESS | 1652 | __metrics 00:42:52 ERROR - PROCESS | 1652 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 00:42:53 INFO - TEST-INFO | 1652: exit 0 00:42:53 INFO - Browser initialized. 00:42:53 INFO - Running cycle 1/1 for dromaeo_css test... 00:42:53 INFO - TEST-INFO | started process 1655 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/tmpezdKv2/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 00:43:05 INFO - PROCESS | 1655 | RSS: Main: 254517248 00:43:05 INFO - PROCESS | 1655 | 00:43:55 INFO - PROCESS | 1655 | 1470815035090 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] 00:46:07 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49266/tests/dromaeo/cssquery-ext.html) 00:46:09 INFO - PROCESS | 1655 | RSS: Main: 267591680 00:46:09 INFO - PROCESS | 1655 | 00:49:11 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-ext.html (next: http://localhost:49266/tests/dromaeo/cssquery-jquery.html) 00:49:12 INFO - PROCESS | 1655 | RSS: Main: 279855104 00:49:12 INFO - PROCESS | 1655 | 00:52:13 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49266/tests/dromaeo/cssquery-mootools.html) 00:52:14 INFO - PROCESS | 1655 | RSS: Main: 287207424 00:52:14 INFO - PROCESS | 1655 | 00:55:16 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49266/tests/dromaeo/cssquery-prototype.html) 00:55:16 INFO - PROCESS | 1655 | RSS: Main: 285749248 00:55:16 INFO - PROCESS | 1655 | 00:58:19 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49266/tests/dromaeo/cssquery-yui.html) 00:58:20 INFO - PROCESS | 1655 | RSS: Main: 290983936 00:58:20 INFO - PROCESS | 1655 | 01:01:22 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-yui.html (next: http://localhost:49266/tests/dromaeo/cssquery-dojo.html) 01:01:22 INFO - PROCESS | 1655 | RSS: Main: 292429824 01:01:22 INFO - PROCESS | 1655 | 01:01:22 INFO - PROCESS | 1655 | __start_tp_report 01:01:22 INFO - PROCESS | 1655 | _x_x_mozilla_page_load 01:01:22 INFO - PROCESS | 1655 | _x_x_mozilla_page_load_details 01:01:22 INFO - PROCESS | 1655 | |i|pagename|runs| 01:01:22 INFO - PROCESS | 1655 | |0;dojo.html;3315.0552092653616;3420.7605467617277;3430.8970730878073;3456.1359660084977;3463.290025544763;5692.743826527806;5758.712064396774;5803.419658034194;5894.17481552583;5901.439363260494;5759.136129580565;5792.160136780164;5827.970860145704;5828.2714660667525;5914.526837852972;5168.586513078944;5270.710110943896;5302.2311764794085;5329.573634109262;5356.625036247445;5322.068637988336;5367.946320536784;5403.594730395216;5414.972925135388;5442.455754424545;4086.6117718816663;4385;5248.632595718302;5296.25852380667;5298.788048478056;5197.532222100029;5204.375474943031;5225.399079105913;5278.366596008465;5313.787448502056;5208.322918020633;5228.215767634847;5277.70972596507;5314.5748340132695;5323.787048518055;5698.116791897262;5797.8550536236935;5830.650160990312;5846.181534585162;5868.882622347529;6158.137860699506;6191.721372538202;6192.752289908398;6250.624962502265;6268.905966410462;5402.621816472849;6246.437820596168;6255.311915689271;6279.215098112736;6287.559870809046;5792.073268277056;5831.883362332772;5892.499137573354;5917.52659787216;5918.408159184133;6311.400416960381;6316.810495685137;6332.0818481320875;6350.237971443364;6354.872902541923;6235.376462353728;6252.531060170414;6258.311585725566;6260.624362538262;6262.812115636538;6138.572327483795;6197.628142311476;6200.968995154995;6203.534734894901;6296.937030629635;6170.259568851677;6251.812445626639;6254.155688981929;6272.529560282997;6272.686365681698;6172.4136207060255;6250.249970003538;6253.7185826637915;6275.246970363585;6283.120363149163;4160.209560183555;4272.166927449118;4865.245886887538;4956.801727930914;5012.8496145115705;3884.8446062157764;4472.39622650938;4489;4493.977530112328;4558.772061396917;5764.394738552475;5860.648361098262;5861.413858614104;5874.853128671732;5901.3213480450295;5883.646981181143;6151.169592105009;6172.444479996732;6201.069839524108;6230.688465576703;5467.343918729778;5855.473007429352;5868.119782032644;5882.588218824641;5903.468687818117;5482.945170548243;5497.230387745719;5501.394846566875;5527.695976721238;5531.612787104864;6182.969085154456;6256.436920677161;6262.342454042442;6312.4634406076;6359.9364006360265;6234.812955611339;6254.186955695913;6257.499400047895;6272.090546870587;6277.623342599459;6313.905291420724;6352.428281454691;6353.142325786144;6359.841003974938;6372.330905255067;6103.85289575482;6146.4468197860615;6152.107944348134;6163.722632481638;6245.96877015612;6125.724342404514;6224.564280500322;6225.595336303126;6241.875162496815;6248.0940263660605;6174.938250617616;6194.783182588588;6204.038374052029;6208.658523781235;6208.751649934133;6026.7589296429405;6030.03519436888;6061.6666083365835;6107.572469927062;6128.233970753656;5765.106408506688;5929.733162007634;6006.099085137264;6067.757289708362;6088;6116.8559221291825;6163.660998645118;6191.659458729813;6194.163787888758;6211.596246243979;5128.230765385222;5468.207109968953;5997.670128142994;6035.094735789667;6042.335343112166 01:01:22 INFO - PROCESS | 1655 | |1;ext.html;462.6137175458492;475.44135640622284;517.3636427194548;540.9080456322426;550.3011175806723;38172.04569885751;41551;41603.58396416035;41700.58299417005;41742.791286043604;42569.36145957813;42982.14035719284;43001.78499107508;43029.784851075776;43042;9519.666811661611;9608.759781005461;9662.130408263254;9723.756906077333;9736;9613.903860961405;9690.75773105671;9695.321327507078;9708.17480514157;9726.17327527161;9694.272929530314;9726.65956691516;9732.41605503672;9734.951325243364;9762.36544624597;9643.855342169873;9691.224702023821;9702.320837541305;9711.125998660083;9746.317757756924;9511.14399704023;9512.47681377524;9565.37825041377;9600.471974041495;9609.087136722;33169;40482.39276410856;40735.38896916519;40812.38781418281;40820.38769418461;2640.577507598775;3217.8551965161623;3294.2917272786226;3494.947575786365;3496.860125594973;29193.124206273846;29422.970196043036;30726.231844204074;30853.537196942063;31330.796212204034;3072.477678794588;3103.534469829521;3110.440120778259;3199.6160460744627;3252.642209356969;400405;454619;455758.9999999967;456035;458370;33734.65061397566;34001.82999085038;34042.659573404446;34065.82967085149;34149.82925085408;32766.017019489453;33799.493007604906;34738;35371.469427958604;36246;16722.74915876263;16919;16937.407190748265;16952;17230.224639891236;12514.624561263177;12606.991440684724;12607.243565386107;12639.93680031594;12685.048621353251;17530.737038944426;18350.81649183518;19439.611207775764;19481.512962175777;19526.90236548808;6404.455621272244;6963.965180174168;7721.613919304013;7777.650005749755;7905.960470197612;803.7106641609016;901.4366021236727;937.3719607862748;992.0426788149471;1066.0405634928627;24200;30542.847285763874;30562.84718576393;30637.69362306393;30735.692643073282;869.9304055675531;1006.8338724110587;1054.0513537815873;1076.8438576406377;1089.7874914391775;15465.613359666098;15774.684506310039;15805.525834224762;15919.293670306408;15978.360865565479;659885;663879;664686;664826;664827;52349.47650523446;59742.80514389775;60418.09372859323;60518;60597.69701151466;1220.7741567809805;1361.6051345110004;1376.0986553807272;1392.554382597559;1393.9651508712363;24976.875115624305;29184.56223156612;29694;30449.847750761106;30508.389832203677;51908;51991.96016079733;52062.73968630284;52147;52223.21665174949;587567.0621646864;588880;608770;610985.8901410929;613055;27279.181624551296;27420;27743.58384624192;27797.583036254877;27906.441871162868;48671.75664121657;48745.756271218415;48787;49701.751491242314;50379.49620503748;39812.80093599513;40196.598034020455;40641.983950401474;41327.79336103421;41532.58467415287;35235.119122021126;37903;39490;40102.19795604013;40643.390349144196;32893.835530822194;38089.42865856959;38458;38869.2226155481;39380.606193937696;34365.656343437244;35010;35662.10844728799;35732;35734;25544.872275638503;26038.869805651608;26106;26331.473370532865;26729.269473147928 01:01:22 INFO - PROCESS | 1655 | |2;jquery.html;366.34058694350165;373.1399125016837;377.8205352457583;383.6106352052669;386.8007975892414;19213.71179432308;20805.583888322242;21388.89305553472;21499.570008599858;21549.56900861982;16824.74762878558;17934.282628694837;20352.491187720316;20421.48946276344;20539;5812.418758124196;5843.912341314884;5953.70231488426;5995.6702381369005;6039.33567307598;4108.404281379198;5824.912626310609;5925.822225333225;5968.253968253968;5987.580869339148;6205.720742566573;6463.870722585569;6524.217093948733;6585.703643336037;6596.406323430891;6255.186825712651;6557.082008518812;6606.867862642768;6616.27221005689;6618.966905165492;5815.244018277639;5833.708314584296;5890.97054514729;5893.941060589425;5976.342602313742;12884.291363974977;13037.413316400785;13111.803322950163;13112.819846213886;21580.920953952398;2314.6528020796845;2335.801456876168;2343.9765602343928;2419.552382809186;2492.513959777844;9671.129598336112;9714.22286217101;9730.513474326255;10164.390136591754;10173.59305627774;1892.1654230830356;1909.1313452379134;1923.2210954563425;1954.5602239496;1986.2055177928944;126745.73254267524;129286.3535682325;132840;133945;137165;10113.64602238918;10864.67405977806;11303.321800691985;11651.47568359409;11669.241499302518;14073.366698498592;14372.928135359256;14431.278436078153;14449.060811047248;14498.347574359179;8345.624446899905;8505.787355316043;8545.829083418297;8656.485115104957;8671.479711217347;8442.788930276669;8458;8463.534505602127;8474.830503389898;8665.220130188314;4414.713043652217;4508.977455112704;4513.5486451355255;4519.593236608721;4555.908881822411;1588.3090855477903;1894.8768330058501;1954.540682939508;1990.3877858934309;2001.4496013596086;862.7454900804278;874.5627186406797;904.8009437923646;974.5273542331963;984.1634610581092;19820.008999549966;20154.39536813898;20233.392998210078;20764.896175519025;21140.894295528426;796.6494742313364;918.2883265469314;930.8324501589778;945.6122989574379;958.6932181701928;10762.78474430507;11268.774624507463;11356;11395.316281023164;11409.372484513266;548191;568827;584194;594358;596407;121939;124987.3750631241;127029;127935;127970;847.6185716427509;938.8310104181313;950.5769932380163;956.1108169402522;1014.5079636376352;16009.919950400174;16589.58526036859;19762.70355944633;19977.800221997593;20069.59860802805;38240.80879595695;47773.28340074832;55267.447325527835;56945;58857;80977;83650.16349836424;84081;85172.57413712892;85204;8073.5963201838495;8101.918980810116;8236.917630823855;8441.071482136836;8452.957735211285;9273.489958052372;11273.041791447491;12062.819057713965;13169;13465.596032119052;10337;11187.384693841917;11531.538738450703;11541.36522491271;11581.652550423501;10269.486525673836;11141.521664622129;11307.321560706385;11337.26307790024;11541.942290288494;11552;11798.410079496163;11885.405729713308;11938.64184074479;12029.578964736193;7197.640117994184;8026.237507436784;8055.476394034369;8310.792230194053;8536.31709463229;8353.415260931677;10535.841962370418;11236.325820450798;11474.4262786862;11676.532938682358 01:01:23 INFO - PROCESS | 1655 | |3;mootools.html;1500.4673340963961;1528.9082655040697;1715.4339068107527;1796.58678503944;1843.1797849956765;7847.646855891484;8278.834423311546;8305.792355191123;8811.427257228284;8842.469451832887;8375.581220938944;8526.190011948871;8597.742067737978;8608.61261243244;8616.095309992439;2287.5196208796133;2324.2097686786487;2325.5581439526436;2332.93001209964;2344.460774021976;2303.873286969216;2329.860208387494;2354.2701762453694;2359.95280094398;2366.053578568578;2338.8362814602983;2343.437574982009;2345.9178928737497;2348.0138341896445;2351.5884720173985;2276.601594720934;2286.9542609147807;2327.767223277676;2332.2303639798824;2340.0288880114817;2319.663648770919;2320.756320586331;2321.1759825261956;2321.8839058047197;2324.6164382876805;8585.871211931826;8623.310135189233;8624.482531048157;8644.178803013703;8659.696910608161;5075.5178258065425;5305.124654432014;5308.761105750251;5312.2828418163435;5326.973365133188;3400.4899265110184;3444.500547420635;3584.175639602906;3585.910352241189;3614.2952124335766;1039.9636012739593;1068.3910171202417;1078.1805827571102;1083.5178345636195;1092.6012005617893;11094.1124710023;11107.389093599848;11167.776644467065;11252.15608829341;11295.943520282346;4480.574345437179;4524;4710.152172608963;4710.246360582359;4721.480637129982;8814.955925220333;9655.22758179344;9765.16996055329;9842.852357214648;9898.505074746234;5273.736313184326;5298.841034768963;5301.284326615934;5304.628675992643;5310.230016647564;4357.215701173755;4694.647901407408;4808.447028591757;4847.563719265283;4855.830045948375;3838.347480928249;3941.3299739044432;3944.7830369329963;3970.662493688011;4051.0277533391773;1264.3235868810143;1281.8782215689494;1288.7293668329569;1289.4519829072606;1293.4567481657725;802.7872613757359;917.9357444978921;922.760082378573;937.5452905340904;964.6671898195111;5494.36814766307;5584.190292407578;5702.971485142548;5876.08920617305;5951.196588460589;425.94888613365976;432.7360310210769;440.73776103218535;440.9603135717801;443.5010613060307;3488.424409972377;3648.434492653643;3888.941665875014;3977.3835055566433;4025.5370632377067;10140.087392134743;10485.056344928993;10547.525361358757;10557.260991730658;10567.841482377771;10508.159347252202;10509.579616815394;10511.632092876713;10560.419176945341;10563.47182640865;7721.806954826175;7846.8430631387055;8048.154943730941;8066.798330041796;8081.515109093473;5720.456556627114;5898.085796701518;5924.851878703067;5960.612560183574;5977.342492325927;9469.810603788024;9834.01659834011;9868.703938881845;9895.703128906145;9901.009899010041;9841.163501102486;9880.901190987997;9922.255830812574;9937.602495900372;10017.449040302854;6908.412784913137;7297.051383320135;7420.369268612229;7500.624968751432;7528.8494230116185;8317.376196785386;8395.1604839518;8402.705905293285;8424.494530327955;8441.493510389397;7287.599182045038;7389.039424874947;7440.3675687567165;7461.962690186514;7544.396448284234;7238.055259883271;7270.6728197230195;7283.089613798275;7363.77908662741;7373.963130184315;6792.830179245559;6830.45356371499;6884.862302754017;6894.207166175954;6908.1019467468905;4428.844990425319;4492.842750503717;4808.879778005438;4940.431850337113;4998.175301075282;4910.288008238714;5003.649744517995;5063.392392912874;5096.592272618108;5106.693598384109 01:01:23 INFO - PROCESS | 1655 | |4;prototype.html;285.1374591859625;295.49765398822007;309.81565968248896;309.8559169985956;312.7654259305521;4553.4080569525995;5220.7450927494065;5386.676799392029;5610.859728506789;5643.435656434354;5528.75120619572;5575.665460072389;5583.35791383991;5599.32808063032;5611.288556990116;4239.724417912841;4253.660876212174;4259.936100958488;4275.166342563201;4278.828846846122;3748.7750734955853;4153.273177193994;4229.090745489719;4254.361845723135;4310.82756689732;3920.7255492115564;4207.453031105967;4219.050713589433;4221.978890105545;4228.1037489319915;4216.409702641633;4235.258829704805;4251.0860165064505;4277.379779931924;4325.416068830699;3540.805255710935;3674.136577904217;3681.1533347330264;3691.409374500094;3708.9600719604377;4685.2269375553;5341.65279256847;5358;5385.21914322425;5464.535514481274;4090.468239128924;4314.568543145691;4851.223804191348;4903.436104847917;4919.21292593187;4982;5289.973550132263;5561.388247292794;5958.880822383571;6031.577789554733;3399.7280217582534;3988.846023147497;4008.078142027321;4019.698522610816;4039.394090886361;5116.513931176532;5566.888662226774;5820.2724659418;6313.621182729051;6368.617882927039;3475.461303497962;4083.9795801020805;4086.8569600063856;4104.733192342488;4111.8692359600755;3543.486194501783;3924.4505769192338;3983.765032839829;4094.5700701426517;4182;4133.090720041586;4152.60550247732;4844.15227335215;4867.70793752376;4887.29134275528;5887.5272385598155;5981.700914954235;6018.01405536172;6038.516918646497;6061.121137435047;1233.1922590703105;1254.4229654359096;1361.4622224221378;1403.0459287684268;1405.4588983241526;743.9851202976018;756.3986630628664;831.5966756123275;855.7860534866284;857.4983634573845;4019.3569028955226;4597.793099310539;4635.768211589407;4660.324252983299;4665.300204969281;4357.869263922087;4533.730555444481;4723.976380118146;5120.18077107661;5120.897582048338;4167.270727622654;4299.849505267301;4492.887677808016;4601.861944141681;4615.953840461552;2140.2509121807243;2474.2824580871347;2638.445926355487;2667.5331816931957;2672.412069344741;4882.923758032488;4947.802087916515;5246.527812496894;5287.814926477632;5310.495502927216;4388.0785035142335;4551.749653769075;4931.4821943696115;5238.123788396559;5251.658642188246;4464.419625448736;4704.5765881070865;5242.7640756166065;5282.867928301823;5300.257963885059;4495.887602809956;4560.749158796298;4994.600431965507;5103.464136265638;5104.617153713412;4056.6551843093666;4596.494385617646;4773.403324584427;5044.949550504595;5079.898402031865;4397;4965.8013679452415;5119.87200319995;5238.659487133476;5278.759491519567;3045.964372113492;3172.7620428468417;3251.8293414370332;3480.147363895862;3544.7164226861273;4974.602031837517;5042.29407882904;5055.241713742821;5093;5796.971015144897;5151.407588127413;5573.018435137182;5794.5364370851075;5916.467517923407;5985.491233245223;5876.559258055749;5910.645361278337;5912.379200183918;5922.111683247547;5932.79235226765;5521.046240261601;5695.686737229492;5721.914171287517;5742.248614172718;5766.884662306814;5639.7180140993605;5687.971560142173;5886.411358864079;5902.704864756659;5919.826522301853;5171.741412929414;5410.675359478287;5795.059359635488;5796.275465566804;5805.912911306249 01:01:23 INFO - PROCESS | 1655 | |5;yui.html;700.4396482813751;703.8205257659296;743.3198623259717;771.6720393832624;837.1335667584052;14860.47988320409;15416.460423885166;15509.922450387732;15638.609034774136;15678.294476748546;12408.317542535156;14301.57095287143;14405.27973601321;14459.421623135062;14471.42114315426;841.5834162089759;849.371465115813;857.391252210931;858.159004175908;860.1613426908746;675.3584095109641;696.7108649910281;857.7341024282462;861.9094995025526;864.2826454043161;901.1664210605197;903.5978989349742;904.1365495951351;904.5206040798388;905.5834316214549;869.2003356911594;895.5611750242399;900.9504477253748;901.8241442918634;902.4585248850702;638.8977763557808;662.3939095727403;662.9502787290925;665.1751827733624;666.2770893580423;14873.256337183098;14875;14881.404743810235;14893.77659335111;14895.404183832634;14526;14614.853851461456;14681.70636587273;14812.851871481254;14893.106413615109;9474.114387098041;9714.90285097147;10464.215183861164;10761.30051546647;12684.80972785409;3528.5412896323314;3891.4941057662604;3900.966243945357;3915.3735402335487;3924.666403355718;105495.89008219869;111439.21401964934;119697.52104840781;123650.14524782136;123708.38145809303;11064.28082174672;11146.162984556075;11182.273152245078;11354;11718.23831450953;22435.32694019182;22796.316110516713;22904.969276382602;22938.770612293665;22981.655275170884;7968.880466793003;8077.919220807834;8186.836263274701;8247.298979586682;8280.089190189074;4469.262571675702;4549;4553.09290139114;4569.223232050559;4695.178343789823;3578.856845726194;3672.192117734094;3713.1830997180577;3714.7399682022537;3718.3678774608384;646.3536463536464;647.2168675902211;652.1489456259532;655.4035827397046;669.3707914560298;574.8447919061914;670.9184557000806;694.6943344928216;701.7228194863001;707.2927072927073;7599.924000760032;9128.402529557301;9241.168294853496;9590.376625519319;9638.662646807328;648.640004797342;650.6941737383422;670.7283550162192;671.8488340123433;683.4634811672912;4438.533953934855;4459.665525085632;4462.152191083684;4670.906581868344;4678.578927896506;103628;103950.92098157994;111560;148513;177579;94729;116506.41746791212;118449;129535.35232323778;143162;98754;101509.49245253726;107794;112780;114899;9555.42667439928;10145.137663298407;10215.489225538842;10252.58989640406;10274.383536987805;57543.712281438326;63150.68424657847;63937;65095.674521628986;65168;77820.8326875086;79015;92039.53980230323;92243;94040.05959940587;13098.345082746015;13185.60443186706;13388.330583470593;13634.181949083088;13640.045196836523;15033;15262.465813696468;15357;15769.842301576837;15778.447754328543;13742.519011834538;13861.722765544431;14498.565043048726;14574.417023318949;14645.048071875293;13812.930935345259;13974.930125349309;14063.226522541358;14317.856821431653;14694;13624.386902589606;13757.79363309571;13954.372053257424;14058.297085145907;14187.432502699776;10922.617708380169;11174.776504469703;11448.942755286504;11460.312381257152;11843.46704398287;8190.7952301192945;8440.20857416428;9775.266854986046;10615.36552066526;10899.673009809718 01:01:23 INFO - PROCESS | 1655 | __end_tp_report 01:01:23 INFO - PROCESS | 1655 | __start_cc_report 01:01:23 INFO - PROCESS | 1655 | _x_x_mozilla_cycle_collect,414 01:01:23 INFO - PROCESS | 1655 | __end_cc_report 01:01:23 INFO - PROCESS | 1655 | __startTimestamp1470816082987__endTimestamp 01:01:23 INFO - PROCESS | 1655 | 01:01:23 INFO - PROCESS | 1655 | ------- Summary: start ------- 01:01:23 INFO - PROCESS | 1655 | Number of tests: 6 01:01:23 INFO - PROCESS | 1655 | 01:01:23 INFO - PROCESS | 1655 | [#0] dojo.html Cycles:165 Average:5760.72 Median:6006.10 stddev:668.23 (11.1%) stddev-sans-first:642.15 01:01:23 INFO - PROCESS | 1655 | Values: 3315.1 3420.8 3430.9 3456.1 3463.3 5692.7 5758.7 5803.4 5894.2 5901.4 5759.1 5792.2 5828.0 5828.3 5914.5 5168.6 5270.7 5302.2 5329.6 5356.6 5322.1 5367.9 5403.6 5415.0 5442.5 4086.6 4385.0 5248.6 5296.3 5298.8 5197.5 5204.4 5225.4 5278.4 5313.8 5208.3 5228.2 5277.7 5314.6 5323.8 5698.1 5797.9 5830.7 5846.2 5868.9 6158.1 6191.7 6192.8 6250.6 6268.9 5402.6 6246.4 6255.3 6279.2 6287.6 5792.1 5831.9 5892.5 5917.5 5918.4 6311.4 6316.8 6332.1 6350.2 6354.9 6235.4 6252.5 6258.3 6260.6 6262.8 6138.6 6197.6 6201.0 6203.5 6296.9 6170.3 6251.8 6254.2 6272.5 6272.7 6172.4 6250.2 6253.7 6275.2 6283.1 4160.2 4272.2 4865.2 4956.8 5012.8 3884.8 4472.4 4489.0 4494.0 4558.8 5764.4 5860.6 5861.4 5874.9 5901.3 5883.6 6151.2 6172.4 6201.1 6230.7 5467.3 5855.5 5868.1 5882.6 5903.5 5482.9 5497.2 5501.4 5527.7 5531.6 6183.0 6256.4 6262.3 6312.5 6359.9 6234.8 6254.2 6257.5 6272.1 6277.6 6313.9 6352.4 6353.1 6359.8 6372.3 6103.9 6146.4 6152.1 6163.7 6246.0 6125.7 6224.6 6225.6 6241.9 6248.1 6174.9 6194.8 6204.0 6208.7 6208.8 6026.8 6030.0 6061.7 6107.6 6128.2 5765.1 5929.7 6006.1 6067.8 6088.0 6116.9 6163.7 6191.7 6194.2 6211.6 5128.2 5468.2 5997.7 6035.1 6042.3 01:01:23 INFO - PROCESS | 1655 | 01:01:23 INFO - PROCESS | 1655 | [#1] ext.html Cycles:180 Average:69081.03 Median:220108.90 stddev:154722.41 (70.3%) stddev-sans-first:155070.67 01:01:23 INFO - PROCESS | 1655 | Values: 462.6 475.4 517.4 540.9 550.3 38172.0 41551.0 41603.6 41700.6 41742.8 42569.4 42982.1 43001.8 43029.8 43042.0 9519.7 9608.8 9662.1 9723.8 9736.0 9613.9 9690.8 9695.3 9708.2 9726.2 9694.3 9726.7 9732.4 9735.0 9762.4 9643.9 9691.2 9702.3 9711.1 9746.3 9511.1 9512.5 9565.4 9600.5 9609.1 33169.0 40482.4 40735.4 40812.4 40820.4 2640.6 3217.9 3294.3 3494.9 3496.9 29193.1 29423.0 30726.2 30853.5 31330.8 3072.5 3103.5 3110.4 3199.6 3252.6 400405.0 454619.0 455759.0 456035.0 458370.0 33734.7 34001.8 34042.7 34065.8 34149.8 32766.0 33799.5 34738.0 35371.5 36246.0 16722.7 16919.0 16937.4 16952.0 17230.2 12514.6 12607.0 12607.2 12639.9 12685.0 17530.7 18350.8 19439.6 19481.5 19526.9 6404.5 6964.0 7721.6 7777.7 7906.0 803.7 901.4 937.4 992.0 1066.0 24200.0 30542.8 30562.8 30637.7 30735.7 869.9 1006.8 1054.1 1076.8 1089.8 15465.6 15774.7 15805.5 15919.3 15978.4 659885.0 663879.0 664686.0 664826.0 664827.0 52349.5 59742.8 60418.1 60518.0 60597.7 1220.8 1361.6 1376.1 1392.6 1394.0 24976.9 29184.6 29694.0 30449.8 30508.4 51908.0 51992.0 52062.7 52147.0 52223.2 587567.1 588880.0 608770.0 610985.9 613055.0 27279.2 27420.0 27743.6 27797.6 27906.4 48671.8 48745.8 48787.0 49701.8 50379.5 39812.8 40196.6 40642.0 41327.8 41532.6 35235.1 37903.0 39490.0 40102.2 40643.4 32893.8 38089.4 38458.0 38869.2 39380.6 34365.7 35010.0 35662.1 35732.0 35734.0 25544.9 26038.9 26106.0 26331.5 26729.3 01:01:23 INFO - PROCESS | 1655 | 01:01:23 INFO - PROCESS | 1655 | [#2] jquery.html Cycles:180 Average:34617.59 Median:1429.43 stddev:97204.68 (6800.3%) stddev-sans-first:97443.34 01:01:23 INFO - PROCESS | 1655 | Values: 366.3 373.1 377.8 383.6 386.8 19213.7 20805.6 21388.9 21499.6 21549.6 16824.7 17934.3 20352.5 20421.5 20539.0 5812.4 5843.9 5953.7 5995.7 6039.3 4108.4 5824.9 5925.8 5968.3 5987.6 6205.7 6463.9 6524.2 6585.7 6596.4 6255.2 6557.1 6606.9 6616.3 6619.0 5815.2 5833.7 5891.0 5893.9 5976.3 12884.3 13037.4 13111.8 13112.8 21580.9 2314.7 2335.8 2344.0 2419.6 2492.5 9671.1 9714.2 9730.5 10164.4 10173.6 1892.2 1909.1 1923.2 1954.6 1986.2 126745.7 129286.4 132840.0 133945.0 137165.0 10113.6 10864.7 11303.3 11651.5 11669.2 14073.4 14372.9 14431.3 14449.1 14498.3 8345.6 8505.8 8545.8 8656.5 8671.5 8442.8 8458.0 8463.5 8474.8 8665.2 4414.7 4509.0 4513.5 4519.6 4555.9 1588.3 1894.9 1954.5 1990.4 2001.4 862.7 874.6 904.8 974.5 984.2 19820.0 20154.4 20233.4 20764.9 21140.9 796.6 918.3 930.8 945.6 958.7 10762.8 11268.8 11356.0 11395.3 11409.4 548191.0 568827.0 584194.0 594358.0 596407.0 121939.0 124987.4 127029.0 127935.0 127970.0 847.6 938.8 950.6 956.1 1014.5 16009.9 16589.6 19762.7 19977.8 20069.6 38240.8 47773.3 55267.4 56945.0 58857.0 80977.0 83650.2 84081.0 85172.6 85204.0 8073.6 8101.9 8236.9 8441.1 8453.0 9273.5 11273.0 12062.8 13169.0 13465.6 10337.0 11187.4 11531.5 11541.4 11581.7 10269.5 11141.5 11307.3 11337.3 11541.9 11552.0 11798.4 11885.4 11938.6 12029.6 7197.6 8026.2 8055.5 8310.8 8536.3 8353.4 10535.8 11236.3 11474.4 11676.5 01:01:23 INFO - PROCESS | 1655 | 01:01:23 INFO - PROCESS | 1655 | [#3] mootools.html Cycles:180 Average:5609.56 Median:4969.30 stddev:3135.59 (63.1%) stddev-sans-first:3129.18 01:01:23 INFO - PROCESS | 1655 | Values: 1500.5 1528.9 1715.4 1796.6 1843.2 7847.6 8278.8 8305.8 8811.4 8842.5 8375.6 8526.2 8597.7 8608.6 8616.1 2287.5 2324.2 2325.6 2332.9 2344.5 2303.9 2329.9 2354.3 2360.0 2366.1 2338.8 2343.4 2345.9 2348.0 2351.6 2276.6 2287.0 2327.8 2332.2 2340.0 2319.7 2320.8 2321.2 2321.9 2324.6 8585.9 8623.3 8624.5 8644.2 8659.7 5075.5 5305.1 5308.8 5312.3 5327.0 3400.5 3444.5 3584.2 3585.9 3614.3 1040.0 1068.4 1078.2 1083.5 1092.6 11094.1 11107.4 11167.8 11252.2 11295.9 4480.6 4524.0 4710.2 4710.2 4721.5 8815.0 9655.2 9765.2 9842.9 9898.5 5273.7 5298.8 5301.3 5304.6 5310.2 4357.2 4694.6 4808.4 4847.6 4855.8 3838.3 3941.3 3944.8 3970.7 4051.0 1264.3 1281.9 1288.7 1289.5 1293.5 802.8 917.9 922.8 937.5 964.7 5494.4 5584.2 5703.0 5876.1 5951.2 425.9 432.7 440.7 441.0 443.5 3488.4 3648.4 3888.9 3977.4 4025.5 10140.1 10485.1 10547.5 10557.3 10567.8 10508.2 10509.6 10511.6 10560.4 10563.5 7721.8 7846.8 8048.2 8066.8 8081.5 5720.5 5898.1 5924.9 5960.6 5977.3 9469.8 9834.0 9868.7 9895.7 9901.0 9841.2 9880.9 9922.3 9937.6 10017.4 6908.4 7297.1 7420.4 7500.6 7528.8 8317.4 8395.2 8402.7 8424.5 8441.5 7287.6 7389.0 7440.4 7462.0 7544.4 7238.1 7270.7 7283.1 7363.8 7374.0 6792.8 6830.5 6884.9 6894.2 6908.1 4428.8 4492.8 4808.9 4940.4 4998.2 4910.3 5003.6 5063.4 5096.6 5106.7 01:01:23 INFO - PROCESS | 1655 | 01:01:23 INFO - PROCESS | 1655 | [#4] prototype.html Cycles:180 Average:4456.22 Median:4859.47 stddev:1376.57 (28.3%) stddev-sans-first:1344.36 01:01:23 INFO - PROCESS | 1655 | Values: 285.1 295.5 309.8 309.9 312.8 4553.4 5220.7 5386.7 5610.9 5643.4 5528.8 5575.7 5583.4 5599.3 5611.3 4239.7 4253.7 4259.9 4275.2 4278.8 3748.8 4153.3 4229.1 4254.4 4310.8 3920.7 4207.5 4219.1 4222.0 4228.1 4216.4 4235.3 4251.1 4277.4 4325.4 3540.8 3674.1 3681.2 3691.4 3709.0 4685.2 5341.7 5358.0 5385.2 5464.5 4090.5 4314.6 4851.2 4903.4 4919.2 4982.0 5290.0 5561.4 5958.9 6031.6 3399.7 3988.8 4008.1 4019.7 4039.4 5116.5 5566.9 5820.3 6313.6 6368.6 3475.5 4084.0 4086.9 4104.7 4111.9 3543.5 3924.5 3983.8 4094.6 4182.0 4133.1 4152.6 4844.2 4867.7 4887.3 5887.5 5981.7 6018.0 6038.5 6061.1 1233.2 1254.4 1361.5 1403.0 1405.5 744.0 756.4 831.6 855.8 857.5 4019.4 4597.8 4635.8 4660.3 4665.3 4357.9 4533.7 4724.0 5120.2 5120.9 4167.3 4299.8 4492.9 4601.9 4616.0 2140.3 2474.3 2638.4 2667.5 2672.4 4882.9 4947.8 5246.5 5287.8 5310.5 4388.1 4551.7 4931.5 5238.1 5251.7 4464.4 4704.6 5242.8 5282.9 5300.3 4495.9 4560.7 4994.6 5103.5 5104.6 4056.7 4596.5 4773.4 5044.9 5079.9 4397.0 4965.8 5119.9 5238.7 5278.8 3046.0 3172.8 3251.8 3480.1 3544.7 4974.6 5042.3 5055.2 5093.0 5797.0 5151.4 5573.0 5794.5 5916.5 5985.5 5876.6 5910.6 5912.4 5922.1 5932.8 5521.0 5695.7 5721.9 5742.2 5766.9 5639.7 5688.0 5886.4 5902.7 5919.8 5171.7 5410.7 5795.1 5796.3 5805.9 01:01:23 INFO - PROCESS | 1655 | 01:01:23 INFO - PROCESS | 1655 | [#5] yui.html Cycles:180 Average:24169.52 Median:3713.96 stddev:37842.49 (1018.9%) stddev-sans-first:37907.62 01:01:23 INFO - PROCESS | 1655 | Values: 700.4 703.8 743.3 771.7 837.1 14860.5 15416.5 15509.9 15638.6 15678.3 12408.3 14301.6 14405.3 14459.4 14471.4 841.6 849.4 857.4 858.2 860.2 675.4 696.7 857.7 861.9 864.3 901.2 903.6 904.1 904.5 905.6 869.2 895.6 901.0 901.8 902.5 638.9 662.4 663.0 665.2 666.3 14873.3 14875.0 14881.4 14893.8 14895.4 14526.0 14614.9 14681.7 14812.9 14893.1 9474.1 9714.9 10464.2 10761.3 12684.8 3528.5 3891.5 3901.0 3915.4 3924.7 105495.9 111439.2 119697.5 123650.1 123708.4 11064.3 11146.2 11182.3 11354.0 11718.2 22435.3 22796.3 22905.0 22938.8 22981.7 7968.9 8077.9 8186.8 8247.3 8280.1 4469.3 4549.0 4553.1 4569.2 4695.2 3578.9 3672.2 3713.2 3714.7 3718.4 646.4 647.2 652.1 655.4 669.4 574.8 670.9 694.7 701.7 707.3 7599.9 9128.4 9241.2 9590.4 9638.7 648.6 650.7 670.7 671.8 683.5 4438.5 4459.7 4462.2 4670.9 4678.6 103628.0 103950.9 111560.0 148513.0 177579.0 94729.0 116506.4 118449.0 129535.4 143162.0 98754.0 101509.5 107794.0 112780.0 114899.0 9555.4 10145.1 10215.5 10252.6 10274.4 57543.7 63150.7 63937.0 65095.7 65168.0 77820.8 79015.0 92039.5 92243.0 94040.1 13098.3 13185.6 13388.3 13634.2 13640.0 15033.0 15262.5 15357.0 15769.8 15778.4 13742.5 13861.7 14498.6 14574.4 14645.0 13812.9 13974.9 14063.2 14317.9 14694.0 13624.4 13757.8 13954.4 14058.3 14187.4 10922.6 11174.8 11448.9 11460.3 11843.5 8190.8 8440.2 9775.3 10615.4 10899.7 01:01:23 INFO - PROCESS | 1655 | -------- Summary: end -------- 01:01:23 INFO - PROCESS | 1655 | 01:01:23 INFO - TEST-INFO | 1655: exit 0 01:01:23 INFO - TEST-OK | dromaeo_css | took 1113829ms 01:01:23 INFO - TEST-START | kraken 01:01:23 INFO - operating with platform_type : mac_ 01:01:23 INFO - Initialising browser for kraken test... 01:01:23 INFO - TEST-INFO | started process 1666 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/tmpnSgRvB/profile http://localhost:49266/getInfo.html) 01:01:26 INFO - PROCESS | 1666 | __metrics Screen width/height:1600/1200 01:01:26 INFO - PROCESS | 1666 | colorDepth:24 01:01:26 INFO - PROCESS | 1666 | Browser inner width/height: 1024/689 01:01:26 INFO - PROCESS | 1666 | __metrics 01:01:26 ERROR - PROCESS | 1666 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 01:01:27 INFO - TEST-INFO | 1666: exit 0 01:01:27 INFO - Browser initialized. 01:01:27 INFO - Running cycle 1/1 for kraken test... 01:01:27 INFO - TEST-INFO | started process 1668 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/tmpnSgRvB/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:01:39 INFO - PROCESS | 1668 | RSS: Main: 254492672 01:01:39 INFO - PROCESS | 1668 | 01:01:42 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49266/tests/kraken/driver.html?testName=audio-beat-detection) 01:01:43 INFO - PROCESS | 1668 | RSS: Main: 267464704 01:01:43 INFO - PROCESS | 1668 | 01:01:45 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49266/tests/kraken/driver.html?testName=audio-dft) 01:01:46 INFO - PROCESS | 1668 | RSS: Main: 276078592 01:01:46 INFO - PROCESS | 1668 | 01:01:49 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49266/tests/kraken/driver.html?testName=audio-fft) 01:01:50 INFO - PROCESS | 1668 | RSS: Main: 279126016 01:01:50 INFO - PROCESS | 1668 | 01:01:52 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49266/tests/kraken/driver.html?testName=audio-oscillator) 01:01:53 INFO - PROCESS | 1668 | RSS: Main: 281313280 01:01:53 INFO - PROCESS | 1668 | 01:01:55 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49266/tests/kraken/driver.html?testName=imaging-gaussian-blur) 01:01:55 INFO - PROCESS | 1668 | RSS: Main: 282062848 01:01:55 INFO - PROCESS | 1668 | 01:01:58 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49266/tests/kraken/driver.html?testName=imaging-darkroom) 01:01:59 INFO - PROCESS | 1668 | RSS: Main: 282079232 01:01:59 INFO - PROCESS | 1668 | 01:02:02 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49266/tests/kraken/driver.html?testName=imaging-desaturate) 01:02:03 INFO - PROCESS | 1668 | RSS: Main: 282320896 01:02:03 INFO - PROCESS | 1668 | 01:02:05 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49266/tests/kraken/driver.html?testName=json-parse-financial) 01:02:06 INFO - PROCESS | 1668 | RSS: Main: 282378240 01:02:06 INFO - PROCESS | 1668 | 01:02:08 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49266/tests/kraken/driver.html?testName=json-stringify-tinderbox) 01:02:08 INFO - PROCESS | 1668 | RSS: Main: 282492928 01:02:08 INFO - PROCESS | 1668 | 01:02:10 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-aes) 01:02:11 INFO - PROCESS | 1668 | RSS: Main: 282804224 01:02:11 INFO - PROCESS | 1668 | 01:02:13 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-ccm) 01:02:14 INFO - PROCESS | 1668 | RSS: Main: 282828800 01:02:14 INFO - PROCESS | 1668 | 01:02:17 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 01:02:17 INFO - PROCESS | 1668 | RSS: Main: 282451968 01:02:17 INFO - PROCESS | 1668 | 01:02:20 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 01:02:21 INFO - PROCESS | 1668 | RSS: Main: 283013120 01:02:21 INFO - PROCESS | 1668 | 01:02:23 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49266/tests/kraken/driver.html?testName=ai-astar) 01:02:23 INFO - PROCESS | 1668 | RSS: Main: 283721728 01:02:23 INFO - PROCESS | 1668 | 01:02:23 INFO - PROCESS | 1668 | __start_tp_report 01:02:23 INFO - PROCESS | 1668 | _x_x_mozilla_page_load 01:02:23 INFO - PROCESS | 1668 | _x_x_mozilla_page_load_details 01:02:23 INFO - PROCESS | 1668 | |i|pagename|runs| 01:02:23 INFO - PROCESS | 1668 | |0;ai-astar;102;131;114;169;143;117;113;164;118;116 01:02:23 INFO - PROCESS | 1668 | |1;audio-beat-detection;169;113;130;154;130;162;116;110;188;135 01:02:23 INFO - PROCESS | 1668 | |2;audio-dft;203;215;215;197;198;195;197;200;208;183 01:02:23 INFO - PROCESS | 1668 | |3;audio-fft;74;83;76;144;62;59;61;56;160;84 01:02:23 INFO - PROCESS | 1668 | |4;audio-oscillator;69;71;128;71;73;84;115;69;78;114 01:02:23 INFO - PROCESS | 1668 | |5;imaging-gaussian-blur;91;98;132;73;130;125;132;126;92;74 01:02:23 INFO - PROCESS | 1668 | |6;imaging-darkroom;147;97;97;103;97;96;97;97;104;99 01:02:23 INFO - PROCESS | 1668 | |7;imaging-desaturate;93;94;91;89;93;91;91;92;92;91 01:02:23 INFO - PROCESS | 1668 | |8;json-parse-financial;49;49;58;73;76;56;56;56;57;56 01:02:23 INFO - PROCESS | 1668 | |9;json-stringify-tinderbox;69;71;74;69;77;70;83;71;71;71 01:02:23 INFO - PROCESS | 1668 | |10;stanford-crypto-aes;85;91;94;100;85;87;87;85;88;83 01:02:23 INFO - PROCESS | 1668 | |11;stanford-crypto-ccm;143;142;140;141;143;143;140;140;156;144 01:02:23 INFO - PROCESS | 1668 | |12;stanford-crypto-pbkdf2;174;172;173;174;207;235;174;172;172;176 01:02:23 INFO - PROCESS | 1668 | |13;stanford-crypto-sha256-iterative;69;70;66;74;88;91;84;69;64;91 01:02:23 INFO - PROCESS | 1668 | __end_tp_report 01:02:23 INFO - PROCESS | 1668 | __start_cc_report 01:02:23 INFO - PROCESS | 1668 | _x_x_mozilla_cycle_collect,1056 01:02:23 INFO - PROCESS | 1668 | __end_cc_report 01:02:23 INFO - PROCESS | 1668 | __startTimestamp1470816143374__endTimestamp 01:02:23 INFO - PROCESS | 1668 | 01:02:23 INFO - PROCESS | 1668 | ------- Summary: start ------- 01:02:23 INFO - PROCESS | 1668 | Number of tests: 14 01:02:23 INFO - PROCESS | 1668 | 01:02:23 INFO - PROCESS | 1668 | [#0] ai-astar Cycles:10 Average:128.70 Median:124.50 stddev:22.77 (18.3%) stddev-sans-first:22.01 01:02:23 INFO - PROCESS | 1668 | Values: 102.0 131.0 114.0 169.0 143.0 117.0 113.0 164.0 118.0 116.0 01:02:23 INFO - PROCESS | 1668 | 01:02:23 INFO - PROCESS | 1668 | [#1] audio-beat-detection Cycles:10 Average:140.70 Median:144.50 stddev:26.35 (18.2%) stddev-sans-first:25.88 01:02:23 INFO - PROCESS | 1668 | Values: 169.0 113.0 130.0 154.0 130.0 162.0 116.0 110.0 188.0 135.0 01:02:23 INFO - PROCESS | 1668 | 01:02:23 INFO - PROCESS | 1668 | [#2] audio-dft Cycles:10 Average:201.10 Median:201.50 stddev:9.70 (4.8%) stddev-sans-first:10.26 01:02:23 INFO - PROCESS | 1668 | Values: 203.0 215.0 215.0 197.0 198.0 195.0 197.0 200.0 208.0 183.0 01:02:23 INFO - PROCESS | 1668 | 01:02:23 INFO - PROCESS | 1668 | [#3] audio-fft Cycles:10 Average:85.90 Median:68.00 stddev:36.40 (53.5%) stddev-sans-first:38.36 01:02:23 INFO - PROCESS | 1668 | Values: 74.0 83.0 76.0 144.0 62.0 59.0 61.0 56.0 160.0 84.0 01:02:23 INFO - PROCESS | 1668 | 01:02:23 INFO - PROCESS | 1668 | [#4] audio-oscillator Cycles:10 Average:87.20 Median:71.00 stddev:22.70 (32.0%) stddev-sans-first:23.11 01:02:23 INFO - PROCESS | 1668 | Values: 69.0 71.0 128.0 71.0 73.0 84.0 115.0 69.0 78.0 114.0 01:02:23 INFO - PROCESS | 1668 | 01:02:23 INFO - PROCESS | 1668 | [#5] imaging-gaussian-blur Cycles:10 Average:107.30 Median:73.50 stddev:24.20 (32.9%) stddev-sans-first:24.94 01:02:23 INFO - PROCESS | 1668 | Values: 91.0 98.0 132.0 73.0 130.0 125.0 132.0 126.0 92.0 74.0 01:02:23 INFO - PROCESS | 1668 | 01:02:23 INFO - PROCESS | 1668 | [#6] imaging-darkroom Cycles:10 Average:103.40 Median:97.00 stddev:15.56 (16.0%) stddev-sans-first:2.92 01:02:23 INFO - PROCESS | 1668 | Values: 147.0 97.0 97.0 103.0 97.0 96.0 97.0 97.0 104.0 99.0 01:02:23 INFO - PROCESS | 1668 | 01:02:23 INFO - PROCESS | 1668 | [#7] imaging-desaturate Cycles:10 Average:91.70 Median:92.00 stddev:1.42 (1.5%) stddev-sans-first:1.42 01:02:23 INFO - PROCESS | 1668 | Values: 93.0 94.0 91.0 89.0 93.0 91.0 91.0 92.0 92.0 91.0 01:02:23 INFO - PROCESS | 1668 | 01:02:23 INFO - PROCESS | 1668 | [#8] json-parse-financial Cycles:10 Average:58.60 Median:56.50 stddev:8.97 (15.9%) stddev-sans-first:8.82 01:02:23 INFO - PROCESS | 1668 | Values: 49.0 49.0 58.0 73.0 76.0 56.0 56.0 56.0 57.0 56.0 01:02:23 INFO - PROCESS | 1668 | 01:02:23 INFO - PROCESS | 1668 | [#9] json-stringify-tinderbox Cycles:10 Average:72.60 Median:71.00 stddev:4.38 (6.2%) stddev-sans-first:4.44 01:02:23 INFO - PROCESS | 1668 | Values: 69.0 71.0 74.0 69.0 77.0 70.0 83.0 71.0 71.0 71.0 01:02:23 INFO - PROCESS | 1668 | 01:02:23 INFO - PROCESS | 1668 | [#10] stanford-crypto-aes Cycles:10 Average:88.50 Median:87.00 stddev:5.17 (5.9%) stddev-sans-first:5.33 01:02:23 INFO - PROCESS | 1668 | Values: 85.0 91.0 94.0 100.0 85.0 87.0 87.0 85.0 88.0 83.0 01:02:23 INFO - PROCESS | 1668 | 01:02:23 INFO - PROCESS | 1668 | [#11] stanford-crypto-ccm Cycles:10 Average:143.20 Median:143.00 stddev:4.73 (3.3%) stddev-sans-first:5.02 01:02:23 INFO - PROCESS | 1668 | Values: 143.0 142.0 140.0 141.0 143.0 143.0 140.0 140.0 156.0 144.0 01:02:23 INFO - PROCESS | 1668 | 01:02:23 INFO - PROCESS | 1668 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:182.90 Median:174.00 stddev:21.17 (12.2%) stddev-sans-first:22.21 01:02:23 INFO - PROCESS | 1668 | Values: 174.0 172.0 173.0 174.0 207.0 235.0 174.0 172.0 172.0 176.0 01:02:23 INFO - PROCESS | 1668 | 01:02:23 INFO - PROCESS | 1668 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:76.60 Median:79.00 stddev:10.73 (13.6%) stddev-sans-first:11.02 01:02:23 INFO - PROCESS | 1668 | Values: 69.0 70.0 66.0 74.0 88.0 91.0 84.0 69.0 64.0 91.0 01:02:23 INFO - PROCESS | 1668 | -------- Summary: end -------- 01:02:23 INFO - PROCESS | 1668 | 01:02:24 INFO - TEST-INFO | 1668: exit 0 01:02:24 INFO - TEST-OK | kraken | took 60584ms 01:02:24 INFO - SUITE-END | took 1174s 01:02:24 INFO - Completed test suite (00:19:34) 01:02:24 INFO - javascript benchmark 01:02:24 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7262.569847481683, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3315.0552092653616, 3420.7605467617277, 3430.8970730878073, 3456.1359660084977, 3463.290025544763, 5692.743826527806, 5758.712064396774, 5803.419658034194, 5894.17481552583, 5901.439363260494, 5759.136129580565, 5792.160136780164, 5827.970860145704, 5828.2714660667525, 5914.526837852972, 5168.586513078944, 5270.710110943896, 5302.2311764794085, 5329.573634109262, 5356.625036247445, 5322.068637988336, 5367.946320536784, 5403.594730395216, 5414.972925135388, 5442.455754424545, 4086.6117718816663, 4385.0, 5248.632595718302, 5296.25852380667, 5298.788048478056, 5197.532222100029, 5204.375474943031, 5225.399079105913, 5278.366596008465, 5313.787448502056, 5208.322918020633, 5228.215767634847, 5277.70972596507, 5314.5748340132695, 5323.787048518055, 5698.116791897262, 5797.8550536236935, 5830.650160990312, 5846.181534585162, 5868.882622347529, 6158.137860699506, 6191.721372538202, 6192.752289908398, 6250.624962502265, 6268.905966410462, 5402.621816472849, 6246.437820596168, 6255.311915689271, 6279.215098112736, 6287.559870809046, 5792.073268277056, 5831.883362332772, 5892.499137573354, 5917.52659787216, 5918.408159184133, 6311.400416960381, 6316.810495685137, 6332.0818481320875, 6350.237971443364, 6354.872902541923, 6235.376462353728, 6252.531060170414, 6258.311585725566, 6260.624362538262, 6262.812115636538, 6138.572327483795, 6197.628142311476, 6200.968995154995, 6203.534734894901, 6296.937030629635, 6170.259568851677, 6251.812445626639, 6254.155688981929, 6272.529560282997, 6272.686365681698, 6172.4136207060255, 6250.249970003538, 6253.7185826637915, 6275.246970363585, 6283.120363149163, 4160.209560183555, 4272.166927449118, 4865.245886887538, 4956.801727930914, 5012.8496145115705, 3884.8446062157764, 4472.39622650938, 4489.0, 4493.977530112328, 4558.772061396917, 5764.394738552475, 5860.648361098262, 5861.413858614104, 5874.853128671732, 5901.3213480450295, 5883.646981181143, 6151.169592105009, 6172.444479996732, 6201.069839524108, 6230.688465576703, 5467.343918729778, 5855.473007429352, 5868.119782032644, 5882.588218824641, 5903.468687818117, 5482.945170548243, 5497.230387745719, 5501.394846566875, 5527.695976721238, 5531.612787104864, 6182.969085154456, 6256.436920677161, 6262.342454042442, 6312.4634406076, 6359.9364006360265, 6234.812955611339, 6254.186955695913, 6257.499400047895, 6272.090546870587, 6277.623342599459, 6313.905291420724, 6352.428281454691, 6353.142325786144, 6359.841003974938, 6372.330905255067, 6103.85289575482, 6146.4468197860615, 6152.107944348134, 6163.722632481638, 6245.96877015612, 6125.724342404514, 6224.564280500322, 6225.595336303126, 6241.875162496815, 6248.0940263660605, 6174.938250617616, 6194.783182588588, 6204.038374052029, 6208.658523781235, 6208.751649934133, 6026.7589296429405, 6030.03519436888, 6061.6666083365835, 6107.572469927062, 6128.233970753656, 5765.106408506688, 5929.733162007634, 6006.099085137264, 6067.757289708362, 6088.0, 6116.8559221291825, 6163.660998645118, 6191.659458729813, 6194.163787888758, 6211.596246243979, 5128.230765385222, 5468.207109968953, 5997.670128142994, 6035.094735789667, 6042.335343112166], "value": 5717.454742996596, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [462.6137175458492, 475.44135640622284, 517.3636427194548, 540.9080456322426, 550.3011175806723, 38172.04569885751, 41551.0, 41603.58396416035, 41700.58299417005, 41742.791286043604, 42569.36145957813, 42982.14035719284, 43001.78499107508, 43029.784851075776, 43042.0, 9519.666811661611, 9608.759781005461, 9662.130408263254, 9723.756906077333, 9736.0, 9613.903860961405, 9690.75773105671, 9695.321327507078, 9708.17480514157, 9726.17327527161, 9694.272929530314, 9726.65956691516, 9732.41605503672, 9734.951325243364, 9762.36544624597, 9643.855342169873, 9691.224702023821, 9702.320837541305, 9711.125998660083, 9746.317757756924, 9511.14399704023, 9512.47681377524, 9565.37825041377, 9600.471974041495, 9609.087136722, 33169.0, 40482.39276410856, 40735.38896916519, 40812.38781418281, 40820.38769418461, 2640.577507598775, 3217.8551965161623, 3294.2917272786226, 3494.947575786365, 3496.860125594973, 29193.124206273846, 29422.970196043036, 30726.231844204074, 30853.537196942063, 31330.796212204034, 3072.477678794588, 3103.534469829521, 3110.440120778259, 3199.6160460744627, 3252.642209356969, 400405.0, 454619.0, 455758.9999999967, 456035.0, 458370.0, 33734.65061397566, 34001.82999085038, 34042.659573404446, 34065.82967085149, 34149.82925085408, 32766.017019489453, 33799.493007604906, 34738.0, 35371.469427958604, 36246.0, 16722.74915876263, 16919.0, 16937.407190748265, 16952.0, 17230.224639891236, 12514.624561263177, 12606.991440684724, 12607.243565386107, 12639.93680031594, 12685.048621353251, 17530.737038944426, 18350.81649183518, 19439.611207775764, 19481.512962175777, 19526.90236548808, 6404.455621272244, 6963.965180174168, 7721.613919304013, 7777.650005749755, 7905.960470197612, 803.7106641609016, 901.4366021236727, 937.3719607862748, 992.0426788149471, 1066.0405634928627, 24200.0, 30542.847285763874, 30562.84718576393, 30637.69362306393, 30735.692643073282, 869.9304055675531, 1006.8338724110587, 1054.0513537815873, 1076.8438576406377, 1089.7874914391775, 15465.613359666098, 15774.684506310039, 15805.525834224762, 15919.293670306408, 15978.360865565479, 659885.0, 663879.0, 664686.0, 664826.0, 664827.0, 52349.47650523446, 59742.80514389775, 60418.09372859323, 60518.0, 60597.69701151466, 1220.7741567809805, 1361.6051345110004, 1376.0986553807272, 1392.554382597559, 1393.9651508712363, 24976.875115624305, 29184.56223156612, 29694.0, 30449.847750761106, 30508.389832203677, 51908.0, 51991.96016079733, 52062.73968630284, 52147.0, 52223.21665174949, 587567.0621646864, 588880.0, 608770.0, 610985.8901410929, 613055.0, 27279.181624551296, 27420.0, 27743.58384624192, 27797.583036254877, 27906.441871162868, 48671.75664121657, 48745.756271218415, 48787.0, 49701.751491242314, 50379.49620503748, 39812.80093599513, 40196.598034020455, 40641.983950401474, 41327.79336103421, 41532.58467415287, 35235.119122021126, 37903.0, 39490.0, 40102.19795604013, 40643.390349144196, 32893.835530822194, 38089.42865856959, 38458.0, 38869.2226155481, 39380.606193937696, 34365.656343437244, 35010.0, 35662.10844728799, 35732.0, 35734.0, 25544.872275638503, 26038.869805651608, 26106.0, 26331.473370532865, 26729.269473147928], "value": 19385.984110490564, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [366.34058694350165, 373.1399125016837, 377.8205352457583, 383.6106352052669, 386.8007975892414, 19213.71179432308, 20805.583888322242, 21388.89305553472, 21499.570008599858, 21549.56900861982, 16824.74762878558, 17934.282628694837, 20352.491187720316, 20421.48946276344, 20539.0, 5812.418758124196, 5843.912341314884, 5953.70231488426, 5995.6702381369005, 6039.33567307598, 4108.404281379198, 5824.912626310609, 5925.822225333225, 5968.253968253968, 5987.580869339148, 6205.720742566573, 6463.870722585569, 6524.217093948733, 6585.703643336037, 6596.406323430891, 6255.186825712651, 6557.082008518812, 6606.867862642768, 6616.27221005689, 6618.966905165492, 5815.244018277639, 5833.708314584296, 5890.97054514729, 5893.941060589425, 5976.342602313742, 12884.291363974977, 13037.413316400785, 13111.803322950163, 13112.819846213886, 21580.920953952398, 2314.6528020796845, 2335.801456876168, 2343.9765602343928, 2419.552382809186, 2492.513959777844, 9671.129598336112, 9714.22286217101, 9730.513474326255, 10164.390136591754, 10173.59305627774, 1892.1654230830356, 1909.1313452379134, 1923.2210954563425, 1954.5602239496, 1986.2055177928944, 126745.73254267524, 129286.3535682325, 132840.0, 133945.0, 137165.0, 10113.64602238918, 10864.67405977806, 11303.321800691985, 11651.47568359409, 11669.241499302518, 14073.366698498592, 14372.928135359256, 14431.278436078153, 14449.060811047248, 14498.347574359179, 8345.624446899905, 8505.787355316043, 8545.829083418297, 8656.485115104957, 8671.479711217347, 8442.788930276669, 8458.0, 8463.534505602127, 8474.830503389898, 8665.220130188314, 4414.713043652217, 4508.977455112704, 4513.5486451355255, 4519.593236608721, 4555.908881822411, 1588.3090855477903, 1894.8768330058501, 1954.540682939508, 1990.3877858934309, 2001.4496013596086, 862.7454900804278, 874.5627186406797, 904.8009437923646, 974.5273542331963, 984.1634610581092, 19820.008999549966, 20154.39536813898, 20233.392998210078, 20764.896175519025, 21140.894295528426, 796.6494742313364, 918.2883265469314, 930.8324501589778, 945.6122989574379, 958.6932181701928, 10762.78474430507, 11268.774624507463, 11356.0, 11395.316281023164, 11409.372484513266, 548191.0, 568827.0, 584194.0, 594358.0, 596407.0, 121939.0, 124987.3750631241, 127029.0, 127935.0, 127970.0, 847.6185716427509, 938.8310104181313, 950.5769932380163, 956.1108169402522, 1014.5079636376352, 16009.919950400174, 16589.58526036859, 19762.70355944633, 19977.800221997593, 20069.59860802805, 38240.80879595695, 47773.28340074832, 55267.447325527835, 56945.0, 58857.0, 80977.0, 83650.16349836424, 84081.0, 85172.57413712892, 85204.0, 8073.5963201838495, 8101.918980810116, 8236.917630823855, 8441.071482136836, 8452.957735211285, 9273.489958052372, 11273.041791447491, 12062.819057713965, 13169.0, 13465.596032119052, 10337.0, 11187.384693841917, 11531.538738450703, 11541.36522491271, 11581.652550423501, 10269.486525673836, 11141.521664622129, 11307.321560706385, 11337.26307790024, 11541.942290288494, 11552.0, 11798.410079496163, 11885.405729713308, 11938.64184074479, 12029.578964736193, 7197.640117994184, 8026.237507436784, 8055.476394034369, 8310.792230194053, 8536.31709463229, 8353.415260931677, 10535.841962370418, 11236.325820450798, 11474.4262786862, 11676.532938682358], "value": 9472.33741818795, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1500.4673340963961, 1528.9082655040697, 1715.4339068107527, 1796.58678503944, 1843.1797849956765, 7847.646855891484, 8278.834423311546, 8305.792355191123, 8811.427257228284, 8842.469451832887, 8375.581220938944, 8526.190011948871, 8597.742067737978, 8608.61261243244, 8616.095309992439, 2287.5196208796133, 2324.2097686786487, 2325.5581439526436, 2332.93001209964, 2344.460774021976, 2303.873286969216, 2329.860208387494, 2354.2701762453694, 2359.95280094398, 2366.053578568578, 2338.8362814602983, 2343.437574982009, 2345.9178928737497, 2348.0138341896445, 2351.5884720173985, 2276.601594720934, 2286.9542609147807, 2327.767223277676, 2332.2303639798824, 2340.0288880114817, 2319.663648770919, 2320.756320586331, 2321.1759825261956, 2321.8839058047197, 2324.6164382876805, 8585.871211931826, 8623.310135189233, 8624.482531048157, 8644.178803013703, 8659.696910608161, 5075.5178258065425, 5305.124654432014, 5308.761105750251, 5312.2828418163435, 5326.973365133188, 3400.4899265110184, 3444.500547420635, 3584.175639602906, 3585.910352241189, 3614.2952124335766, 1039.9636012739593, 1068.3910171202417, 1078.1805827571102, 1083.5178345636195, 1092.6012005617893, 11094.1124710023, 11107.389093599848, 11167.776644467065, 11252.15608829341, 11295.943520282346, 4480.574345437179, 4524.0, 4710.152172608963, 4710.246360582359, 4721.480637129982, 8814.955925220333, 9655.22758179344, 9765.16996055329, 9842.852357214648, 9898.505074746234, 5273.736313184326, 5298.841034768963, 5301.284326615934, 5304.628675992643, 5310.230016647564, 4357.215701173755, 4694.647901407408, 4808.447028591757, 4847.563719265283, 4855.830045948375, 3838.347480928249, 3941.3299739044432, 3944.7830369329963, 3970.662493688011, 4051.0277533391773, 1264.3235868810143, 1281.8782215689494, 1288.7293668329569, 1289.4519829072606, 1293.4567481657725, 802.7872613757359, 917.9357444978921, 922.760082378573, 937.5452905340904, 964.6671898195111, 5494.36814766307, 5584.190292407578, 5702.971485142548, 5876.08920617305, 5951.196588460589, 425.94888613365976, 432.7360310210769, 440.73776103218535, 440.9603135717801, 443.5010613060307, 3488.424409972377, 3648.434492653643, 3888.941665875014, 3977.3835055566433, 4025.5370632377067, 10140.087392134743, 10485.056344928993, 10547.525361358757, 10557.260991730658, 10567.841482377771, 10508.159347252202, 10509.579616815394, 10511.632092876713, 10560.419176945341, 10563.47182640865, 7721.806954826175, 7846.8430631387055, 8048.154943730941, 8066.798330041796, 8081.515109093473, 5720.456556627114, 5898.085796701518, 5924.851878703067, 5960.612560183574, 5977.342492325927, 9469.810603788024, 9834.01659834011, 9868.703938881845, 9895.703128906145, 9901.009899010041, 9841.163501102486, 9880.901190987997, 9922.255830812574, 9937.602495900372, 10017.449040302854, 6908.412784913137, 7297.051383320135, 7420.369268612229, 7500.624968751432, 7528.8494230116185, 8317.376196785386, 8395.1604839518, 8402.705905293285, 8424.494530327955, 8441.493510389397, 7287.599182045038, 7389.039424874947, 7440.3675687567165, 7461.962690186514, 7544.396448284234, 7238.055259883271, 7270.6728197230195, 7283.089613798275, 7363.77908662741, 7373.963130184315, 6792.830179245559, 6830.45356371499, 6884.862302754017, 6894.207166175954, 6908.1019467468905, 4428.844990425319, 4492.842750503717, 4808.879778005438, 4940.431850337113, 4998.175301075282, 4910.288008238714, 5003.649744517995, 5063.392392912874, 5096.592272618108, 5106.693598384109], "value": 4446.090957048973, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [285.1374591859625, 295.49765398822007, 309.81565968248896, 309.8559169985956, 312.7654259305521, 4553.4080569525995, 5220.7450927494065, 5386.676799392029, 5610.859728506789, 5643.435656434354, 5528.75120619572, 5575.665460072389, 5583.35791383991, 5599.32808063032, 5611.288556990116, 4239.724417912841, 4253.660876212174, 4259.936100958488, 4275.166342563201, 4278.828846846122, 3748.7750734955853, 4153.273177193994, 4229.090745489719, 4254.361845723135, 4310.82756689732, 3920.7255492115564, 4207.453031105967, 4219.050713589433, 4221.978890105545, 4228.1037489319915, 4216.409702641633, 4235.258829704805, 4251.0860165064505, 4277.379779931924, 4325.416068830699, 3540.805255710935, 3674.136577904217, 3681.1533347330264, 3691.409374500094, 3708.9600719604377, 4685.2269375553, 5341.65279256847, 5358.0, 5385.21914322425, 5464.535514481274, 4090.468239128924, 4314.568543145691, 4851.223804191348, 4903.436104847917, 4919.21292593187, 4982.0, 5289.973550132263, 5561.388247292794, 5958.880822383571, 6031.577789554733, 3399.7280217582534, 3988.846023147497, 4008.078142027321, 4019.698522610816, 4039.394090886361, 5116.513931176532, 5566.888662226774, 5820.2724659418, 6313.621182729051, 6368.617882927039, 3475.461303497962, 4083.9795801020805, 4086.8569600063856, 4104.733192342488, 4111.8692359600755, 3543.486194501783, 3924.4505769192338, 3983.765032839829, 4094.5700701426517, 4182.0, 4133.090720041586, 4152.60550247732, 4844.15227335215, 4867.70793752376, 4887.29134275528, 5887.5272385598155, 5981.700914954235, 6018.01405536172, 6038.516918646497, 6061.121137435047, 1233.1922590703105, 1254.4229654359096, 1361.4622224221378, 1403.0459287684268, 1405.4588983241526, 743.9851202976018, 756.3986630628664, 831.5966756123275, 855.7860534866284, 857.4983634573845, 4019.3569028955226, 4597.793099310539, 4635.768211589407, 4660.324252983299, 4665.300204969281, 4357.869263922087, 4533.730555444481, 4723.976380118146, 5120.18077107661, 5120.897582048338, 4167.270727622654, 4299.849505267301, 4492.887677808016, 4601.861944141681, 4615.953840461552, 2140.2509121807243, 2474.2824580871347, 2638.445926355487, 2667.5331816931957, 2672.412069344741, 4882.923758032488, 4947.802087916515, 5246.527812496894, 5287.814926477632, 5310.495502927216, 4388.0785035142335, 4551.749653769075, 4931.4821943696115, 5238.123788396559, 5251.658642188246, 4464.419625448736, 4704.5765881070865, 5242.7640756166065, 5282.867928301823, 5300.257963885059, 4495.887602809956, 4560.749158796298, 4994.600431965507, 5103.464136265638, 5104.617153713412, 4056.6551843093666, 4596.494385617646, 4773.403324584427, 5044.949550504595, 5079.898402031865, 4397.0, 4965.8013679452415, 5119.87200319995, 5238.659487133476, 5278.759491519567, 3045.964372113492, 3172.7620428468417, 3251.8293414370332, 3480.147363895862, 3544.7164226861273, 4974.602031837517, 5042.29407882904, 5055.241713742821, 5093.0, 5796.971015144897, 5151.407588127413, 5573.018435137182, 5794.5364370851075, 5916.467517923407, 5985.491233245223, 5876.559258055749, 5910.645361278337, 5912.379200183918, 5922.111683247547, 5932.79235226765, 5521.046240261601, 5695.686737229492, 5721.914171287517, 5742.248614172718, 5766.884662306814, 5639.7180140993605, 5687.971560142173, 5886.411358864079, 5902.704864756659, 5919.826522301853, 5171.741412929414, 5410.675359478287, 5795.059359635488, 5796.275465566804, 5805.912911306249], "value": 4013.2390139047825, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [700.4396482813751, 703.8205257659296, 743.3198623259717, 771.6720393832624, 837.1335667584052, 14860.47988320409, 15416.460423885166, 15509.922450387732, 15638.609034774136, 15678.294476748546, 12408.317542535156, 14301.57095287143, 14405.27973601321, 14459.421623135062, 14471.42114315426, 841.5834162089759, 849.371465115813, 857.391252210931, 858.159004175908, 860.1613426908746, 675.3584095109641, 696.7108649910281, 857.7341024282462, 861.9094995025526, 864.2826454043161, 901.1664210605197, 903.5978989349742, 904.1365495951351, 904.5206040798388, 905.5834316214549, 869.2003356911594, 895.5611750242399, 900.9504477253748, 901.8241442918634, 902.4585248850702, 638.8977763557808, 662.3939095727403, 662.9502787290925, 665.1751827733624, 666.2770893580423, 14873.256337183098, 14875.0, 14881.404743810235, 14893.77659335111, 14895.404183832634, 14526.0, 14614.853851461456, 14681.70636587273, 14812.851871481254, 14893.106413615109, 9474.114387098041, 9714.90285097147, 10464.215183861164, 10761.30051546647, 12684.80972785409, 3528.5412896323314, 3891.4941057662604, 3900.966243945357, 3915.3735402335487, 3924.666403355718, 105495.89008219869, 111439.21401964934, 119697.52104840781, 123650.14524782136, 123708.38145809303, 11064.28082174672, 11146.162984556075, 11182.273152245078, 11354.0, 11718.23831450953, 22435.32694019182, 22796.316110516713, 22904.969276382602, 22938.770612293665, 22981.655275170884, 7968.880466793003, 8077.919220807834, 8186.836263274701, 8247.298979586682, 8280.089190189074, 4469.262571675702, 4549.0, 4553.09290139114, 4569.223232050559, 4695.178343789823, 3578.856845726194, 3672.192117734094, 3713.1830997180577, 3714.7399682022537, 3718.3678774608384, 646.3536463536464, 647.2168675902211, 652.1489456259532, 655.4035827397046, 669.3707914560298, 574.8447919061914, 670.9184557000806, 694.6943344928216, 701.7228194863001, 707.2927072927073, 7599.924000760032, 9128.402529557301, 9241.168294853496, 9590.376625519319, 9638.662646807328, 648.640004797342, 650.6941737383422, 670.7283550162192, 671.8488340123433, 683.4634811672912, 4438.533953934855, 4459.665525085632, 4462.152191083684, 4670.906581868344, 4678.578927896506, 103628.0, 103950.92098157994, 111560.0, 148513.0, 177579.0, 94729.0, 116506.41746791212, 118449.0, 129535.35232323778, 143162.0, 98754.0, 101509.49245253726, 107794.0, 112780.0, 114899.0, 9555.42667439928, 10145.137663298407, 10215.489225538842, 10252.58989640406, 10274.383536987805, 57543.712281438326, 63150.68424657847, 63937.0, 65095.674521628986, 65168.0, 77820.8326875086, 79015.0, 92039.53980230323, 92243.0, 94040.05959940587, 13098.345082746015, 13185.60443186706, 13388.330583470593, 13634.181949083088, 13640.045196836523, 15033.0, 15262.465813696468, 15357.0, 15769.842301576837, 15778.447754328543, 13742.519011834538, 13861.722765544431, 14498.565043048726, 14574.417023318949, 14645.048071875293, 13812.930935345259, 13974.930125349309, 14063.226522541358, 14317.856821431653, 14694.0, 13624.386902589606, 13757.79363309571, 13954.372053257424, 14058.297085145907, 14187.432502699776, 10922.617708380169, 11174.776504469703, 11448.942755286504, 11460.312381257152, 11843.46704398287, 8190.7952301192945, 8440.20857416428, 9775.266854986046, 10615.36552066526, 10899.673009809718], "value": 7832.025027324045, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1568.4, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 131.0, 114.0, 169.0, 143.0, 117.0, 113.0, 164.0, 118.0, 116.0], "value": 128.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 113.0, 130.0, 154.0, 130.0, 162.0, 116.0, 110.0, 188.0, 135.0], "value": 140.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [203.0, 215.0, 215.0, 197.0, 198.0, 195.0, 197.0, 200.0, 208.0, 183.0], "value": 201.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 83.0, 76.0, 144.0, 62.0, 59.0, 61.0, 56.0, 160.0, 84.0], "value": 85.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 71.0, 128.0, 71.0, 73.0, 84.0, 115.0, 69.0, 78.0, 114.0], "value": 87.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 98.0, 132.0, 73.0, 130.0, 125.0, 132.0, 126.0, 92.0, 74.0], "value": 107.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 97.0, 97.0, 103.0, 97.0, 96.0, 97.0, 97.0, 104.0, 99.0], "value": 103.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 94.0, 91.0, 89.0, 93.0, 91.0, 91.0, 92.0, 92.0, 91.0], "value": 91.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [49.0, 49.0, 58.0, 73.0, 76.0, 56.0, 56.0, 56.0, 57.0, 56.0], "value": 58.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 71.0, 74.0, 69.0, 77.0, 70.0, 83.0, 71.0, 71.0, 71.0], "value": 72.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 91.0, 94.0, 100.0, 85.0, 87.0, 87.0, 85.0, 88.0, 83.0], "value": 88.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 142.0, 140.0, 141.0, 143.0, 143.0, 140.0, 140.0, 156.0, 144.0], "value": 143.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 172.0, 173.0, 174.0, 207.0, 235.0, 174.0, 172.0, 172.0, 176.0], "value": 182.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 70.0, 66.0, 74.0, 88.0, 91.0, 84.0, 69.0, 64.0, 91.0], "value": 76.6, "unit": "score"}]}]} 01:02:24 INFO - Return code: 0 01:02:24 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 01:02:24 ERROR - # TBPL SUCCESS # 01:02:24 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 01:02:24 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 01:02:24 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 01:02:24 INFO - 2016-08-10 01:02:24.685 screenresolution[1673:10274] starting screenresolution argv=screenresolution get 01:02:24 INFO - 2016-08-10 01:02:24.687 screenresolution[1673:10274] Display 0: 1600x1200x32@60 01:02:24 INFO - 2016-08-10 01:02:24.694 screenresolution[1674:10277] starting screenresolution argv=screenresolution list 01:02:24 INFO - Available Modes on Display 0 01:02:24 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 01:02:24 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 01:02:24 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 01:02:24 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 01:02:24 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 01:02:24 INFO - Intel Iris: 01:02:24 INFO - Chipset Model: Intel Iris 01:02:24 INFO - Type: GPU 01:02:24 INFO - Bus: Built-In 01:02:24 INFO - VRAM (Dynamic, Max): 1536 MB 01:02:24 INFO - Vendor: Intel (0x8086) 01:02:24 INFO - Device ID: 0x0a2e 01:02:24 INFO - Revision ID: 0x0009 01:02:24 INFO - Displays: 01:02:24 INFO - Display: 01:02:24 INFO - Resolution: 1600 x 1200 @ 60 Hz 01:02:24 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 01:02:24 INFO - Display Serial Number: 1600x1200 60 01:02:24 INFO - Main Display: Yes 01:02:24 INFO - Mirror: Off 01:02:24 INFO - Online: Yes 01:02:24 INFO - Rotation: Supported 01:02:24 INFO - Return code: 0 01:02:24 INFO - Running post-action listener: _resource_record_post_action 01:02:24 INFO - [mozharness: 2016-08-10 08:02:24.927801Z] Finished run-tests step (success) 01:02:24 INFO - Running post-run listener: _resource_record_post_run 01:02:24 INFO - Total resource usage - Wall time: 1210s; CPU: 55.0%; Read bytes: 37815296; Write bytes: 707314176; Read time: 368; Write time: 2236 01:02:24 INFO - TinderboxPrint: CPU usage
54.9% 01:02:24 INFO - TinderboxPrint: I/O read bytes / time
37,815,296 / 368 01:02:24 INFO - TinderboxPrint: I/O write bytes / time
707,314,176 / 2,236 01:02:24 INFO - TinderboxPrint: CPU idle
2,183.3 (45.1%) 01:02:24 INFO - TinderboxPrint: CPU system
981.3 (20.3%) 01:02:24 INFO - TinderboxPrint: CPU user
1,677.0 (34.6%) 01:02:24 INFO - TinderboxPrint: Swap in / out
441,479,168 / 0 01:02:24 INFO - install - Wall time: 35s; CPU: 55.0%; Read bytes: 386503168; Write bytes: 379852288; Read time: 28948; Write time: 667 01:02:25 INFO - run-tests - Wall time: 1176s; CPU: 55.0%; Read bytes: 36860928; Write bytes: 297272320; Read time: 353; Write time: 1435 01:02:25 INFO - Running post-run listener: _upload_blobber_files 01:02:25 INFO - Blob upload gear active. 01:02:25 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 01:02:25 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 01:02:25 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'] 01:02:25 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 01:02:25 INFO - (blobuploader) - INFO - Open directory for files ... 01:02:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 01:02:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:02:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:02:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 01:02:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:02:26 INFO - (blobuploader) - INFO - Done attempting. 01:02:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 01:02:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:02:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:02:27 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 01:02:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:02:27 INFO - (blobuploader) - INFO - Done attempting. 01:02:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 01:02:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:02:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:02:29 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 01:02:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:02:29 INFO - (blobuploader) - INFO - Done attempting. 01:02:29 INFO - (blobuploader) - INFO - Iteration through files over. 01:02:29 INFO - Return code: 0 01:02:29 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 01:02:29 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 01:02:29 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ddbe050c826ac36ce1d53dba1469b1ba6185089c40b87d92eb11515adb18359d3265a16d8c91eedcd0f1a6687d120e83a85ca7c57b02eaae468b1809ffe33d80", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a81303edb43cdc30018f3de9c4fce2687be653a453e797df058bc33766a497881a2b864ecb393802f903f7140a1ea0c3abc4a776885686791d82aa362eeeb67d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1d53d06f0eb962948ba9452b0ef53385440eeb40ae5df2ca8a8c31a4d83b65337ddbdc099dbeaddbd8b15a89886bb9e29cc89f046809d5573f6a0de57f944ed9"} 01:02:29 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 01:02:29 INFO - Writing to file /builds/slave/test/properties/blobber_files 01:02:29 INFO - Contents: 01:02:29 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ddbe050c826ac36ce1d53dba1469b1ba6185089c40b87d92eb11515adb18359d3265a16d8c91eedcd0f1a6687d120e83a85ca7c57b02eaae468b1809ffe33d80", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a81303edb43cdc30018f3de9c4fce2687be653a453e797df058bc33766a497881a2b864ecb393802f903f7140a1ea0c3abc4a776885686791d82aa362eeeb67d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1d53d06f0eb962948ba9452b0ef53385440eeb40ae5df2ca8a8c31a4d83b65337ddbdc099dbeaddbd8b15a89886bb9e29cc89f046809d5573f6a0de57f944ed9"} 01:02:29 INFO - Running post-run listener: copy_logs_to_upload_dir 01:02:29 INFO - Copying logs to upload dir... 01:02:29 INFO - mkdir: /builds/slave/test/build/upload/logs 01:02:29 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1263.156361 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2016-08-10 01:02:29.929920) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-10 01:02:29.932977) ========= 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.98Q0OeKug0/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.ggLe7WHkAi/Listeners TMPDIR=/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/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/ddbe050c826ac36ce1d53dba1469b1ba6185089c40b87d92eb11515adb18359d3265a16d8c91eedcd0f1a6687d120e83a85ca7c57b02eaae468b1809ffe33d80", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a81303edb43cdc30018f3de9c4fce2687be653a453e797df058bc33766a497881a2b864ecb393802f903f7140a1ea0c3abc4a776885686791d82aa362eeeb67d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1d53d06f0eb962948ba9452b0ef53385440eeb40ae5df2ca8a8c31a4d83b65337ddbdc099dbeaddbd8b15a89886bb9e29cc89f046809d5573f6a0de57f944ed9"} build_url:https://queue.taskcluster.net/v1/task/BFTouO-CRQG2-L1bIZXezQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011069 build_url: 'https://queue.taskcluster.net/v1/task/BFTouO-CRQG2-L1bIZXezQ/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/ddbe050c826ac36ce1d53dba1469b1ba6185089c40b87d92eb11515adb18359d3265a16d8c91eedcd0f1a6687d120e83a85ca7c57b02eaae468b1809ffe33d80", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a81303edb43cdc30018f3de9c4fce2687be653a453e797df058bc33766a497881a2b864ecb393802f903f7140a1ea0c3abc4a776885686791d82aa362eeeb67d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1d53d06f0eb962948ba9452b0ef53385440eeb40ae5df2ca8a8c31a4d83b65337ddbdc099dbeaddbd8b15a89886bb9e29cc89f046809d5573f6a0de57f944ed9"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-10 01:02:29.965478) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-10 01:02:29.965805) ========= 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.98Q0OeKug0/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.ggLe7WHkAi/Listeners TMPDIR=/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/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.005187 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-10 01:02:30.014469) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-10 01:02:30.014788) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-10 01:02:30.015118) ========= ========= Total master_lag: 0.66 =========