builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0124 starttime: 1470751547.32 results: success (0) buildid: 20160809050430 builduid: 3a4cc2a27b1c4609b888cd1b892abe3a revision: a3fb4eb11fcf840b9e0d65a06be6cf64584add08 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-09 07:05:47.324241) ========= master: http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-09 07:05:47.324676) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-09 07:05:47.324963) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-09 07:05:47.352188) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-09 07:05:47.352523) ========= 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.uxsQ52DNdQ/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.GdKp0pwELi/Listeners TMPDIR=/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/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-09 07:05:47-- 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% 25.1M=0s 2016-08-09 07:05:47 (25.1 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.493937 ========= master_lag: 1.45 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-09 07:05:49.295813) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 4 secs) (at 2016-08-09 07:05:49.296126) ========= 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.uxsQ52DNdQ/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.GdKp0pwELi/Listeners TMPDIR=/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/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.027111 ========= master_lag: 4.20 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 4 secs) (at 2016-08-09 07:05:53.526702) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-09 07:05:53.527017) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev a3fb4eb11fcf840b9e0d65a06be6cf64584add08 --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 a3fb4eb11fcf840b9e0d65a06be6cf64584add08 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.uxsQ52DNdQ/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.GdKp0pwELi/Listeners TMPDIR=/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/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-09 07:05:53,692 truncating revision to first 12 chars 2016-08-09 07:05:53,692 Setting DEBUG logging. 2016-08-09 07:05:53,692 attempt 1/10 2016-08-09 07:05:53,692 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/a3fb4eb11fcf?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-09 07:05:54,811 unpacking tar archive at: fx-team-a3fb4eb11fcf/testing/mozharness/ program finished with exit code 0 elapsedTime=1.377537 ========= master_lag: 0.12 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-09 07:05:55.022621) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-09 07:05:55.022918) ========= script_repo_revision: a3fb4eb11fcf840b9e0d65a06be6cf64584add08 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-09 07:05:55.023288) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-09 07:05:55.023546) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-09 07:05:55.444340) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2016-08-09 07:05:55.444691) ========= /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.uxsQ52DNdQ/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.GdKp0pwELi/Listeners TMPDIR=/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/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 07:05:55 INFO - MultiFileLogger online at 20160809 07:05:55 in /builds/slave/test 07:05:55 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 07:05:55 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:05:55 INFO - {'append_to_log': False, 07:05:55 INFO - 'base_work_dir': '/builds/slave/test', 07:05:55 INFO - 'blob_upload_branch': 'Fx-Team', 07:05:55 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:05:55 INFO - 'branch': 'Fx-Team', 07:05:55 INFO - 'buildbot_json_path': 'buildprops.json', 07:05:55 INFO - 'config_files': ('talos/mac_config.py',), 07:05:55 INFO - 'default_actions': ('clobber', 07:05:55 INFO - 'read-buildbot-config', 07:05:55 INFO - 'download-and-extract', 07:05:55 INFO - 'populate-webroot', 07:05:55 INFO - 'create-virtualenv', 07:05:55 INFO - 'install', 07:05:55 INFO - 'run-tests'), 07:05:55 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:05:55 INFO - 'download_minidump_stackwalk': True, 07:05:55 INFO - 'download_symbols': 'ondemand', 07:05:55 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:05:55 INFO - 'tooltool.py': '/tools/tooltool.py', 07:05:55 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:05:55 INFO - '/tools/misc-python/virtualenv.py')}, 07:05:55 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:05:55 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:05:55 INFO - 'installer_path': 'installer.exe', 07:05:55 INFO - 'log_level': 'info', 07:05:55 INFO - 'log_name': 'talos', 07:05:55 INFO - 'log_to_console': True, 07:05:55 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 07:05:55 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 07:05:55 INFO - 'opt_config_files': (), 07:05:55 INFO - 'pip_index': False, 07:05:55 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:05:55 INFO - 'cmd': ('bash', 07:05:55 INFO - '-c', 07:05:55 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:05:55 INFO - 'enabled': True, 07:05:55 INFO - 'halt_on_failure': False, 07:05:55 INFO - 'name': 'check_screen_resolution'},), 07:05:55 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:05:55 INFO - 'cmd': ('bash', 07:05:55 INFO - '-c', 07:05:55 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:05:55 INFO - 'enabled': True, 07:05:55 INFO - 'halt_on_failure': False, 07:05:55 INFO - 'name': 'check_screen_resolution'},), 07:05:55 INFO - 'run_cmd_checks_enabled': True, 07:05:55 INFO - 'sps_profile': False, 07:05:55 INFO - 'sps_profile_interval': 0, 07:05:55 INFO - 'suite': 'dromaeojs-e10s', 07:05:55 INFO - 'system_bits': '32', 07:05:55 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:05:55 INFO - 'title': 't-yosemite-r7-0124', 07:05:55 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:05:55 INFO - 'use_talos_json': True, 07:05:55 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:05:55 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:05:55 INFO - 'work_dir': 'build'} 07:05:55 INFO - [mozharness: 2016-08-09 14:05:55.646166Z] Running clobber step. 07:05:55 INFO - Running pre-action listener: _resource_record_pre_action 07:05:55 INFO - Running main action method: clobber 07:05:55 INFO - rmtree: /builds/slave/test/build 07:05:55 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:05:57 INFO - Running post-action listener: _resource_record_post_action 07:05:57 INFO - [mozharness: 2016-08-09 14:05:57.753528Z] Finished clobber step (success) 07:05:57 INFO - [mozharness: 2016-08-09 14:05:57.753708Z] Running read-buildbot-config step. 07:05:57 INFO - Running pre-action listener: _resource_record_pre_action 07:05:57 INFO - Running main action method: read_buildbot_config 07:05:57 INFO - Using buildbot properties: 07:05:57 INFO - { 07:05:57 INFO - "project": "", 07:05:57 INFO - "product": "firefox", 07:05:57 INFO - "script_repo_revision": "production", 07:05:57 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 07:05:57 INFO - "repository": "", 07:05:57 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 07:05:57 INFO - "buildid": "20160809050430", 07:05:57 INFO - "pgo_build": "False", 07:05:57 INFO - "basedir": "/builds/slave/test", 07:05:57 INFO - "buildnumber": 84, 07:05:57 INFO - "slavename": "t-yosemite-r7-0124", 07:05:57 INFO - "master": "http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/", 07:05:57 INFO - "platform": "yosemite_r7", 07:05:57 INFO - "scheduler": "tests-fx-team-macosx64-talos-7-3600", 07:05:57 INFO - "branch": "fx-team", 07:05:57 INFO - "repo_path": "integration/fx-team", 07:05:57 INFO - "revision": "a3fb4eb11fcf840b9e0d65a06be6cf64584add08", 07:05:57 INFO - "stage_platform": "macosx64", 07:05:57 INFO - "builduid": "3a4cc2a27b1c4609b888cd1b892abe3a", 07:05:57 INFO - "slavebuilddir": "test" 07:05:57 INFO - } 07:05:57 INFO - Found installer url https://queue.taskcluster.net/v1/task/LTxvbTt-RGqMQz91mm4qeA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg. 07:05:57 INFO - Running post-action listener: _resource_record_post_action 07:05:57 INFO - [mozharness: 2016-08-09 14:05:57.757139Z] Finished read-buildbot-config step (success) 07:05:57 INFO - [mozharness: 2016-08-09 14:05:57.757268Z] Running download-and-extract step. 07:05:57 INFO - Running pre-action listener: _resource_record_pre_action 07:05:57 INFO - Running main action method: download_and_extract 07:05:57 INFO - mkdir: /builds/slave/test/build/tests 07:05:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:05:57 INFO - trying https://queue.taskcluster.net/v1/task/LTxvbTt-RGqMQz91mm4qeA/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json 07:05:57 INFO - Downloading https://queue.taskcluster.net/v1/task/LTxvbTt-RGqMQz91mm4qeA/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 07:05:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LTxvbTt-RGqMQz91mm4qeA/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 07:05:58 INFO - Downloaded 1199 bytes. 07:05:58 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 07:05:58 INFO - Using the following test package requirements: 07:05:58 INFO - {u'common': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 07:05:58 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 07:05:58 INFO - u'firefox-51.0a1.en-US.mac.cppunittest.tests.zip'], 07:05:58 INFO - u'gtest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 07:05:58 INFO - u'firefox-51.0a1.en-US.mac.gtest.tests.zip'], 07:05:58 INFO - u'jittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 07:05:58 INFO - u'jsshell-mac.zip'], 07:05:58 INFO - u'mochitest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 07:05:58 INFO - u'firefox-51.0a1.en-US.mac.mochitest.tests.zip'], 07:05:58 INFO - u'mozbase': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 07:05:58 INFO - u'reftest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 07:05:58 INFO - u'firefox-51.0a1.en-US.mac.reftest.tests.zip'], 07:05:58 INFO - u'talos': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 07:05:58 INFO - u'firefox-51.0a1.en-US.mac.talos.tests.zip'], 07:05:58 INFO - u'web-platform': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 07:05:58 INFO - u'firefox-51.0a1.en-US.mac.web-platform.tests.zip'], 07:05:58 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 07:05:58 INFO - u'firefox-51.0a1.en-US.mac.xpcshell.tests.zip']} 07:05:58 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip'] for test suite category: common 07:05: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')]} 07:05:58 INFO - trying https://queue.taskcluster.net/v1/task/LTxvbTt-RGqMQz91mm4qeA/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 07:05:58 INFO - Downloading https://queue.taskcluster.net/v1/task/LTxvbTt-RGqMQz91mm4qeA/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 07:05:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LTxvbTt-RGqMQz91mm4qeA/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 07:05:59 INFO - Downloaded 16324205 bytes. 07:05:59 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'] 07:05:59 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 07:06:02 INFO - Return code: 0 07:06:02 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 07:06:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:06:02 INFO - trying https://queue.taskcluster.net/v1/task/LTxvbTt-RGqMQz91mm4qeA/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 07:06:02 INFO - Downloading https://queue.taskcluster.net/v1/task/LTxvbTt-RGqMQz91mm4qeA/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 07:06:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LTxvbTt-RGqMQz91mm4qeA/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 07:06:03 INFO - Downloaded 16324205 bytes. 07:06:03 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'] 07:06:03 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 07:06:06 INFO - Return code: 0 07:06:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:06:06 INFO - trying https://queue.taskcluster.net/v1/task/LTxvbTt-RGqMQz91mm4qeA/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip 07:06:06 INFO - Downloading https://queue.taskcluster.net/v1/task/LTxvbTt-RGqMQz91mm4qeA/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 07:06:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LTxvbTt-RGqMQz91mm4qeA/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 07:06:07 INFO - Downloaded 14413723 bytes. 07:06:07 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'] 07:06:07 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 07:06:08 INFO - Return code: 0 07:06: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')]} 07:06:08 INFO - trying https://queue.taskcluster.net/v1/task/LTxvbTt-RGqMQz91mm4qeA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 07:06:08 INFO - Downloading https://queue.taskcluster.net/v1/task/LTxvbTt-RGqMQz91mm4qeA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg 07:06:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LTxvbTt-RGqMQz91mm4qeA/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 07:06:10 INFO - Downloaded 111954074 bytes. 07:06:10 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/LTxvbTt-RGqMQz91mm4qeA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 07:06:10 INFO - mkdir: /builds/slave/test/properties 07:06:10 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:06:10 INFO - Writing to file /builds/slave/test/properties/build_url 07:06:10 INFO - Contents: 07:06:10 INFO - build_url:https://queue.taskcluster.net/v1/task/LTxvbTt-RGqMQz91mm4qeA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 07:06:11 INFO - Running post-action listener: _resource_record_post_action 07:06:11 INFO - Running post-action listener: set_extra_try_arguments 07:06:11 INFO - [mozharness: 2016-08-09 14:06:11.534709Z] Finished download-and-extract step (success) 07:06:11 INFO - [mozharness: 2016-08-09 14:06:11.534838Z] Running populate-webroot step. 07:06:11 INFO - Running pre-action listener: _resource_record_pre_action 07:06:11 INFO - Running main action method: populate_webroot 07:06:11 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:06:11 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:06:11 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:06:11 INFO - '--tppagecycles', 07:06:11 INFO - '7'], 07:06:11 INFO - 'tests': ['tsvgm']}}, 07:06:11 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:06:11 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:06:11 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:06:11 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:06:11 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:06:11 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:06:11 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:06:11 INFO - 'talos_options': ['--disable-e10s'], 07:06:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:06:11 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:06:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:06:11 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:06:11 INFO - 'talos_options': ['--disable-e10s'], 07:06:11 INFO - 'tests': ['damp', 'tps']}, 07:06:11 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:06:11 INFO - 'tests': ['damp', 'tps']}, 07:06:11 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:06:11 INFO - 'tests': ['dromaeo_dom']}, 07:06:11 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:06:11 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:06:11 INFO - 'tests': ['basic_compositor_video']}, 07:06:11 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:06:11 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:06:11 INFO - 'tests': ['a11yr', 07:06:11 INFO - 'ts_paint', 07:06:11 INFO - 'tpaint', 07:06:11 INFO - 'sessionrestore', 07:06:11 INFO - 'sessionrestore_no_auto_restore', 07:06:11 INFO - 'tabpaint']}, 07:06:11 INFO - 'other-e10s': {'tests': ['a11yr', 07:06:11 INFO - 'ts_paint', 07:06:11 INFO - 'tpaint', 07:06:11 INFO - 'sessionrestore', 07:06:11 INFO - 'sessionrestore_no_auto_restore', 07:06:11 INFO - 'tabpaint']}, 07:06:11 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:06:11 INFO - 'ts_paint', 07:06:11 INFO - 'tpaint', 07:06:11 INFO - 'sessionrestore', 07:06:11 INFO - 'sessionrestore_no_auto_restore', 07:06:11 INFO - 'tabpaint']}, 07:06:11 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:06:11 INFO - 'ts_paint', 07:06:11 INFO - 'tpaint', 07:06:11 INFO - 'sessionrestore', 07:06:11 INFO - 'sessionrestore_no_auto_restore', 07:06:11 INFO - 'tabpaint']}, 07:06:11 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:06:11 INFO - 'tests': ['a11yr', 07:06:11 INFO - 'ts_paint', 07:06:11 INFO - 'tpaint', 07:06:11 INFO - 'sessionrestore', 07:06:11 INFO - 'sessionrestore_no_auto_restore', 07:06:11 INFO - 'tabpaint']}, 07:06:11 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:06:11 INFO - 'tests': ['a11yr', 07:06:11 INFO - 'ts_paint', 07:06:11 INFO - 'tpaint', 07:06:11 INFO - 'sessionrestore', 07:06:11 INFO - 'sessionrestore_no_auto_restore', 07:06:11 INFO - 'tabpaint']}, 07:06:11 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:06:11 INFO - 'tests': ['tsvgx', 07:06:11 INFO - 'tsvgr_opacity', 07:06:11 INFO - 'tart', 07:06:11 INFO - 'tscrollx', 07:06:11 INFO - 'cart']}, 07:06:11 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:06:11 INFO - 'tsvgr_opacity', 07:06:11 INFO - 'tart', 07:06:11 INFO - 'tscrollx', 07:06:11 INFO - 'cart']}, 07:06:11 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:06:11 INFO - 'talos_options': ['--disable-e10s'], 07:06:11 INFO - 'tests': ['tp5o']}, 07:06:11 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:06:11 INFO - 'tests': ['tp5o']}, 07:06:11 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:06:11 INFO - 'talos_options': ['--disable-e10s', 07:06:11 INFO - '--xperf_path', 07:06:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:06:11 INFO - 'tests': ['tp5n']}, 07:06:11 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:06:11 INFO - 'talos_options': ['--xperf_path', 07:06:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:06:11 INFO - 'tests': ['tp5n']}}, 07:06:11 INFO - 'talos.zip': {'path': '', 07:06:11 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:06:11 INFO - Running post-action listener: _resource_record_post_action 07:06:11 INFO - [mozharness: 2016-08-09 14:06:11.553648Z] Finished populate-webroot step (success) 07:06:11 INFO - [mozharness: 2016-08-09 14:06:11.553775Z] Running create-virtualenv step. 07:06:11 INFO - Running pre-action listener: _resource_record_pre_action 07:06:11 INFO - Running main action method: create_virtualenv 07:06:11 INFO - Creating virtualenv /builds/slave/test/build/venv 07:06:11 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 07:06:11 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:06:11 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:06:11 INFO - Using real prefix '/tools/python27' 07:06:11 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:06:12 INFO - Installing distribute.............................................................................................................................................................................................done. 07:06:15 INFO - Installing pip.................done. 07:06:15 INFO - Return code: 0 07:06:15 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:06:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:06:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:06:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:06:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:06:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e070a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e105618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa75a5b6b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dfd4d30>, '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 0x10dd39db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dfccb20>, '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.uxsQ52DNdQ/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.GdKp0pwELi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/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 07:06:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 07:06:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 07:06:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uxsQ52DNdQ/Render', 07:06:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:06:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:06:15 INFO - 'HOME': '/Users/cltbld', 07:06:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:06:15 INFO - 'LOGNAME': 'cltbld', 07:06:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:06:15 INFO - 'MOZ_NO_REMOTE': '1', 07:06:15 INFO - 'NO_EM_RESTART': '1', 07:06:15 INFO - 'PAGER': '/bin/cat', 07:06:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:06:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:06:15 INFO - 'PWD': '/builds/slave/test', 07:06:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:06:15 INFO - 'SHELL': '/bin/bash', 07:06:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GdKp0pwELi/Listeners', 07:06:15 INFO - 'TMPDIR': '/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/', 07:06:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:06:15 INFO - 'USER': 'cltbld', 07:06:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:06:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:06:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:06:15 INFO - 'XPC_FLAGS': '0x0', 07:06:15 INFO - 'XPC_SERVICE_NAME': '0', 07:06:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:06:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:06:15 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 07:06:15 INFO - Cleaning up... 07:06:15 INFO - Return code: 0 07:06:15 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:06:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:06:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:06:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:06:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:06:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10e070a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e105618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa75a5b6b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dfd4d30>, '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 0x10dd39db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dfccb20>, '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.uxsQ52DNdQ/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.GdKp0pwELi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/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 07:06:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 07:06:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 07:06:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uxsQ52DNdQ/Render', 07:06:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:06:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:06:15 INFO - 'HOME': '/Users/cltbld', 07:06:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:06:15 INFO - 'LOGNAME': 'cltbld', 07:06:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:06:15 INFO - 'MOZ_NO_REMOTE': '1', 07:06:15 INFO - 'NO_EM_RESTART': '1', 07:06:15 INFO - 'PAGER': '/bin/cat', 07:06:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:06:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:06:15 INFO - 'PWD': '/builds/slave/test', 07:06:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:06:15 INFO - 'SHELL': '/bin/bash', 07:06:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GdKp0pwELi/Listeners', 07:06:15 INFO - 'TMPDIR': '/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/', 07:06:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:06:15 INFO - 'USER': 'cltbld', 07:06:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:06:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:06:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:06:15 INFO - 'XPC_FLAGS': '0x0', 07:06:15 INFO - 'XPC_SERVICE_NAME': '0', 07:06:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:06:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:06:16 INFO - Downloading/unpacking psutil>=3.1.1 07:06:16 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 07:06:16 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 07:06:16 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 07:06:16 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 07:06:16 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 07:06:16 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 07:06:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:06:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:06:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:06:19 INFO - Installing collected packages: psutil 07:06:19 INFO - Running setup.py install for psutil 07:06:19 INFO - building 'psutil._psutil_osx' extension 07:06:19 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 07:06:19 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 07:06:19 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 07:06:20 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 07:06:20 INFO - building 'psutil._psutil_posix' extension 07:06:20 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 07:06:20 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 07:06:20 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 07:06:20 INFO - ^ 07:06:20 INFO - 1 warning generated. 07:06:20 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 07:06:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:06:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:06:20 INFO - Successfully installed psutil 07:06:20 INFO - Cleaning up... 07:06:20 INFO - Return code: 0 07:06:20 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:06:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:06:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:06:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:06:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:06:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06:20 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 0x10e070a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e105618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa75a5b6b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dfd4d30>, '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 0x10dd39db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dfccb20>, '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.uxsQ52DNdQ/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.GdKp0pwELi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/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 07:06:20 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 07:06:20 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 07:06:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uxsQ52DNdQ/Render', 07:06:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:06:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:06:20 INFO - 'HOME': '/Users/cltbld', 07:06:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:06:20 INFO - 'LOGNAME': 'cltbld', 07:06:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:06:20 INFO - 'MOZ_NO_REMOTE': '1', 07:06:20 INFO - 'NO_EM_RESTART': '1', 07:06:20 INFO - 'PAGER': '/bin/cat', 07:06:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:06:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:06:20 INFO - 'PWD': '/builds/slave/test', 07:06:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:06:20 INFO - 'SHELL': '/bin/bash', 07:06:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GdKp0pwELi/Listeners', 07:06:20 INFO - 'TMPDIR': '/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/', 07:06:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:06:20 INFO - 'USER': 'cltbld', 07:06:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:06:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:06:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:06:20 INFO - 'XPC_FLAGS': '0x0', 07:06:20 INFO - 'XPC_SERVICE_NAME': '0', 07:06:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:06:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:06:20 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:06:20 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 07:06:20 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 07:06:20 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 07:06:20 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 07:06:20 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 07:06:20 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 07:06:23 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:06:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:06:23 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:06:23 INFO - Installing collected packages: mozsystemmonitor 07:06:23 INFO - Running setup.py install for mozsystemmonitor 07:06:23 INFO - Successfully installed mozsystemmonitor 07:06:23 INFO - Cleaning up... 07:06:23 INFO - Return code: 0 07:06:23 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:06:23 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')]} 07:06:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:06:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06:23 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')]} 07:06:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:06:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06:23 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 0x10e070a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e105618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa75a5b6b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dfd4d30>, '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 0x10dd39db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dfccb20>, '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.uxsQ52DNdQ/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.GdKp0pwELi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/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 07:06:23 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 07:06:23 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 07:06:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uxsQ52DNdQ/Render', 07:06:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:06:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:06:23 INFO - 'HOME': '/Users/cltbld', 07:06:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:06:23 INFO - 'LOGNAME': 'cltbld', 07:06:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:06:23 INFO - 'MOZ_NO_REMOTE': '1', 07:06:23 INFO - 'NO_EM_RESTART': '1', 07:06:23 INFO - 'PAGER': '/bin/cat', 07:06:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:06:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:06:23 INFO - 'PWD': '/builds/slave/test', 07:06:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:06:23 INFO - 'SHELL': '/bin/bash', 07:06:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GdKp0pwELi/Listeners', 07:06:23 INFO - 'TMPDIR': '/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/', 07:06:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:06:23 INFO - 'USER': 'cltbld', 07:06:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:06:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:06:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:06:23 INFO - 'XPC_FLAGS': '0x0', 07:06:23 INFO - 'XPC_SERVICE_NAME': '0', 07:06:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:06:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:06:23 INFO - Downloading/unpacking jsonschema==2.5.1 07:06:23 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 07:06:23 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 07:06:23 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 07:06:23 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 07:06:23 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 07:06:23 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 07:06:26 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:06:26 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:06:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:06:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:06:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:06:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:06:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:06:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:06:26 INFO - Downloading functools32-3.2.3-2.tar.gz 07:06:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:06:26 INFO - warning: no files found matching '*.txt' 07:06:26 INFO - no previously-included directories found matching 'build' 07:06:26 INFO - no previously-included directories found matching 'dist' 07:06:26 INFO - no previously-included directories found matching '.git*' 07:06:26 INFO - Installing collected packages: jsonschema, functools32 07:06:26 INFO - Running setup.py install for functools32 07:06:26 INFO - warning: no files found matching '*.txt' 07:06:26 INFO - no previously-included directories found matching 'build' 07:06:26 INFO - no previously-included directories found matching 'dist' 07:06:26 INFO - no previously-included directories found matching '.git*' 07:06:26 INFO - Successfully installed jsonschema functools32 07:06:26 INFO - Cleaning up... 07:06:26 INFO - Return code: 0 07:06:26 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 07:06:26 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')]} 07:06:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:06:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06:26 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')]} 07:06:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:06:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06:26 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 0x10e070a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e105618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa75a5b6b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dfd4d30>, '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 0x10dd39db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dfccb20>, '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.uxsQ52DNdQ/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.GdKp0pwELi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/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 07:06:26 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 07:06:26 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 07:06:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uxsQ52DNdQ/Render', 07:06:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:06:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:06:26 INFO - 'HOME': '/Users/cltbld', 07:06:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:06:26 INFO - 'LOGNAME': 'cltbld', 07:06:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:06:26 INFO - 'MOZ_NO_REMOTE': '1', 07:06:26 INFO - 'NO_EM_RESTART': '1', 07:06:26 INFO - 'PAGER': '/bin/cat', 07:06:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:06:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:06:26 INFO - 'PWD': '/builds/slave/test', 07:06:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:06:26 INFO - 'SHELL': '/bin/bash', 07:06:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GdKp0pwELi/Listeners', 07:06:26 INFO - 'TMPDIR': '/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/', 07:06:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:06:26 INFO - 'USER': 'cltbld', 07:06:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:06:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:06:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:06:26 INFO - 'XPC_FLAGS': '0x0', 07:06:26 INFO - 'XPC_SERVICE_NAME': '0', 07:06:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:06:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:06:27 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 07:06:27 INFO - Cleaning up... 07:06:27 INFO - Return code: 0 07:06:27 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:06:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:06:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:06:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:06:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:06:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06:27 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 0x10e070a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e105618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa75a5b6b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dfd4d30>, '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 0x10dd39db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dfccb20>, '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.uxsQ52DNdQ/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.GdKp0pwELi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/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 07:06:27 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 07:06:27 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 07:06:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uxsQ52DNdQ/Render', 07:06:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:06:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:06:27 INFO - 'HOME': '/Users/cltbld', 07:06:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:06:27 INFO - 'LOGNAME': 'cltbld', 07:06:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:06:27 INFO - 'MOZ_NO_REMOTE': '1', 07:06:27 INFO - 'NO_EM_RESTART': '1', 07:06:27 INFO - 'PAGER': '/bin/cat', 07:06:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:06:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:06:27 INFO - 'PWD': '/builds/slave/test', 07:06:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:06:27 INFO - 'SHELL': '/bin/bash', 07:06:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GdKp0pwELi/Listeners', 07:06:27 INFO - 'TMPDIR': '/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/', 07:06:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:06:27 INFO - 'USER': 'cltbld', 07:06:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:06:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:06:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:06:27 INFO - 'XPC_FLAGS': '0x0', 07:06:27 INFO - 'XPC_SERVICE_NAME': '0', 07:06:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:06:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:06:27 INFO - Downloading/unpacking blobuploader==1.2.4 07:06:27 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 07:06:27 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 07:06:27 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 07:06:27 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 07:06:27 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 07:06:27 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 07:06:29 INFO - Downloading blobuploader-1.2.4.tar.gz 07:06:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:06:30 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:06:30 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 07:06:30 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 07:06:30 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 07:06:30 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 07:06:30 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 07:06:30 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 07:06:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:06:30 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:06:30 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 07:06:30 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 07:06:30 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 07:06:30 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 07:06:30 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 07:06:30 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 07:06:31 INFO - Downloading docopt-0.6.1.tar.gz 07:06:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:06:31 INFO - Installing collected packages: blobuploader, requests, docopt 07:06:31 INFO - Running setup.py install for blobuploader 07:06:31 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:06:31 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:06:31 INFO - Running setup.py install for requests 07:06:31 INFO - Running setup.py install for docopt 07:06:32 INFO - Successfully installed blobuploader requests docopt 07:06:32 INFO - Cleaning up... 07:06:32 INFO - Return code: 0 07:06:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:06:32 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')]} 07:06:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:06:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06:32 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')]} 07:06:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:06:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06:32 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 0x10e070a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e105618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa75a5b6b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dfd4d30>, '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 0x10dd39db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dfccb20>, '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.uxsQ52DNdQ/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.GdKp0pwELi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/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 07:06:32 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 07:06:32 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 07:06:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uxsQ52DNdQ/Render', 07:06:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:06:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:06:32 INFO - 'HOME': '/Users/cltbld', 07:06:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:06:32 INFO - 'LOGNAME': 'cltbld', 07:06:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:06:32 INFO - 'MOZ_NO_REMOTE': '1', 07:06:32 INFO - 'NO_EM_RESTART': '1', 07:06:32 INFO - 'PAGER': '/bin/cat', 07:06:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:06:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:06:32 INFO - 'PWD': '/builds/slave/test', 07:06:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:06:32 INFO - 'SHELL': '/bin/bash', 07:06:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GdKp0pwELi/Listeners', 07:06:32 INFO - 'TMPDIR': '/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/', 07:06:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:06:32 INFO - 'USER': 'cltbld', 07:06:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:06:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:06:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:06:32 INFO - 'XPC_FLAGS': '0x0', 07:06:32 INFO - 'XPC_SERVICE_NAME': '0', 07:06:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:06:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:06:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:06:32 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-HL15l7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:06:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:06:32 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-hMRvYJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:06:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:06:32 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-wMlbhW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:06:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:06:32 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-NCFHmy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:06:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:06:32 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-EH2D3a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:06:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:06:32 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-d_FlPU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:06:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:06:33 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-3MWtWm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:06:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:06:33 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-kYy8Vy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:06:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:06:33 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-GeOTeo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:06:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:06:33 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-alpCtb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:06:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:06:33 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-MXVeom-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:06:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:06:33 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-9TXzUm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:06:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:06:33 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-UnTl61-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:06:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:06:33 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-JXbxeD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:06:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:06:33 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-KtiOZd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:06:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:06:33 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-sUQ_QN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:06:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:06:34 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-0AUvUK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:06:34 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:06:34 INFO - Running setup.py install for manifestparser 07:06:34 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:06:34 INFO - Running setup.py install for mozcrash 07:06:34 INFO - Running setup.py install for mozdebug 07:06:34 INFO - Running setup.py install for mozdevice 07:06:34 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:06:34 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:06:34 INFO - Running setup.py install for mozfile 07:06:34 INFO - Running setup.py install for mozhttpd 07:06:35 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:06:35 INFO - Running setup.py install for mozinfo 07:06:35 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:06:35 INFO - Running setup.py install for mozInstall 07:06:35 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:06:35 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:06:35 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:06:35 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:06:35 INFO - Running setup.py install for mozleak 07:06:35 INFO - Running setup.py install for mozlog 07:06:35 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:06:35 INFO - Running setup.py install for moznetwork 07:06:35 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:06:35 INFO - Running setup.py install for mozprocess 07:06:35 INFO - Running setup.py install for mozprofile 07:06:36 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:06:36 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:06:36 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:06:36 INFO - Running setup.py install for mozrunner 07:06:36 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:06:36 INFO - Running setup.py install for mozscreenshot 07:06:36 INFO - Running setup.py install for moztest 07:06:36 INFO - Running setup.py install for mozversion 07:06:36 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:06:36 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:06:36 INFO - Cleaning up... 07:06:36 INFO - Return code: 0 07:06:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:06:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:06:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:06:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:06:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:06:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06:36 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 0x10e070a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e105618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa75a5b6b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dfd4d30>, '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 0x10dd39db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dfccb20>, '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.uxsQ52DNdQ/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.GdKp0pwELi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/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 07:06:36 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 07:06:36 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 07:06:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uxsQ52DNdQ/Render', 07:06:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:06:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:06:36 INFO - 'HOME': '/Users/cltbld', 07:06:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:06:36 INFO - 'LOGNAME': 'cltbld', 07:06:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:06:36 INFO - 'MOZ_NO_REMOTE': '1', 07:06:36 INFO - 'NO_EM_RESTART': '1', 07:06:36 INFO - 'PAGER': '/bin/cat', 07:06:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:06:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:06:36 INFO - 'PWD': '/builds/slave/test', 07:06:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:06:36 INFO - 'SHELL': '/bin/bash', 07:06:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GdKp0pwELi/Listeners', 07:06:36 INFO - 'TMPDIR': '/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/', 07:06:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:06:36 INFO - 'USER': 'cltbld', 07:06:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:06:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:06:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:06:36 INFO - 'XPC_FLAGS': '0x0', 07:06:36 INFO - 'XPC_SERVICE_NAME': '0', 07:06:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:06:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:06:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:06:37 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-fg9drM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:06:37 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)) 07:06:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:06:37 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-F3dmij-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:06:37 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)) 07:06:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:06:37 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-PqhZE8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:06:37 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)) 07:06:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:06:37 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-lgZ1dn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:06:37 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)) 07:06:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:06:37 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-2NDOWF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:06:37 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)) 07:06:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:06:37 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-SSSiFf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:06:37 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)) 07:06:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:06:37 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-k94Ly8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:06:37 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)) 07:06:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:06:37 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-9ULk92-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:06:37 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)) 07:06:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:06:37 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-8m25kV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:06:38 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)) 07:06:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:06:38 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-Di6U8S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:06:38 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)) 07:06:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:06:38 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-8uT7SF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:06:38 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)) 07:06:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:06:38 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-KbU3qM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:06:38 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)) 07:06:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:06:38 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-HCuSG6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:06:38 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)) 07:06:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:06:38 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-qqz4uP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:06:38 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)) 07:06:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:06:38 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-vgbcCi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:06:38 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)) 07:06:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:06:38 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-njTegO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:06:38 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)) 07:06:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:06:38 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-Mw7uSS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:06:38 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)) 07:06:38 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)) 07:06:38 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)) 07:06:38 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)) 07:06:38 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)) 07:06:38 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)) 07:06:38 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:06:38 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 07:06:38 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 07:06:38 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 07:06:38 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 07:06:38 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 07:06:38 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 07:06:42 INFO - Downloading blessings-1.6.tar.gz 07:06:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:06:42 INFO - Installing collected packages: blessings 07:06:42 INFO - Running setup.py install for blessings 07:06:42 INFO - Successfully installed blessings 07:06:42 INFO - Cleaning up... 07:06:42 INFO - Return code: 0 07:06:42 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:06:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:06:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:06:42 INFO - Reading from file tmpfile_stdout 07:06:42 INFO - Current package versions: 07:06:42 INFO - blessings == 1.6 07:06:42 INFO - blobuploader == 1.2.4 07:06:42 INFO - docopt == 0.6.1 07:06:42 INFO - functools32 == 3.2.3-2 07:06:42 INFO - jsonschema == 2.5.1 07:06:42 INFO - manifestparser == 1.1 07:06:42 INFO - mozInstall == 1.12 07:06:42 INFO - mozcrash == 0.17 07:06:42 INFO - mozdebug == 0.1 07:06:42 INFO - mozdevice == 0.48 07:06:42 INFO - mozfile == 1.2 07:06:42 INFO - mozhttpd == 0.7 07:06:42 INFO - mozinfo == 0.9 07:06:42 INFO - mozleak == 0.1 07:06:42 INFO - mozlog == 3.3 07:06:42 INFO - moznetwork == 0.27 07:06:42 INFO - mozprocess == 0.23 07:06:42 INFO - mozprofile == 0.28 07:06:42 INFO - mozrunner == 6.12 07:06:42 INFO - mozscreenshot == 0.1 07:06:42 INFO - mozsystemmonitor == 0.3 07:06:42 INFO - moztest == 0.7 07:06:42 INFO - mozversion == 1.4 07:06:42 INFO - psutil == 3.1.1 07:06:42 INFO - requests == 1.2.3 07:06:42 INFO - wsgiref == 0.1.2 07:06:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:06:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:06:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:06:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:06:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:06:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06:42 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 0x10e070a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e105618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa75a5b6b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dfd4d30>, '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 0x10dd39db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dfccb20>, '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.uxsQ52DNdQ/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.GdKp0pwELi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/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 07:06:42 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 07:06:42 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 07:06:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uxsQ52DNdQ/Render', 07:06:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:06:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:06:42 INFO - 'HOME': '/Users/cltbld', 07:06:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:06:42 INFO - 'LOGNAME': 'cltbld', 07:06:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:06:42 INFO - 'MOZ_NO_REMOTE': '1', 07:06:42 INFO - 'NO_EM_RESTART': '1', 07:06:42 INFO - 'PAGER': '/bin/cat', 07:06:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:06:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:06:42 INFO - 'PWD': '/builds/slave/test', 07:06:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:06:42 INFO - 'SHELL': '/bin/bash', 07:06:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GdKp0pwELi/Listeners', 07:06:42 INFO - 'TMPDIR': '/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/', 07:06:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:06:42 INFO - 'USER': 'cltbld', 07:06:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:06:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:06:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:06:42 INFO - 'XPC_FLAGS': '0x0', 07:06:42 INFO - 'XPC_SERVICE_NAME': '0', 07:06:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:06:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:06:43 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)) 07:06:43 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)) 07:06:43 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)) 07:06:43 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)) 07:06:43 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)) 07:06:43 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)) 07:06:43 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)) 07:06:43 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)) 07:06:43 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)) 07:06:43 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)) 07:06:43 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)) 07:06:43 INFO - Cleaning up... 07:06:43 INFO - Return code: 0 07:06:43 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:06:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:06:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:06:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:06:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:06:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06:43 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 0x10e070a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e105618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa75a5b6b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dfd4d30>, '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 0x10dd39db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dfccb20>, '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.uxsQ52DNdQ/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.GdKp0pwELi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/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 07:06:43 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 07:06:43 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 07:06:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uxsQ52DNdQ/Render', 07:06:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:06:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:06:43 INFO - 'HOME': '/Users/cltbld', 07:06:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:06:43 INFO - 'LOGNAME': 'cltbld', 07:06:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:06:43 INFO - 'MOZ_NO_REMOTE': '1', 07:06:43 INFO - 'NO_EM_RESTART': '1', 07:06:43 INFO - 'PAGER': '/bin/cat', 07:06:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:06:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:06:43 INFO - 'PWD': '/builds/slave/test', 07:06:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:06:43 INFO - 'SHELL': '/bin/bash', 07:06:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GdKp0pwELi/Listeners', 07:06:43 INFO - 'TMPDIR': '/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/', 07:06:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:06:43 INFO - 'USER': 'cltbld', 07:06:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:06:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:06:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:06:43 INFO - 'XPC_FLAGS': '0x0', 07:06:43 INFO - 'XPC_SERVICE_NAME': '0', 07:06:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:06:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:06:43 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:06:43 INFO - Cleaning up... 07:06:43 INFO - Return code: 0 07:06:43 INFO - Running post-action listener: _resource_record_post_action 07:06:43 INFO - Running post-action listener: _start_resource_monitoring 07:06:43 INFO - Starting resource monitoring. 07:06:43 INFO - [mozharness: 2016-08-09 14:06:43.452830Z] Finished create-virtualenv step (success) 07:06:43 INFO - [mozharness: 2016-08-09 14:06:43.453743Z] Running install step. 07:06:43 INFO - Running pre-action listener: _resource_record_pre_action 07:06:43 INFO - Running main action method: install 07:06:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:06:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:06:43 INFO - Reading from file tmpfile_stdout 07:06:43 INFO - Detecting whether we're running mozinstall >=1.0... 07:06:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:06:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:06:43 INFO - Reading from file tmpfile_stdout 07:06:43 INFO - Output received: 07:06:43 INFO - Usage: mozinstall [options] installer 07:06:43 INFO - Options: 07:06:43 INFO - -h, --help show this help message and exit 07:06:43 INFO - -d DEST, --destination=DEST 07:06:43 INFO - Directory to install application into. [default: 07:06:43 INFO - "/builds/slave/test"] 07:06:43 INFO - --app=APP Application being installed. [default: firefox] 07:06:43 INFO - mkdir: /builds/slave/test/build/application 07:06:43 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'] 07:06:43 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 07:07:18 INFO - Reading from file tmpfile_stdout 07:07:18 INFO - Output received: 07:07:18 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 07:07:18 INFO - Running post-action listener: _resource_record_post_action 07:07:18 INFO - [mozharness: 2016-08-09 14:07:18.373811Z] Finished install step (success) 07:07:18 INFO - [mozharness: 2016-08-09 14:07:18.373945Z] Running run-tests step. 07:07:18 INFO - Running pre-action listener: _resource_record_pre_action 07:07:18 INFO - Running main action method: run_tests 07:07:18 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:07:18 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:07:18 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:07:18 INFO - 2016-08-09 07:07:18.387 screenresolution[1644:8533] starting screenresolution argv=screenresolution get 07:07:18 INFO - 2016-08-09 07:07:18.390 screenresolution[1644:8533] Display 0: 1600x1200x32@60 07:07:18 INFO - 2016-08-09 07:07:18.396 screenresolution[1645:8536] starting screenresolution argv=screenresolution list 07:07:18 INFO - Available Modes on Display 0 07:07:18 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:07:18 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:07:18 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:07:18 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:07:18 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:07:18 INFO - Intel Iris: 07:07:18 INFO - Chipset Model: Intel Iris 07:07:18 INFO - Type: GPU 07:07:18 INFO - Bus: Built-In 07:07:18 INFO - VRAM (Dynamic, Max): 1536 MB 07:07:18 INFO - Vendor: Intel (0x8086) 07:07:18 INFO - Device ID: 0x0a2e 07:07:18 INFO - Revision ID: 0x0009 07:07:18 INFO - Displays: 07:07:18 INFO - Display: 07:07:18 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:07:18 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:07:18 INFO - Display Serial Number: 1600x1200 60 07:07:18 INFO - Main Display: Yes 07:07:18 INFO - Mirror: Off 07:07:18 INFO - Online: Yes 07:07:18 INFO - Rotation: Supported 07:07:18 INFO - Return code: 0 07:07:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:07:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:07:18 INFO - Python 2.7.3 07:07:18 INFO - Return code: 0 07:07:18 INFO - grabbing minidump binary from tooltool 07:07:18 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')]} 07:07:18 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 0x10dfd4d30>, '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 0x10dd39db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dfccb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:07:18 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 07:07:18 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 07:07:18 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 07:07:18 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:07:18 INFO - Return code: 0 07:07:18 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 07:07:18 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:07:18 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:07:18 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 07:07:18 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:07:18 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/LTxvbTt-RGqMQz91mm4qeA/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0124', '--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 07:07:18 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/LTxvbTt-RGqMQz91mm4qeA/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0124 --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 07:07:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uxsQ52DNdQ/Render', 07:07:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:07:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:07:18 INFO - 'HOME': '/Users/cltbld', 07:07:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:07:18 INFO - 'LOGNAME': 'cltbld', 07:07:18 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:07:18 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 07:07:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:07:18 INFO - 'MOZ_NO_REMOTE': '1', 07:07:18 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:07:18 INFO - 'NO_EM_RESTART': '1', 07:07:18 INFO - 'PAGER': '/bin/cat', 07:07:18 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:07:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:07:18 INFO - 'PWD': '/builds/slave/test', 07:07:18 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:07:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:07:18 INFO - 'SHELL': '/bin/bash', 07:07:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GdKp0pwELi/Listeners', 07:07:18 INFO - 'TMPDIR': '/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/', 07:07:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:07:18 INFO - 'USER': 'cltbld', 07:07:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:07:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:07:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:07:18 INFO - 'XPC_FLAGS': '0x0', 07:07:18 INFO - 'XPC_SERVICE_NAME': '0', 07:07:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:07:18 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/LTxvbTt-RGqMQz91mm4qeA/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0124', '--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 07:07:18 INFO - mozversion application_buildid: 20160809050430 07:07:18 INFO - mozversion application_changeset: a3fb4eb11fcf840b9e0d65a06be6cf64584add08 07:07:18 INFO - mozversion application_display_name: Nightly 07:07:18 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:07:18 INFO - mozversion application_name: Firefox 07:07:18 INFO - mozversion application_remotingname: firefox 07:07:18 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 07:07:18 INFO - mozversion application_vendor: Mozilla 07:07:18 INFO - mozversion application_version: 51.0a1 07:07:18 INFO - mozversion platform_buildid: 20160809050430 07:07:18 INFO - mozversion platform_changeset: a3fb4eb11fcf840b9e0d65a06be6cf64584add08 07:07:18 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 07:07:18 INFO - mozversion platform_version: 51.0a1 07:07:18 INFO - using testdate: 1470751638 07:07:18 INFO - actual date: 1470751638 07:07:18 INFO - starting webserver on 'localhost:49266' 07:07:18 INFO - SUITE-START | Running 2 tests 07:07:18 INFO - TEST-START | dromaeo_css 07:07:18 INFO - operating with platform_type : mac_ 07:07:18 INFO - Initialising browser for dromaeo_css test... 07:07:19 INFO - TEST-INFO | started process 1655 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/tmpvuqTs0/profile http://localhost:49266/getInfo.html) 07:07:22 INFO - PROCESS | 1655 | __metrics Screen width/height:1600/1200 07:07:22 INFO - PROCESS | 1655 | colorDepth:24 07:07:22 INFO - PROCESS | 1655 | Browser inner width/height: 1024/689 07:07:22 INFO - PROCESS | 1655 | __metrics 07:07:22 ERROR - PROCESS | 1655 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 07:07:22 INFO - TEST-INFO | 1655: exit 0 07:07:22 INFO - Browser initialized. 07:07:22 INFO - Running cycle 1/1 for dromaeo_css test... 07:07:22 INFO - TEST-INFO | started process 1659 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/tmpvuqTs0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:07:34 INFO - PROCESS | 1659 | RSS: Main: 254590976 07:07:34 INFO - PROCESS | 1659 | 07:08:24 INFO - PROCESS | 1659 | 1470751704413 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] 07:10:37 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49266/tests/dromaeo/cssquery-ext.html) 07:10:38 INFO - PROCESS | 1659 | RSS: Main: 267796480 07:10:38 INFO - PROCESS | 1659 | 07:13:40 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-ext.html (next: http://localhost:49266/tests/dromaeo/cssquery-jquery.html) 07:13:41 INFO - PROCESS | 1659 | RSS: Main: 280145920 07:13:41 INFO - PROCESS | 1659 | 07:16:43 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49266/tests/dromaeo/cssquery-mootools.html) 07:16:43 INFO - PROCESS | 1659 | RSS: Main: 287711232 07:16:43 INFO - PROCESS | 1659 | 07:19:45 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49266/tests/dromaeo/cssquery-prototype.html) 07:19:46 INFO - PROCESS | 1659 | RSS: Main: 287289344 07:19:46 INFO - PROCESS | 1659 | 07:22:49 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49266/tests/dromaeo/cssquery-yui.html) 07:22:49 INFO - PROCESS | 1659 | RSS: Main: 291463168 07:22:49 INFO - PROCESS | 1659 | 07:25:52 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-yui.html (next: http://localhost:49266/tests/dromaeo/cssquery-dojo.html) 07:25:52 INFO - PROCESS | 1659 | RSS: Main: 291803136 07:25:52 INFO - PROCESS | 1659 | 07:25:52 INFO - PROCESS | 1659 | __start_tp_report 07:25:52 INFO - PROCESS | 1659 | _x_x_mozilla_page_load 07:25:52 INFO - PROCESS | 1659 | _x_x_mozilla_page_load_details 07:25:52 INFO - PROCESS | 1659 | |i|pagename|runs| 07:25:52 INFO - PROCESS | 1659 | |0;dojo.html;3391.711704505117;3395.830208489575;3412.0275721419403;3426.503157042229;3430.1939044324586;5617.662940223589;5720.742566584503;5751.7699292028265;5779.133130030492;5836.824895253149;4586.678932474728;5618.662880227179;5730.971345143268;5751.223584816049;5770.538356931446;5152.072626927152;5200.947990520084;5235.947640523584;5304.946950530484;5328.706921119337;5316.415194328621;5354.544863686591;5392.245085688007;5422.4306447823;5436.782528698847;5119.539241468286;5204.1673332266655;5247.816326428595;5274.868128296785;5336.733163341817;5242.764075616568;5268.657537260104;5301.549368303698;5305.495977882095;5355.384130824966;5174;5189.42916279209;5215.061288967984;5285.418603953601;5293.391260005072;5032.0690672225755;5529.212489444743;5597.860053498654;5758.48173664368;5789.07374820031;5637;5721.4850663440075;6068.848278793022;6207.937920620826;6238.781642642486;6197.686541230195;6241.188645476059;6285.9057114143325;6293.559450838443;6297.622142671455;5695.231143795618;5814.126689373667;5861.5603829712945;5882.235309409835;5925.614835035666;6148.569600128038;6170.167027451326;6213.5339849511465;6217.191765070512;6295.779647712399;5764.942350576524;5829.5044921181325;6063.478916038454;6125.081237814364;6137.539684523589;5158.432572417031;6162.845928851814;6179.81460556184;6259.374062593704;6288.27684816252;6190.164327815777;6211.130441738161;6224.37756224383;6238.251409830758;6246.750129994749;6149.477294429934;6226.5641405102115;6228.532860035515;6235.501159907287;6255.0617407388345;4893.192623217201;4987.10232158215;5029.1450453423;5032.295478632995;5056.317397151338;4427.734335939854;4500.752458614807;4513.616342610915;4523.751193684379;4556.84051058218;5734.655920644775;5830.067189249699;5835.79574714883;5842.065269556851;5862.618929769551;6115.696722738819;6138.848241798255;6184.628922264588;6214.316425193225;6262.1859158310035;5762.88474230513;5782.595218334676;5792.9710351447975;5801.593888427769;5874.970625146847;5425.294711687456;5450.972745136249;5479.780808767605;5487.094629386186;5491.615586908958;6133.3866613338305;6251.749930002749;6286;6314.905276420765;6330.430261276507;6182.814515564541;6240.375962403905;6246.063090536456;6247.250329960434;6249.625022498664;6279.183706118175;6312.842178945563;6334.746610135543;6342.39747224013;6377;6089.604175728564;6141.332587233645;6146.5248340398875;6155.107509411021;6256.186695729526;6170.475509581735;6213.65824879636;6231.937680623136;6239.594426362272;6287.931051721127;5296.708681022581;6133.938660613337;6149.354317796567;6165.260168779775;6173.9073913892225;5730.914036289376;5738.139279108167;5751.913721294268;5997.400259973968;6162.044883043135;5324.893502130013;5573.7770489179975;5648.774049037993;5655.7172141393585;5731.942680573141;4768.3085952537385;4789.185838407409;5232.5552328052545;5782.797602084075;5807.738651760596;5619.943800561942;5634.070378387521;5640.943590564042;5695.772169113355;5834.15404766315 07:25:52 INFO - PROCESS | 1659 | |1;ext.html;449.27666457004216;490.40415894687925;501.92587861975403;505.1942152267135;551.1182108626199;37946.430803537936;40173;40211.79894100533;40268;40451.58419455316;40832.79583602085;40859.59140408595;41426.171476570526;41470;41501.7924910375;9633.855492167622;9708.466034368106;9736.221102311798;9795.706128816111;9820.312578119534;9658;9676.75808104796;9723.951380243088;9786.657466988658;9791.412515249072;9721.125098741148;9791.265655075898;9812.165965892907;9821;9869.01309869011;9726.513674316257;9766.121049105579;9767.365121267096;9776.853347199798;9812.067853553972;9526.476043817587;9560.330776845623;9620.807583848284;9628.3260171788;9658.082482164184;38362.0409489765;38371.42442863331;38575.42136867949;38847.22305553873;38941.41587876184;3028.364043550857;3314.834258287076;3325.5676762021026;3393.321335732863;3423.726101911841;30257.848710756305;30288.394232115235;30442.695573044206;30562.235944101354;30728.2317942051;3119.2825650100376;3125.484295091307;3131.091983324833;3161.2571045804216;3233.5796346475045;465025;468544;470726;474124;474300;32474.35051299008;32589;32614.836925815693;32628.184295392806;32640.347193056004;33442;33602.15994600154;33759.66240337614;34783.652163478044;34877.65122348795;16382;16529.33882644681;16599.336026559045;16642.16789160537;16668;12463.813042804366;12575.931045861022;12595.181313214613;12602.558910438274;12617.432215550321;18501;18811.81188188128;19014.61970760577;19041.61916761657;19149.808501914802;7669.38644908406;7907.690308781728;7928.1675424080795;7946.205379462008;8013.879791803011;876.8202518483696;953.2612225525273;964.0793042644398;1004.3873237325225;1029.7271223125877;23020.53958920812;29872.954446594264;30372.392552148835;30669.8466507666;31092.222694432367;1013.6670278583639;1056.2342301831266;1058.6453538064834;1097.3635291530893;1097.8956999085074;12003.879961200451;14318.355673994694;15821.446249381217;15942.715527343318;16090.436834710728;710933;714316;716304;716560;720244;57946;58469.12296315558;58725.706371468725;59043;59354.40645593575;1337.25782190885;1355.5323413422354;1369.110078448996;1369.2674419185687;1370.3559327116438;28065.017724379548;28224.576631350956;29294.853525732236;29901.850490747405;30731.692683073776;49382.25926611032;49717;49719.751401242764;49736;49811.25283120684;470791;569104;569648;572489;576849;21898.562028759017;26243.86878065674;26331.21006369812;26681.866590666923;26750.46499069969;47647.28529071997;47668.04663906772;47895.281570777166;49091;49262;31536.211594710316;39623.8081940391;40438.59561404349;40792.70953155359;41307.58692413037;38651.22697546089;39633.009174770865;39748.00629984274;40734;41256.79371603123;37483.625163748016;38199.42700859545;38653;38787.61212387953;39040.80479597584;27597.724022759514;34731.30537389289;34789.736208154536;34919.30161396707;35140.472892907135;25633.359166021;25658.743412566382;25721.742782572685;26234.4753104933;26401 07:25:52 INFO - PROCESS | 1659 | |2;jquery.html;357.21591107519004;371.2000638623765;377.2737480350325;385.1930206217974;398.97264543799724;15178.848211517881;19710.70433943492;20634.690479642817;21032.36902892912;21074.789252107475;18147.546311342223;19761.011949402546;20236.494087647818;20715.792842071613;21141.471463213427;5949.286085669725;6037.184980027706;6039.275286965549;6086.056661217518;6134.110553969672;5907.616004959686;6049.788257410992;6064.757409703607;6095.207623009002;6097.05495648173;5857.619254748428;5958.195643588125;6032.457078862902;6045.365236650155;6065.545084118687;5859.44335288147;5898.351181370046;6031.758729650831;6044.758209671608;6058.727357268934;5129.0767661820855;5177.249298851645;5239.423663397023;5240.082985477527;5244.082285600043;25034.874825625757;25540.489190216093;25564.105256316125;25699.229023129148;25741.871290643616;2215.667649852519;2442.1696623148214;2457.213691618683;2682.5707886738223;2878.5250433678625;14467.71064578713;15660.294528475095;16118.838811611968;16226.756598651029;16418.26117824701;1860.2280053777802;1906.2946709717355;1941.2332128809041;1944.0765636322774;1962.5289930416598;124706;126670;126709.36645316807;129472.3526382362;130243;11133.554657813596;11507.942460287812;11639.359835208976;11728.237664551776;11760.411979400995;14447.349869255699;14453.349599268058;14475.420983160766;14490.492832751013;14516.85483145155;7133.643317834088;8288.958555207186;8412.831743365221;8557.10150434208;8689.739307820775;7031.367176954099;8456.619452124669;8549.358798090168;8582.227599516074;8688.739337819876;4486.080353527519;4497.977510112429;4508.143452743968;4549.249373853278;4646.86059418218;1682.779984511244;1922.1158267196965;1964.931227407034;1977.4067779666043;1979.3567090695294;808.8261023879894;826.1820797410641;837.4556538250187;842.664376962509;909.8374934673893;20352.898235509023;21182.411319151124;21957.341279761633;21984.90075496219;22013;968.6561270748923;975.1321324021626;1004.9547770350351;1005.9295849290626;1075.7848430313968;8150.75547733569;10786.730331741612;11519;11519.71200719972;11543.19197656156;604379;604557;606361;624130;626012;137364;146176;149725.7541136884;150847;151175;946.1626460582435;979.3829887171037;983.1986930651497;998.4259051045677;1001.7946321004176;16483.92854464456;17361.826381736526;19302.938338391523;19484.707729383786;19545.511362216057;51767;56155.15767263576;58280.12579811391;58897.34961926809;59676.40323596708;87523.56238218768;89282.10717892738;89408;89840.5507972456;90789;6220.315765265726;7453.478256521991;7469.850602988018;7487.925120748723;7797.298243158143;11968.281903085843;13345.866541334462;13471.057026008086;13866.168029918237;13988.860111398755;10691.144708423151;11618.360990145624;11961.342126183143;11982.760344792881;12062;9881.160101391462;11407.087433005174;11715.355655438692;11837.607691846306;12001.519939202333;11720.589779357682;12018.459169337575;12089.274643521418;12095.274283543016;12120.212186207867;7413.962930185315;7626.656800443882;7658.617069146632;7847.9607601961625;7864.4888082274465;11606.825897611374;11622.360770157722;11645.825312620149;12024.158308918291;12035.879641203826 07:25:52 INFO - PROCESS | 1659 | |3;mootools.html;1515.530185642451;1545.1270032431676;1741.6603762266354;1806.4038867173833;1844.206990993873;7879.093904201019;8345;8508.191721786421;8895.199432051106;8904.91095089049;8609;8684.478931264128;8690.565471726404;8706.477611343324;8733.606987685553;1801.4235444657716;2020.8080232377902;2264.750877403484;2320.2807129789735;2328.1967721136266;2273.5566564519927;2287.3824067501764;2357.1043003658588;2360.126753101355;2362.4093976505874;2341.0869760793303;2347.7065366829147;2350.764923507653;2365.976340236593;2367.0413482539598;2305.9077636894503;2314.3982564533344;2316;2327.9185228517003;2328.988355058222;2315.2706897327457;2315.3401280635107;2316.3630001749652;2322.6632138340015;2327.476317828475;8765.956170219171;8776.736697899074;8796.912030879674;8828.24959878411;8882.555872206363;5125.743712814382;5237;5309.946900530984;5310.097283461821;5310.893782124336;3390;3453.9827300863585;3459;3512.4204506256438;3627.9274414511824;916.6929078758624;1085.8208395614713;1089.3028461784463;1098.4617537406614;1107.6843099716623;11270.042046426064;11595.188336816425;11604.071674266039;11615.361155136465;11619.244749091282;4523.411956445641;4628.120657075212;4686.74222917736;4746.050789842046;4759.214729569651;9927.950360248153;9940.751481213027;9947.403155810674;9959.502024898871;9967;5239.973800130975;5250.684958902478;5257.08001099806;5272.762725677354;5274.7098909560345;4308.375285583573;4672.275797251432;4791.041791641685;4817.927731084036;4851.34506841579;3851.7496362736333;3874.4769456123627;3886.8639597613947;3980.164165525272;4008.2785098682516;1101.4437708956925;1279.9168054076642;1283.6790802299424;1295.7343744532348;1306.0922658752265;809.5830647216688;817.8037271054905;870.3254977392571;975.878015248094;988.0860204310984;5406.810761623325;5804.477597016289;6083.300420451616;6110.358412366726;6186.721597528122;387.75183882315343;456.52065331401894;457.95191504891505;924.6948506992676;1038.402918321968;3926.959355770723;3945.151792364655;4023.376376661622;4140.275451795924;4176.373543968369;8378.371622128243;8998.59506322217;10657.84013239802;10826.56693732242;10832.891671083189;8937.955310223537;10624.990625890528;10758.78482430347;10791.190660700478;10814.243002989873;8047.83904321922;8190.058143313476;8196.34429245659;8271.669133234724;8313.210245026834;5794.565407594363;5888.146218798336;6024.1265016573225;6085.1480792689945;6099.512039036955;10032.598696052077;10058.04448577384;10093.848592270975;10128.898711012796;10132.138768204784;9997.600095996078;10036.146927510952;10062.849057264293;10147.325691261154;10208.438535880598;6577.2436169841085;6955.930440695528;7032.648367581498;7163.820904477221;7179.210286868336;8371.204735550113;8440.409171358191;8502.319814414956;8545.74362769118;8551.486910785372;6880.0367948486255;7469.439792015729;7557.697692092474;7630.656620452204;7758.922410776046;6978.47661425385;7184.928150718635;7373.225811289737;7461.813454663677;7539.170691224071;6965.616891071039;6976.372126508639;7071.151461824614;7072.292770722886;7085.929140708733;4944.456109827845;4997.900041999213;5001;5079.111155547838;5178.378594568525;4071.6946229032346;5083.593312534915;5130.050940575856;5248.868778280574;5276.445973172762 07:25:52 INFO - PROCESS | 1659 | |4;prototype.html;309.9225193701575;314.97322727568155;317.02672794520817;317.8410794602697;321.54661926683383;5695.035212851565;5731.942680573198;5732.5127364173995;5756.280464941882;5766.567507436938;5658.264425624663;5672.489475947164;5727.140928860673;5748.5975981681295;5751.8718074312565;3572.5534308211472;3933.606639336072;4165.354370072629;4256.744595324275;4305.6124948754605;3576.517170182018;3810.1808111256073;3947.8026098695095;4309.547497512763;4339.479262488506;4276.246738837078;4303.956960430387;4313.986213239902;4321.848735294266;4330.899513735835;3745.9324092633606;3905.1799122184234;4246.978765106154;4276.123394704078;4308.919122827162;2756.3935934094466;3691.7969511676847;3711.4432835074685;3715.399220545629;3720.6465385788306;4788.425388953313;5014.874628134289;5352.732363381815;5512.889742205133;5521.282233309684;4758.5241475852135;4926.4827193144565;4929.2359684248995;4973.179425394806;4976.034466385793;5436.728163591844;5657.09486482165;5975.671338076404;6009.699515024231;6016.729247183887;3113.6886311368908;4050.3316952702767;4107.445494858216;4137.81379837908;4140.772257525835;5925.8814823703715;5966.701664916737;6228.937710622881;6286.811395658137;6296;3336.7664263501806;3743.5507739071486;3859.517560304962;4022.3597644132105;4180.184863951561;3546.343926373629;3907.1404291055924;4155.355919832431;4183.807614829759;4279.422277992431;4029.959700403017;4118;4190.9673808203;4830.7101573905675;4947.5794557462295;5915.970420147872;5923;5947.167396564484;5995.912105265792;6093.573449858556;1232.2852745407642;1237.7400745843295;1312.6980794417339;1424.2309153057233;1457.2203870929002;728.9198188199293;875.8292133034124;891.4562117108559;891.8974317953389;897.2239013253488;4714.585624312693;4861.343718598015;5545.805896793593;5578.246936663499;5592.356878958972;5534.225208470817;5679.1258884568;5750.741216645178;6170.444659980533;6232.657203853741;5360.016793786324;5515.40053384514;5592.077307244259;5608.495235428831;5616.297962754656;2702.7837772978114;2799.656165040751;2894.6526416830116;3251.804891706458;3261.2010057536054;6124.785632502841;6166.784162554289;6395.2645445773405;6475.32009139043;6479.44924681398;5664.405237450009;6292.622442653455;6329.398707122816;6360.872782544323;6402.167718196604;6230.906536402048;6383.936160638427;6413.29453760086;6424.775132870421;6434.420902118832;5260.500252476008;5496.780128794803;5897.469227769521;5901.026330655393;6286.842828929313;5731.3122425307565;6120.540959427972;6126.479249263863;6153.476954458921;6262.624242545462;5864;6007.8197654070445;6298.464630506458;6391.96804015977;6448;3679.6688298053305;3873.2447172801035;4180.435641188401;4187.623113919762;4189.916201675888;5435;5921.230240068763;6210.4100110489435;6239.251289845248;6261.217347831521;5060.949390506048;5632.901584191043;6043.969780151071;6056.848578785565;6116.969415152896;5267.499587539178;6065.423784740443;6109.7861574844665;6127.724252408563;6149.169862068564;5463.863403414946;5670.262865827416;5937.6061714331945;5943.257092863392;6005.579609427473;6039;6061.636301821904;6062.484688801501;6069.968105422001;6133.160051984476;5154.61340399479;5872.29532456108;5876.764929402776;5935.376785437639;5976.3127240366175 07:25:52 INFO - PROCESS | 1659 | |5;yui.html;670.4066900792797;722.4725950056458;724.3010494872447;733.6991833348328;770.7456539342018;15145.621359466006;15792.368305267804;15966;16022.599435014115;16038.957467764587;14463.493777717782;14550.272486375692;14562.470940551248;14587.41650333988;14626.122432654049;702.3222590200455;853.8121613245077;864.8270345930807;873.7247766953421;894.9328800339968;877.6006916852816;885.4908427654093;891.9598618062171;893.9731808045769;898.9640414383449;923.2890674180877;940.5344354544476;945.9479728614923;946.1201082992814;946.2146418472652;902.9909700903005;917.1104029091771;932.4824722279133;933.7712260496188;936.2884208001899;683.0846665468247;695.9060526828864;702.0101656664079;702.6732569355223;705.2665228162705;14587.781183282259;14778.852211477855;14949.252537373197;14982.026168299135;15024.849751502454;12869.549565765154;14712.779308310277;14779;14809.629759255997;14846.70306593873;9923.553440095213;10384.792304153874;11586.84131586843;11884.821727674092;12260.509579616804;3835.1562656215588;3855.2096820152083;3880.6507414332564;3910.530736311661;4000.9199816003807;101839.99999999926;117126;118582;119592;123152.14782817353;9567.186789123003;11149.108071354272;11293.548258069584;11458.369789661649;11957.162998590014;22426.551468970854;22451.438714031952;22522.21172258963;22553.548929021326;22587;7582.810429739301;8204.958975205085;8256.752297431087;8313.293370063613;8322.16778322163;4515.006698526319;4534.682572219979;4644.149878928621;4666.066786642617;4844.491328410537;3591.5690117186105;3673.3755261605593;3703.6111208323277;3724.404095344732;3733.9626603733614;662.9734810607522;668.1314291421133;674.8110529051874;679.6975345970995;682.668905580793;591.7248479457073;667.8998150277497;689.3588962265042;694.6144889586227;696.8675951569186;8929.553522323858;9396.107369799858;9481.66814161501;9485.762855928657;9560.426374417557;643.6652940470929;647.8930976388843;666.7732970789858;676.2865177237962;712.654362634122;4166.979165104155;4605.608523275492;4617.492075871652;4638.652101092432;4687.7656117194;101560.33616470313;131319.3434032843;164905;166343;167514.3248567523;74020;84890.57554712311;118952.24191032434;122476.61434453007;138533.14668533066;89768.5511572451;93208.53395732978;97118.02881971232;109611;125931.37034314952;8188;9393.671221507215;9402.858957115512;10173.949130254598;10182.643607473703;56192.71903640455;56758.432415676965;57023.71488142533;57077.429225708875;60769;54675;54744.45255547394;78016.60991695005;84782;87695.56152219453;12961.675958101123;13049.34753262314;13240.933795330962;13376.331183440983;13440.596782096552;14548.636284092983;15032.624184395478;15170.165640889856;15171.24143792828;15231.847681523042;13723.656908577366;13850.307484625528;13872.098313609584;13966.231857247949;14550.563483095524;11838.467268972745;13945.651358715708;14005.159690418608;14053.22707251111;14601.342939567532;13646.24945628;13737.519186828413;13889.65275868071;14071.437142514185;14202.360893759598;11137.888621114009;11424;11456.427178641201;11562.537498499965;11634.6509604712;10721.30311529748;10743.355398676105;11241.831372529256;11589.594364197214;11788.410579471163 07:25:52 INFO - PROCESS | 1659 | __end_tp_report 07:25:52 INFO - PROCESS | 1659 | __start_cc_report 07:25:52 INFO - PROCESS | 1659 | _x_x_mozilla_cycle_collect,424 07:25:52 INFO - PROCESS | 1659 | __end_cc_report 07:25:52 INFO - PROCESS | 1659 | __startTimestamp1470752752830__endTimestamp 07:25:52 INFO - PROCESS | 1659 | 07:25:52 INFO - PROCESS | 1659 | ------- Summary: start ------- 07:25:52 INFO - PROCESS | 1659 | Number of tests: 6 07:25:52 INFO - PROCESS | 1659 | 07:25:52 INFO - PROCESS | 1659 | [#0] dojo.html Cycles:165 Average:5687.69 Median:5782.80 stddev:620.06 (10.7%) stddev-sans-first:595.23 07:25:52 INFO - PROCESS | 1659 | Values: 3391.7 3395.8 3412.0 3426.5 3430.2 5617.7 5720.7 5751.8 5779.1 5836.8 4586.7 5618.7 5731.0 5751.2 5770.5 5152.1 5200.9 5235.9 5304.9 5328.7 5316.4 5354.5 5392.2 5422.4 5436.8 5119.5 5204.2 5247.8 5274.9 5336.7 5242.8 5268.7 5301.5 5305.5 5355.4 5174.0 5189.4 5215.1 5285.4 5293.4 5032.1 5529.2 5597.9 5758.5 5789.1 5637.0 5721.5 6068.8 6207.9 6238.8 6197.7 6241.2 6285.9 6293.6 6297.6 5695.2 5814.1 5861.6 5882.2 5925.6 6148.6 6170.2 6213.5 6217.2 6295.8 5764.9 5829.5 6063.5 6125.1 6137.5 5158.4 6162.8 6179.8 6259.4 6288.3 6190.2 6211.1 6224.4 6238.3 6246.8 6149.5 6226.6 6228.5 6235.5 6255.1 4893.2 4987.1 5029.1 5032.3 5056.3 4427.7 4500.8 4513.6 4523.8 4556.8 5734.7 5830.1 5835.8 5842.1 5862.6 6115.7 6138.8 6184.6 6214.3 6262.2 5762.9 5782.6 5793.0 5801.6 5875.0 5425.3 5451.0 5479.8 5487.1 5491.6 6133.4 6251.7 6286.0 6314.9 6330.4 6182.8 6240.4 6246.1 6247.3 6249.6 6279.2 6312.8 6334.7 6342.4 6377.0 6089.6 6141.3 6146.5 6155.1 6256.2 6170.5 6213.7 6231.9 6239.6 6287.9 5296.7 6133.9 6149.4 6165.3 6173.9 5730.9 5738.1 5751.9 5997.4 6162.0 5324.9 5573.8 5648.8 5655.7 5731.9 4768.3 4789.2 5232.6 5782.8 5807.7 5619.9 5634.1 5640.9 5695.8 5834.2 07:25:52 INFO - PROCESS | 1659 | 07:25:52 INFO - PROCESS | 1659 | [#1] ext.html Cycles:180 Average:69488.64 Median:38720.31 stddev:157883.79 (407.8%) stddev-sans-first:158241.60 07:25:52 INFO - PROCESS | 1659 | Values: 449.3 490.4 501.9 505.2 551.1 37946.4 40173.0 40211.8 40268.0 40451.6 40832.8 40859.6 41426.2 41470.0 41501.8 9633.9 9708.5 9736.2 9795.7 9820.3 9658.0 9676.8 9724.0 9786.7 9791.4 9721.1 9791.3 9812.2 9821.0 9869.0 9726.5 9766.1 9767.4 9776.9 9812.1 9526.5 9560.3 9620.8 9628.3 9658.1 38362.0 38371.4 38575.4 38847.2 38941.4 3028.4 3314.8 3325.6 3393.3 3423.7 30257.8 30288.4 30442.7 30562.2 30728.2 3119.3 3125.5 3131.1 3161.3 3233.6 465025.0 468544.0 470726.0 474124.0 474300.0 32474.4 32589.0 32614.8 32628.2 32640.3 33442.0 33602.2 33759.7 34783.7 34877.7 16382.0 16529.3 16599.3 16642.2 16668.0 12463.8 12575.9 12595.2 12602.6 12617.4 18501.0 18811.8 19014.6 19041.6 19149.8 7669.4 7907.7 7928.2 7946.2 8013.9 876.8 953.3 964.1 1004.4 1029.7 23020.5 29873.0 30372.4 30669.8 31092.2 1013.7 1056.2 1058.6 1097.4 1097.9 12003.9 14318.4 15821.4 15942.7 16090.4 710933.0 714316.0 716304.0 716560.0 720244.0 57946.0 58469.1 58725.7 59043.0 59354.4 1337.3 1355.5 1369.1 1369.3 1370.4 28065.0 28224.6 29294.9 29901.9 30731.7 49382.3 49717.0 49719.8 49736.0 49811.3 470791.0 569104.0 569648.0 572489.0 576849.0 21898.6 26243.9 26331.2 26681.9 26750.5 47647.3 47668.0 47895.3 49091.0 49262.0 31536.2 39623.8 40438.6 40792.7 41307.6 38651.2 39633.0 39748.0 40734.0 41256.8 37483.6 38199.4 38653.0 38787.6 39040.8 27597.7 34731.3 34789.7 34919.3 35140.5 25633.4 25658.7 25721.7 26234.5 26401.0 07:25:52 INFO - PROCESS | 1659 | 07:25:52 INFO - PROCESS | 1659 | [#2] jquery.html Cycles:180 Average:36847.25 Median:25287.68 stddev:103081.07 (407.6%) stddev-sans-first:103333.83 07:25:52 INFO - PROCESS | 1659 | Values: 357.2 371.2 377.3 385.2 399.0 15178.8 19710.7 20634.7 21032.4 21074.8 18147.5 19761.0 20236.5 20715.8 21141.5 5949.3 6037.2 6039.3 6086.1 6134.1 5907.6 6049.8 6064.8 6095.2 6097.1 5857.6 5958.2 6032.5 6045.4 6065.5 5859.4 5898.4 6031.8 6044.8 6058.7 5129.1 5177.2 5239.4 5240.1 5244.1 25034.9 25540.5 25564.1 25699.2 25741.9 2215.7 2442.2 2457.2 2682.6 2878.5 14467.7 15660.3 16118.8 16226.8 16418.3 1860.2 1906.3 1941.2 1944.1 1962.5 124706.0 126670.0 126709.4 129472.4 130243.0 11133.6 11507.9 11639.4 11728.2 11760.4 14447.3 14453.3 14475.4 14490.5 14516.9 7133.6 8289.0 8412.8 8557.1 8689.7 7031.4 8456.6 8549.4 8582.2 8688.7 4486.1 4498.0 4508.1 4549.2 4646.9 1682.8 1922.1 1964.9 1977.4 1979.4 808.8 826.2 837.5 842.7 909.8 20352.9 21182.4 21957.3 21984.9 22013.0 968.7 975.1 1005.0 1005.9 1075.8 8150.8 10786.7 11519.0 11519.7 11543.2 604379.0 604557.0 606361.0 624130.0 626012.0 137364.0 146176.0 149725.8 150847.0 151175.0 946.2 979.4 983.2 998.4 1001.8 16483.9 17361.8 19302.9 19484.7 19545.5 51767.0 56155.2 58280.1 58897.3 59676.4 87523.6 89282.1 89408.0 89840.6 90789.0 6220.3 7453.5 7469.9 7487.9 7797.3 11968.3 13345.9 13471.1 13866.2 13988.9 10691.1 11618.4 11961.3 11982.8 12062.0 9881.2 11407.1 11715.4 11837.6 12001.5 11720.6 12018.5 12089.3 12095.3 12120.2 7414.0 7626.7 7658.6 7848.0 7864.5 11606.8 11622.4 11645.8 12024.2 12035.9 07:25:52 INFO - PROCESS | 1659 | 07:25:52 INFO - PROCESS | 1659 | [#3] mootools.html Cycles:180 Average:5658.48 Median:4971.18 stddev:3175.73 (63.9%) stddev-sans-first:3169.38 07:25:52 INFO - PROCESS | 1659 | Values: 1515.5 1545.1 1741.7 1806.4 1844.2 7879.1 8345.0 8508.2 8895.2 8904.9 8609.0 8684.5 8690.6 8706.5 8733.6 1801.4 2020.8 2264.8 2320.3 2328.2 2273.6 2287.4 2357.1 2360.1 2362.4 2341.1 2347.7 2350.8 2366.0 2367.0 2305.9 2314.4 2316.0 2327.9 2329.0 2315.3 2315.3 2316.4 2322.7 2327.5 8766.0 8776.7 8796.9 8828.2 8882.6 5125.7 5237.0 5309.9 5310.1 5310.9 3390.0 3454.0 3459.0 3512.4 3627.9 916.7 1085.8 1089.3 1098.5 1107.7 11270.0 11595.2 11604.1 11615.4 11619.2 4523.4 4628.1 4686.7 4746.1 4759.2 9928.0 9940.8 9947.4 9959.5 9967.0 5240.0 5250.7 5257.1 5272.8 5274.7 4308.4 4672.3 4791.0 4817.9 4851.3 3851.7 3874.5 3886.9 3980.2 4008.3 1101.4 1279.9 1283.7 1295.7 1306.1 809.6 817.8 870.3 975.9 988.1 5406.8 5804.5 6083.3 6110.4 6186.7 387.8 456.5 458.0 924.7 1038.4 3927.0 3945.2 4023.4 4140.3 4176.4 8378.4 8998.6 10657.8 10826.6 10832.9 8938.0 10625.0 10758.8 10791.2 10814.2 8047.8 8190.1 8196.3 8271.7 8313.2 5794.6 5888.1 6024.1 6085.1 6099.5 10032.6 10058.0 10093.8 10128.9 10132.1 9997.6 10036.1 10062.8 10147.3 10208.4 6577.2 6955.9 7032.6 7163.8 7179.2 8371.2 8440.4 8502.3 8545.7 8551.5 6880.0 7469.4 7557.7 7630.7 7758.9 6978.5 7184.9 7373.2 7461.8 7539.2 6965.6 6976.4 7071.2 7072.3 7085.9 4944.5 4997.9 5001.0 5079.1 5178.4 4071.7 5083.6 5130.1 5248.9 5276.4 07:25:52 INFO - PROCESS | 1659 | 07:25:52 INFO - PROCESS | 1659 | [#4] prototype.html Cycles:180 Average:4839.03 Median:5592.22 stddev:1554.15 (27.8%) stddev-sans-first:1520.88 07:25:52 INFO - PROCESS | 1659 | Values: 309.9 315.0 317.0 317.8 321.5 5695.0 5731.9 5732.5 5756.3 5766.6 5658.3 5672.5 5727.1 5748.6 5751.9 3572.6 3933.6 4165.4 4256.7 4305.6 3576.5 3810.2 3947.8 4309.5 4339.5 4276.2 4304.0 4314.0 4321.8 4330.9 3745.9 3905.2 4247.0 4276.1 4308.9 2756.4 3691.8 3711.4 3715.4 3720.6 4788.4 5014.9 5352.7 5512.9 5521.3 4758.5 4926.5 4929.2 4973.2 4976.0 5436.7 5657.1 5975.7 6009.7 6016.7 3113.7 4050.3 4107.4 4137.8 4140.8 5925.9 5966.7 6228.9 6286.8 6296.0 3336.8 3743.6 3859.5 4022.4 4180.2 3546.3 3907.1 4155.4 4183.8 4279.4 4030.0 4118.0 4191.0 4830.7 4947.6 5916.0 5923.0 5947.2 5995.9 6093.6 1232.3 1237.7 1312.7 1424.2 1457.2 728.9 875.8 891.5 891.9 897.2 4714.6 4861.3 5545.8 5578.2 5592.4 5534.2 5679.1 5750.7 6170.4 6232.7 5360.0 5515.4 5592.1 5608.5 5616.3 2702.8 2799.7 2894.7 3251.8 3261.2 6124.8 6166.8 6395.3 6475.3 6479.4 5664.4 6292.6 6329.4 6360.9 6402.2 6230.9 6383.9 6413.3 6424.8 6434.4 5260.5 5496.8 5897.5 5901.0 6286.8 5731.3 6120.5 6126.5 6153.5 6262.6 5864.0 6007.8 6298.5 6392.0 6448.0 3679.7 3873.2 4180.4 4187.6 4189.9 5435.0 5921.2 6210.4 6239.3 6261.2 5060.9 5632.9 6044.0 6056.8 6117.0 5267.5 6065.4 6109.8 6127.7 6149.2 5463.9 5670.3 5937.6 5943.3 6005.6 6039.0 6061.6 6062.5 6070.0 6133.2 5154.6 5872.3 5876.8 5935.4 5976.3 07:25:52 INFO - PROCESS | 1659 | 07:25:52 INFO - PROCESS | 1659 | [#5] yui.html Cycles:180 Average:23625.52 Median:3845.18 stddev:37540.47 (976.3%) stddev-sans-first:37606.21 07:25:52 INFO - PROCESS | 1659 | Values: 670.4 722.5 724.3 733.7 770.7 15145.6 15792.4 15966.0 16022.6 16039.0 14463.5 14550.3 14562.5 14587.4 14626.1 702.3 853.8 864.8 873.7 894.9 877.6 885.5 892.0 894.0 899.0 923.3 940.5 945.9 946.1 946.2 903.0 917.1 932.5 933.8 936.3 683.1 695.9 702.0 702.7 705.3 14587.8 14778.9 14949.3 14982.0 15024.8 12869.5 14712.8 14779.0 14809.6 14846.7 9923.6 10384.8 11586.8 11884.8 12260.5 3835.2 3855.2 3880.7 3910.5 4000.9 101840.0 117126.0 118582.0 119592.0 123152.1 9567.2 11149.1 11293.5 11458.4 11957.2 22426.6 22451.4 22522.2 22553.5 22587.0 7582.8 8205.0 8256.8 8313.3 8322.2 4515.0 4534.7 4644.1 4666.1 4844.5 3591.6 3673.4 3703.6 3724.4 3734.0 663.0 668.1 674.8 679.7 682.7 591.7 667.9 689.4 694.6 696.9 8929.6 9396.1 9481.7 9485.8 9560.4 643.7 647.9 666.8 676.3 712.7 4167.0 4605.6 4617.5 4638.7 4687.8 101560.3 131319.3 164905.0 166343.0 167514.3 74020.0 84890.6 118952.2 122476.6 138533.1 89768.6 93208.5 97118.0 109611.0 125931.4 8188.0 9393.7 9402.9 10173.9 10182.6 56192.7 56758.4 57023.7 57077.4 60769.0 54675.0 54744.5 78016.6 84782.0 87695.6 12961.7 13049.3 13240.9 13376.3 13440.6 14548.6 15032.6 15170.2 15171.2 15231.8 13723.7 13850.3 13872.1 13966.2 14550.6 11838.5 13945.7 14005.2 14053.2 14601.3 13646.2 13737.5 13889.7 14071.4 14202.4 11137.9 11424.0 11456.4 11562.5 11634.7 10721.3 10743.4 11241.8 11589.6 11788.4 07:25:52 INFO - PROCESS | 1659 | -------- Summary: end -------- 07:25:52 INFO - PROCESS | 1659 | 07:25:53 INFO - TEST-INFO | 1659: exit 0 07:25:53 INFO - TEST-OK | dromaeo_css | took 1114551ms 07:25:53 INFO - TEST-START | kraken 07:25:53 INFO - operating with platform_type : mac_ 07:25:53 INFO - Initialising browser for kraken test... 07:25:53 INFO - TEST-INFO | started process 1668 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/tmpJeUDC_/profile http://localhost:49266/getInfo.html) 07:25:56 INFO - PROCESS | 1668 | __metrics Screen width/height:1600/1200 07:25:56 INFO - PROCESS | 1668 | colorDepth:24 07:25:56 INFO - PROCESS | 1668 | Browser inner width/height: 1024/689 07:25:56 INFO - PROCESS | 1668 | __metrics 07:25:56 ERROR - PROCESS | 1668 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 07:25:57 INFO - TEST-INFO | 1668: exit 0 07:25:57 INFO - Browser initialized. 07:25:57 INFO - Running cycle 1/1 for kraken test... 07:25:57 INFO - TEST-INFO | started process 1670 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/tmpJeUDC_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:26:09 INFO - PROCESS | 1670 | RSS: Main: 254918656 07:26:09 INFO - PROCESS | 1670 | 07:26:12 INFO - PROCESS | 1670 | 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) 07:26:13 INFO - PROCESS | 1670 | RSS: Main: 267550720 07:26:13 INFO - PROCESS | 1670 | 07:26:15 INFO - PROCESS | 1670 | 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) 07:26:16 INFO - PROCESS | 1670 | RSS: Main: 276172800 07:26:16 INFO - PROCESS | 1670 | 07:26:19 INFO - PROCESS | 1670 | 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) 07:26:20 INFO - PROCESS | 1670 | RSS: Main: 279121920 07:26:20 INFO - PROCESS | 1670 | 07:26:22 INFO - PROCESS | 1670 | 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) 07:26:23 INFO - PROCESS | 1670 | RSS: Main: 280514560 07:26:23 INFO - PROCESS | 1670 | 07:26:25 INFO - PROCESS | 1670 | 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) 07:26:25 INFO - PROCESS | 1670 | RSS: Main: 280879104 07:26:25 INFO - PROCESS | 1670 | 07:26:28 INFO - PROCESS | 1670 | 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) 07:26:29 INFO - PROCESS | 1670 | RSS: Main: 282173440 07:26:29 INFO - PROCESS | 1670 | 07:26:32 INFO - PROCESS | 1670 | 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) 07:26:32 INFO - PROCESS | 1670 | RSS: Main: 282378240 07:26:32 INFO - PROCESS | 1670 | 07:26:36 INFO - PROCESS | 1670 | 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) 07:26:36 INFO - PROCESS | 1670 | RSS: Main: 282492928 07:26:36 INFO - PROCESS | 1670 | 07:26:38 INFO - PROCESS | 1670 | 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) 07:26:39 INFO - PROCESS | 1670 | RSS: Main: 282316800 07:26:39 INFO - PROCESS | 1670 | 07:26:41 INFO - PROCESS | 1670 | 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) 07:26:41 INFO - PROCESS | 1670 | RSS: Main: 282394624 07:26:41 INFO - PROCESS | 1670 | 07:26:43 INFO - PROCESS | 1670 | 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) 07:26:44 INFO - PROCESS | 1670 | RSS: Main: 282767360 07:26:44 INFO - PROCESS | 1670 | 07:26:47 INFO - PROCESS | 1670 | 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) 07:26:48 INFO - PROCESS | 1670 | RSS: Main: 282918912 07:26:48 INFO - PROCESS | 1670 | 07:26:50 INFO - PROCESS | 1670 | 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) 07:26:51 INFO - PROCESS | 1670 | RSS: Main: 282730496 07:26:51 INFO - PROCESS | 1670 | 07:26:53 INFO - PROCESS | 1670 | 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) 07:26:53 INFO - PROCESS | 1670 | RSS: Main: 283451392 07:26:53 INFO - PROCESS | 1670 | 07:26:53 INFO - PROCESS | 1670 | __start_tp_report 07:26:53 INFO - PROCESS | 1670 | _x_x_mozilla_page_load 07:26:53 INFO - PROCESS | 1670 | _x_x_mozilla_page_load_details 07:26:53 INFO - PROCESS | 1670 | |i|pagename|runs| 07:26:53 INFO - PROCESS | 1670 | |0;ai-astar;130;109;149;172;138;120;115;119;117;119 07:26:53 INFO - PROCESS | 1670 | |1;audio-beat-detection;143;118;136;158;113;164;123;113;146;99 07:26:53 INFO - PROCESS | 1670 | |2;audio-dft;202;206;218;219;198;200;200;200;201;198 07:26:53 INFO - PROCESS | 1670 | |3;audio-fft;70;105;101;157;52;76;84;89;165;81 07:26:53 INFO - PROCESS | 1670 | |4;audio-oscillator;71;72;117;70;72;88;115;71;74;115 07:26:53 INFO - PROCESS | 1670 | |5;imaging-gaussian-blur;136;132;90;89;121;87;91;88;110;87 07:26:53 INFO - PROCESS | 1670 | |6;imaging-darkroom;95;96;95;95;110;95;151;139;95;97 07:26:53 INFO - PROCESS | 1670 | |7;imaging-desaturate;137;144;92;140;142;94;137;85;143;143 07:26:53 INFO - PROCESS | 1670 | |8;json-parse-financial;56;59;56;56;57;58;55;56;57;56 07:26:53 INFO - PROCESS | 1670 | |9;json-stringify-tinderbox;68;75;70;78;74;78;103;105;89;74 07:26:53 INFO - PROCESS | 1670 | |10;stanford-crypto-aes;87;86;84;82;87;83;85;87;90;85 07:26:53 INFO - PROCESS | 1670 | |11;stanford-crypto-ccm;139;141;135;159;147;150;133;138;171;131 07:26:53 INFO - PROCESS | 1670 | |12;stanford-crypto-pbkdf2;165;170;164;168;167;168;171;165;168;165 07:26:53 INFO - PROCESS | 1670 | |13;stanford-crypto-sha256-iterative;67;68;68;68;63;66;66;61;78;83 07:26:53 INFO - PROCESS | 1670 | __end_tp_report 07:26:53 INFO - PROCESS | 1670 | __start_cc_report 07:26:53 INFO - PROCESS | 1670 | _x_x_mozilla_cycle_collect,1042 07:26:53 INFO - PROCESS | 1670 | __end_cc_report 07:26:53 INFO - PROCESS | 1670 | __startTimestamp1470752813445__endTimestamp 07:26:53 INFO - PROCESS | 1670 | 07:26:53 INFO - PROCESS | 1670 | ------- Summary: start ------- 07:26:53 INFO - PROCESS | 1670 | Number of tests: 14 07:26:53 INFO - PROCESS | 1670 | 07:26:53 INFO - PROCESS | 1670 | [#0] ai-astar Cycles:10 Average:128.80 Median:125.00 stddev:19.30 (15.4%) stddev-sans-first:20.46 07:26:53 INFO - PROCESS | 1670 | Values: 130.0 109.0 149.0 172.0 138.0 120.0 115.0 119.0 117.0 119.0 07:26:53 INFO - PROCESS | 1670 | 07:26:53 INFO - PROCESS | 1670 | [#1] audio-beat-detection Cycles:10 Average:131.30 Median:144.50 stddev:21.39 (14.8%) stddev-sans-first:22.26 07:26:53 INFO - PROCESS | 1670 | Values: 143.0 118.0 136.0 158.0 113.0 164.0 123.0 113.0 146.0 99.0 07:26:53 INFO - PROCESS | 1670 | 07:26:53 INFO - PROCESS | 1670 | [#2] audio-dft Cycles:10 Average:204.20 Median:201.50 stddev:7.87 (3.9%) stddev-sans-first:8.31 07:26:53 INFO - PROCESS | 1670 | Values: 202.0 206.0 218.0 219.0 198.0 200.0 200.0 200.0 201.0 198.0 07:26:53 INFO - PROCESS | 1670 | 07:26:53 INFO - PROCESS | 1670 | [#3] audio-fft Cycles:10 Average:98.00 Median:73.00 stddev:36.48 (50.0%) stddev-sans-first:37.26 07:26:53 INFO - PROCESS | 1670 | Values: 70.0 105.0 101.0 157.0 52.0 76.0 84.0 89.0 165.0 81.0 07:26:53 INFO - PROCESS | 1670 | 07:26:53 INFO - PROCESS | 1670 | [#4] audio-oscillator Cycles:10 Average:86.50 Median:71.50 stddev:20.78 (29.1%) stddev-sans-first:21.27 07:26:53 INFO - PROCESS | 1670 | Values: 71.0 72.0 117.0 70.0 72.0 88.0 115.0 71.0 74.0 115.0 07:26:53 INFO - PROCESS | 1670 | 07:26:53 INFO - PROCESS | 1670 | [#5] imaging-gaussian-blur Cycles:10 Average:103.10 Median:87.50 stddev:19.86 (22.7%) stddev-sans-first:17.13 07:26:53 INFO - PROCESS | 1670 | Values: 136.0 132.0 90.0 89.0 121.0 87.0 91.0 88.0 110.0 87.0 07:26:53 INFO - PROCESS | 1670 | 07:26:53 INFO - PROCESS | 1670 | [#6] imaging-darkroom Cycles:10 Average:106.80 Median:95.00 stddev:20.84 (21.9%) stddev-sans-first:21.66 07:26:53 INFO - PROCESS | 1670 | Values: 95.0 96.0 95.0 95.0 110.0 95.0 151.0 139.0 95.0 97.0 07:26:53 INFO - PROCESS | 1670 | 07:26:53 INFO - PROCESS | 1670 | [#7] imaging-desaturate Cycles:10 Average:125.70 Median:143.50 stddev:24.62 (17.2%) stddev-sans-first:25.77 07:26:53 INFO - PROCESS | 1670 | Values: 137.0 144.0 92.0 140.0 142.0 94.0 137.0 85.0 143.0 143.0 07:26:53 INFO - PROCESS | 1670 | 07:26:53 INFO - PROCESS | 1670 | [#8] json-parse-financial Cycles:10 Average:56.60 Median:56.50 stddev:1.17 (2.1%) stddev-sans-first:1.22 07:26:53 INFO - PROCESS | 1670 | Values: 56.0 59.0 56.0 56.0 57.0 58.0 55.0 56.0 57.0 56.0 07:26:53 INFO - PROCESS | 1670 | 07:26:53 INFO - PROCESS | 1670 | [#9] json-stringify-tinderbox Cycles:10 Average:81.40 Median:74.50 stddev:13.18 (17.7%) stddev-sans-first:13.06 07:26:53 INFO - PROCESS | 1670 | Values: 68.0 75.0 70.0 78.0 74.0 78.0 103.0 105.0 89.0 74.0 07:26:53 INFO - PROCESS | 1670 | 07:26:53 INFO - PROCESS | 1670 | [#10] stanford-crypto-aes Cycles:10 Average:85.60 Median:86.50 stddev:2.32 (2.7%) stddev-sans-first:2.40 07:26:53 INFO - PROCESS | 1670 | Values: 87.0 86.0 84.0 82.0 87.0 83.0 85.0 87.0 90.0 85.0 07:26:53 INFO - PROCESS | 1670 | 07:26:53 INFO - PROCESS | 1670 | [#11] stanford-crypto-ccm Cycles:10 Average:144.40 Median:144.00 stddev:12.64 (8.8%) stddev-sans-first:13.26 07:26:53 INFO - PROCESS | 1670 | Values: 139.0 141.0 135.0 159.0 147.0 150.0 133.0 138.0 171.0 131.0 07:26:53 INFO - PROCESS | 1670 | 07:26:53 INFO - PROCESS | 1670 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:167.10 Median:168.00 stddev:2.33 (1.4%) stddev-sans-first:2.35 07:26:53 INFO - PROCESS | 1670 | Values: 165.0 170.0 164.0 168.0 167.0 168.0 171.0 165.0 168.0 165.0 07:26:53 INFO - PROCESS | 1670 | 07:26:53 INFO - PROCESS | 1670 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.80 Median:68.00 stddev:6.68 (9.8%) stddev-sans-first:7.05 07:26:53 INFO - PROCESS | 1670 | Values: 67.0 68.0 68.0 68.0 63.0 66.0 66.0 61.0 78.0 83.0 07:26:53 INFO - PROCESS | 1670 | -------- Summary: end -------- 07:26:53 INFO - PROCESS | 1670 | 07:26:54 INFO - TEST-INFO | 1670: exit 0 07:26:54 INFO - TEST-OK | kraken | took 60741ms 07:26:54 INFO - SUITE-END | took 1175s 07:26:54 INFO - Completed test suite (00:19:35) 07:26:54 INFO - javascript benchmark 07:26:54 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7401.136921279174, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3391.711704505117, 3395.830208489575, 3412.0275721419403, 3426.503157042229, 3430.1939044324586, 5617.662940223589, 5720.742566584503, 5751.7699292028265, 5779.133130030492, 5836.824895253149, 4586.678932474728, 5618.662880227179, 5730.971345143268, 5751.223584816049, 5770.538356931446, 5152.072626927152, 5200.947990520084, 5235.947640523584, 5304.946950530484, 5328.706921119337, 5316.415194328621, 5354.544863686591, 5392.245085688007, 5422.4306447823, 5436.782528698847, 5119.539241468286, 5204.1673332266655, 5247.816326428595, 5274.868128296785, 5336.733163341817, 5242.764075616568, 5268.657537260104, 5301.549368303698, 5305.495977882095, 5355.384130824966, 5174.0, 5189.42916279209, 5215.061288967984, 5285.418603953601, 5293.391260005072, 5032.0690672225755, 5529.212489444743, 5597.860053498654, 5758.48173664368, 5789.07374820031, 5637.0, 5721.4850663440075, 6068.848278793022, 6207.937920620826, 6238.781642642486, 6197.686541230195, 6241.188645476059, 6285.9057114143325, 6293.559450838443, 6297.622142671455, 5695.231143795618, 5814.126689373667, 5861.5603829712945, 5882.235309409835, 5925.614835035666, 6148.569600128038, 6170.167027451326, 6213.5339849511465, 6217.191765070512, 6295.779647712399, 5764.942350576524, 5829.5044921181325, 6063.478916038454, 6125.081237814364, 6137.539684523589, 5158.432572417031, 6162.845928851814, 6179.81460556184, 6259.374062593704, 6288.27684816252, 6190.164327815777, 6211.130441738161, 6224.37756224383, 6238.251409830758, 6246.750129994749, 6149.477294429934, 6226.5641405102115, 6228.532860035515, 6235.501159907287, 6255.0617407388345, 4893.192623217201, 4987.10232158215, 5029.1450453423, 5032.295478632995, 5056.317397151338, 4427.734335939854, 4500.752458614807, 4513.616342610915, 4523.751193684379, 4556.84051058218, 5734.655920644775, 5830.067189249699, 5835.79574714883, 5842.065269556851, 5862.618929769551, 6115.696722738819, 6138.848241798255, 6184.628922264588, 6214.316425193225, 6262.1859158310035, 5762.88474230513, 5782.595218334676, 5792.9710351447975, 5801.593888427769, 5874.970625146847, 5425.294711687456, 5450.972745136249, 5479.780808767605, 5487.094629386186, 5491.615586908958, 6133.3866613338305, 6251.749930002749, 6286.0, 6314.905276420765, 6330.430261276507, 6182.814515564541, 6240.375962403905, 6246.063090536456, 6247.250329960434, 6249.625022498664, 6279.183706118175, 6312.842178945563, 6334.746610135543, 6342.39747224013, 6377.0, 6089.604175728564, 6141.332587233645, 6146.5248340398875, 6155.107509411021, 6256.186695729526, 6170.475509581735, 6213.65824879636, 6231.937680623136, 6239.594426362272, 6287.931051721127, 5296.708681022581, 6133.938660613337, 6149.354317796567, 6165.260168779775, 6173.9073913892225, 5730.914036289376, 5738.139279108167, 5751.913721294268, 5997.400259973968, 6162.044883043135, 5324.893502130013, 5573.7770489179975, 5648.774049037993, 5655.7172141393585, 5731.942680573141, 4768.3085952537385, 4789.185838407409, 5232.5552328052545, 5782.797602084075, 5807.738651760596, 5619.943800561942, 5634.070378387521, 5640.943590564042, 5695.772169113355, 5834.15404766315], "value": 5651.166407093037, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [449.27666457004216, 490.40415894687925, 501.92587861975403, 505.1942152267135, 551.1182108626199, 37946.430803537936, 40173.0, 40211.79894100533, 40268.0, 40451.58419455316, 40832.79583602085, 40859.59140408595, 41426.171476570526, 41470.0, 41501.7924910375, 9633.855492167622, 9708.466034368106, 9736.221102311798, 9795.706128816111, 9820.312578119534, 9658.0, 9676.75808104796, 9723.951380243088, 9786.657466988658, 9791.412515249072, 9721.125098741148, 9791.265655075898, 9812.165965892907, 9821.0, 9869.01309869011, 9726.513674316257, 9766.121049105579, 9767.365121267096, 9776.853347199798, 9812.067853553972, 9526.476043817587, 9560.330776845623, 9620.807583848284, 9628.3260171788, 9658.082482164184, 38362.0409489765, 38371.42442863331, 38575.42136867949, 38847.22305553873, 38941.41587876184, 3028.364043550857, 3314.834258287076, 3325.5676762021026, 3393.321335732863, 3423.726101911841, 30257.848710756305, 30288.394232115235, 30442.695573044206, 30562.235944101354, 30728.2317942051, 3119.2825650100376, 3125.484295091307, 3131.091983324833, 3161.2571045804216, 3233.5796346475045, 465025.0, 468544.0, 470726.0, 474124.0, 474300.0, 32474.35051299008, 32589.0, 32614.836925815693, 32628.184295392806, 32640.347193056004, 33442.0, 33602.15994600154, 33759.66240337614, 34783.652163478044, 34877.65122348795, 16382.0, 16529.33882644681, 16599.336026559045, 16642.16789160537, 16668.0, 12463.813042804366, 12575.931045861022, 12595.181313214613, 12602.558910438274, 12617.432215550321, 18501.0, 18811.81188188128, 19014.61970760577, 19041.61916761657, 19149.808501914802, 7669.38644908406, 7907.690308781728, 7928.1675424080795, 7946.205379462008, 8013.879791803011, 876.8202518483696, 953.2612225525273, 964.0793042644398, 1004.3873237325225, 1029.7271223125877, 23020.53958920812, 29872.954446594264, 30372.392552148835, 30669.8466507666, 31092.222694432367, 1013.6670278583639, 1056.2342301831266, 1058.6453538064834, 1097.3635291530893, 1097.8956999085074, 12003.879961200451, 14318.355673994694, 15821.446249381217, 15942.715527343318, 16090.436834710728, 710933.0, 714316.0, 716304.0, 716560.0, 720244.0, 57946.0, 58469.12296315558, 58725.706371468725, 59043.0, 59354.40645593575, 1337.25782190885, 1355.5323413422354, 1369.110078448996, 1369.2674419185687, 1370.3559327116438, 28065.017724379548, 28224.576631350956, 29294.853525732236, 29901.850490747405, 30731.692683073776, 49382.25926611032, 49717.0, 49719.751401242764, 49736.0, 49811.25283120684, 470791.0, 569104.0, 569648.0, 572489.0, 576849.0, 21898.562028759017, 26243.86878065674, 26331.21006369812, 26681.866590666923, 26750.46499069969, 47647.28529071997, 47668.04663906772, 47895.281570777166, 49091.0, 49262.0, 31536.211594710316, 39623.8081940391, 40438.59561404349, 40792.70953155359, 41307.58692413037, 38651.22697546089, 39633.009174770865, 39748.00629984274, 40734.0, 41256.79371603123, 37483.625163748016, 38199.42700859545, 38653.0, 38787.61212387953, 39040.80479597584, 27597.724022759514, 34731.30537389289, 34789.736208154536, 34919.30161396707, 35140.472892907135, 25633.359166021, 25658.743412566382, 25721.742782572685, 26234.4753104933, 26401.0], "value": 19282.289330578933, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [357.21591107519004, 371.2000638623765, 377.2737480350325, 385.1930206217974, 398.97264543799724, 15178.848211517881, 19710.70433943492, 20634.690479642817, 21032.36902892912, 21074.789252107475, 18147.546311342223, 19761.011949402546, 20236.494087647818, 20715.792842071613, 21141.471463213427, 5949.286085669725, 6037.184980027706, 6039.275286965549, 6086.056661217518, 6134.110553969672, 5907.616004959686, 6049.788257410992, 6064.757409703607, 6095.207623009002, 6097.05495648173, 5857.619254748428, 5958.195643588125, 6032.457078862902, 6045.365236650155, 6065.545084118687, 5859.44335288147, 5898.351181370046, 6031.758729650831, 6044.758209671608, 6058.727357268934, 5129.0767661820855, 5177.249298851645, 5239.423663397023, 5240.082985477527, 5244.082285600043, 25034.874825625757, 25540.489190216093, 25564.105256316125, 25699.229023129148, 25741.871290643616, 2215.667649852519, 2442.1696623148214, 2457.213691618683, 2682.5707886738223, 2878.5250433678625, 14467.71064578713, 15660.294528475095, 16118.838811611968, 16226.756598651029, 16418.26117824701, 1860.2280053777802, 1906.2946709717355, 1941.2332128809041, 1944.0765636322774, 1962.5289930416598, 124706.0, 126670.0, 126709.36645316807, 129472.3526382362, 130243.0, 11133.554657813596, 11507.942460287812, 11639.359835208976, 11728.237664551776, 11760.411979400995, 14447.349869255699, 14453.349599268058, 14475.420983160766, 14490.492832751013, 14516.85483145155, 7133.643317834088, 8288.958555207186, 8412.831743365221, 8557.10150434208, 8689.739307820775, 7031.367176954099, 8456.619452124669, 8549.358798090168, 8582.227599516074, 8688.739337819876, 4486.080353527519, 4497.977510112429, 4508.143452743968, 4549.249373853278, 4646.86059418218, 1682.779984511244, 1922.1158267196965, 1964.931227407034, 1977.4067779666043, 1979.3567090695294, 808.8261023879894, 826.1820797410641, 837.4556538250187, 842.664376962509, 909.8374934673893, 20352.898235509023, 21182.411319151124, 21957.341279761633, 21984.90075496219, 22013.0, 968.6561270748923, 975.1321324021626, 1004.9547770350351, 1005.9295849290626, 1075.7848430313968, 8150.75547733569, 10786.730331741612, 11519.0, 11519.71200719972, 11543.19197656156, 604379.0, 604557.0, 606361.0, 624130.0, 626012.0, 137364.0, 146176.0, 149725.7541136884, 150847.0, 151175.0, 946.1626460582435, 979.3829887171037, 983.1986930651497, 998.4259051045677, 1001.7946321004176, 16483.92854464456, 17361.826381736526, 19302.938338391523, 19484.707729383786, 19545.511362216057, 51767.0, 56155.15767263576, 58280.12579811391, 58897.34961926809, 59676.40323596708, 87523.56238218768, 89282.10717892738, 89408.0, 89840.5507972456, 90789.0, 6220.315765265726, 7453.478256521991, 7469.850602988018, 7487.925120748723, 7797.298243158143, 11968.281903085843, 13345.866541334462, 13471.057026008086, 13866.168029918237, 13988.860111398755, 10691.144708423151, 11618.360990145624, 11961.342126183143, 11982.760344792881, 12062.0, 9881.160101391462, 11407.087433005174, 11715.355655438692, 11837.607691846306, 12001.519939202333, 11720.589779357682, 12018.459169337575, 12089.274643521418, 12095.274283543016, 12120.212186207867, 7413.962930185315, 7626.656800443882, 7658.617069146632, 7847.9607601961625, 7864.4888082274465, 11606.825897611374, 11622.360770157722, 11645.825312620149, 12024.158308918291, 12035.879641203826], "value": 9843.215749555106, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1515.530185642451, 1545.1270032431676, 1741.6603762266354, 1806.4038867173833, 1844.206990993873, 7879.093904201019, 8345.0, 8508.191721786421, 8895.199432051106, 8904.91095089049, 8609.0, 8684.478931264128, 8690.565471726404, 8706.477611343324, 8733.606987685553, 1801.4235444657716, 2020.8080232377902, 2264.750877403484, 2320.2807129789735, 2328.1967721136266, 2273.5566564519927, 2287.3824067501764, 2357.1043003658588, 2360.126753101355, 2362.4093976505874, 2341.0869760793303, 2347.7065366829147, 2350.764923507653, 2365.976340236593, 2367.0413482539598, 2305.9077636894503, 2314.3982564533344, 2316.0, 2327.9185228517003, 2328.988355058222, 2315.2706897327457, 2315.3401280635107, 2316.3630001749652, 2322.6632138340015, 2327.476317828475, 8765.956170219171, 8776.736697899074, 8796.912030879674, 8828.24959878411, 8882.555872206363, 5125.743712814382, 5237.0, 5309.946900530984, 5310.097283461821, 5310.893782124336, 3390.0, 3453.9827300863585, 3459.0, 3512.4204506256438, 3627.9274414511824, 916.6929078758624, 1085.8208395614713, 1089.3028461784463, 1098.4617537406614, 1107.6843099716623, 11270.042046426064, 11595.188336816425, 11604.071674266039, 11615.361155136465, 11619.244749091282, 4523.411956445641, 4628.120657075212, 4686.74222917736, 4746.050789842046, 4759.214729569651, 9927.950360248153, 9940.751481213027, 9947.403155810674, 9959.502024898871, 9967.0, 5239.973800130975, 5250.684958902478, 5257.08001099806, 5272.762725677354, 5274.7098909560345, 4308.375285583573, 4672.275797251432, 4791.041791641685, 4817.927731084036, 4851.34506841579, 3851.7496362736333, 3874.4769456123627, 3886.8639597613947, 3980.164165525272, 4008.2785098682516, 1101.4437708956925, 1279.9168054076642, 1283.6790802299424, 1295.7343744532348, 1306.0922658752265, 809.5830647216688, 817.8037271054905, 870.3254977392571, 975.878015248094, 988.0860204310984, 5406.810761623325, 5804.477597016289, 6083.300420451616, 6110.358412366726, 6186.721597528122, 387.75183882315343, 456.52065331401894, 457.95191504891505, 924.6948506992676, 1038.402918321968, 3926.959355770723, 3945.151792364655, 4023.376376661622, 4140.275451795924, 4176.373543968369, 8378.371622128243, 8998.59506322217, 10657.84013239802, 10826.56693732242, 10832.891671083189, 8937.955310223537, 10624.990625890528, 10758.78482430347, 10791.190660700478, 10814.243002989873, 8047.83904321922, 8190.058143313476, 8196.34429245659, 8271.669133234724, 8313.210245026834, 5794.565407594363, 5888.146218798336, 6024.1265016573225, 6085.1480792689945, 6099.512039036955, 10032.598696052077, 10058.04448577384, 10093.848592270975, 10128.898711012796, 10132.138768204784, 9997.600095996078, 10036.146927510952, 10062.849057264293, 10147.325691261154, 10208.438535880598, 6577.2436169841085, 6955.930440695528, 7032.648367581498, 7163.820904477221, 7179.210286868336, 8371.204735550113, 8440.409171358191, 8502.319814414956, 8545.74362769118, 8551.486910785372, 6880.0367948486255, 7469.439792015729, 7557.697692092474, 7630.656620452204, 7758.922410776046, 6978.47661425385, 7184.928150718635, 7373.225811289737, 7461.813454663677, 7539.170691224071, 6965.616891071039, 6976.372126508639, 7071.151461824614, 7072.292770722886, 7085.929140708733, 4944.456109827845, 4997.900041999213, 5001.0, 5079.111155547838, 5178.378594568525, 4071.6946229032346, 5083.593312534915, 5130.050940575856, 5248.868778280574, 5276.445973172762], "value": 4511.690312074239, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [309.9225193701575, 314.97322727568155, 317.02672794520817, 317.8410794602697, 321.54661926683383, 5695.035212851565, 5731.942680573198, 5732.5127364173995, 5756.280464941882, 5766.567507436938, 5658.264425624663, 5672.489475947164, 5727.140928860673, 5748.5975981681295, 5751.8718074312565, 3572.5534308211472, 3933.606639336072, 4165.354370072629, 4256.744595324275, 4305.6124948754605, 3576.517170182018, 3810.1808111256073, 3947.8026098695095, 4309.547497512763, 4339.479262488506, 4276.246738837078, 4303.956960430387, 4313.986213239902, 4321.848735294266, 4330.899513735835, 3745.9324092633606, 3905.1799122184234, 4246.978765106154, 4276.123394704078, 4308.919122827162, 2756.3935934094466, 3691.7969511676847, 3711.4432835074685, 3715.399220545629, 3720.6465385788306, 4788.425388953313, 5014.874628134289, 5352.732363381815, 5512.889742205133, 5521.282233309684, 4758.5241475852135, 4926.4827193144565, 4929.2359684248995, 4973.179425394806, 4976.034466385793, 5436.728163591844, 5657.09486482165, 5975.671338076404, 6009.699515024231, 6016.729247183887, 3113.6886311368908, 4050.3316952702767, 4107.445494858216, 4137.81379837908, 4140.772257525835, 5925.8814823703715, 5966.701664916737, 6228.937710622881, 6286.811395658137, 6296.0, 3336.7664263501806, 3743.5507739071486, 3859.517560304962, 4022.3597644132105, 4180.184863951561, 3546.343926373629, 3907.1404291055924, 4155.355919832431, 4183.807614829759, 4279.422277992431, 4029.959700403017, 4118.0, 4190.9673808203, 4830.7101573905675, 4947.5794557462295, 5915.970420147872, 5923.0, 5947.167396564484, 5995.912105265792, 6093.573449858556, 1232.2852745407642, 1237.7400745843295, 1312.6980794417339, 1424.2309153057233, 1457.2203870929002, 728.9198188199293, 875.8292133034124, 891.4562117108559, 891.8974317953389, 897.2239013253488, 4714.585624312693, 4861.343718598015, 5545.805896793593, 5578.246936663499, 5592.356878958972, 5534.225208470817, 5679.1258884568, 5750.741216645178, 6170.444659980533, 6232.657203853741, 5360.016793786324, 5515.40053384514, 5592.077307244259, 5608.495235428831, 5616.297962754656, 2702.7837772978114, 2799.656165040751, 2894.6526416830116, 3251.804891706458, 3261.2010057536054, 6124.785632502841, 6166.784162554289, 6395.2645445773405, 6475.32009139043, 6479.44924681398, 5664.405237450009, 6292.622442653455, 6329.398707122816, 6360.872782544323, 6402.167718196604, 6230.906536402048, 6383.936160638427, 6413.29453760086, 6424.775132870421, 6434.420902118832, 5260.500252476008, 5496.780128794803, 5897.469227769521, 5901.026330655393, 6286.842828929313, 5731.3122425307565, 6120.540959427972, 6126.479249263863, 6153.476954458921, 6262.624242545462, 5864.0, 6007.8197654070445, 6298.464630506458, 6391.96804015977, 6448.0, 3679.6688298053305, 3873.2447172801035, 4180.435641188401, 4187.623113919762, 4189.916201675888, 5435.0, 5921.230240068763, 6210.4100110489435, 6239.251289845248, 6261.217347831521, 5060.949390506048, 5632.901584191043, 6043.969780151071, 6056.848578785565, 6116.969415152896, 5267.499587539178, 6065.423784740443, 6109.7861574844665, 6127.724252408563, 6149.169862068564, 5463.863403414946, 5670.262865827416, 5937.6061714331945, 5943.257092863392, 6005.579609427473, 6039.0, 6061.636301821904, 6062.484688801501, 6069.968105422001, 6133.160051984476, 5154.61340399479, 5872.29532456108, 5876.764929402776, 5935.376785437639, 5976.3127240366175], "value": 4329.837695493863, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [670.4066900792797, 722.4725950056458, 724.3010494872447, 733.6991833348328, 770.7456539342018, 15145.621359466006, 15792.368305267804, 15966.0, 16022.599435014115, 16038.957467764587, 14463.493777717782, 14550.272486375692, 14562.470940551248, 14587.41650333988, 14626.122432654049, 702.3222590200455, 853.8121613245077, 864.8270345930807, 873.7247766953421, 894.9328800339968, 877.6006916852816, 885.4908427654093, 891.9598618062171, 893.9731808045769, 898.9640414383449, 923.2890674180877, 940.5344354544476, 945.9479728614923, 946.1201082992814, 946.2146418472652, 902.9909700903005, 917.1104029091771, 932.4824722279133, 933.7712260496188, 936.2884208001899, 683.0846665468247, 695.9060526828864, 702.0101656664079, 702.6732569355223, 705.2665228162705, 14587.781183282259, 14778.852211477855, 14949.252537373197, 14982.026168299135, 15024.849751502454, 12869.549565765154, 14712.779308310277, 14779.0, 14809.629759255997, 14846.70306593873, 9923.553440095213, 10384.792304153874, 11586.84131586843, 11884.821727674092, 12260.509579616804, 3835.1562656215588, 3855.2096820152083, 3880.6507414332564, 3910.530736311661, 4000.9199816003807, 101839.99999999926, 117126.0, 118582.0, 119592.0, 123152.14782817353, 9567.186789123003, 11149.108071354272, 11293.548258069584, 11458.369789661649, 11957.162998590014, 22426.551468970854, 22451.438714031952, 22522.21172258963, 22553.548929021326, 22587.0, 7582.810429739301, 8204.958975205085, 8256.752297431087, 8313.293370063613, 8322.16778322163, 4515.006698526319, 4534.682572219979, 4644.149878928621, 4666.066786642617, 4844.491328410537, 3591.5690117186105, 3673.3755261605593, 3703.6111208323277, 3724.404095344732, 3733.9626603733614, 662.9734810607522, 668.1314291421133, 674.8110529051874, 679.6975345970995, 682.668905580793, 591.7248479457073, 667.8998150277497, 689.3588962265042, 694.6144889586227, 696.8675951569186, 8929.553522323858, 9396.107369799858, 9481.66814161501, 9485.762855928657, 9560.426374417557, 643.6652940470929, 647.8930976388843, 666.7732970789858, 676.2865177237962, 712.654362634122, 4166.979165104155, 4605.608523275492, 4617.492075871652, 4638.652101092432, 4687.7656117194, 101560.33616470313, 131319.3434032843, 164905.0, 166343.0, 167514.3248567523, 74020.0, 84890.57554712311, 118952.24191032434, 122476.61434453007, 138533.14668533066, 89768.5511572451, 93208.53395732978, 97118.02881971232, 109611.0, 125931.37034314952, 8188.0, 9393.671221507215, 9402.858957115512, 10173.949130254598, 10182.643607473703, 56192.71903640455, 56758.432415676965, 57023.71488142533, 57077.429225708875, 60769.0, 54675.0, 54744.45255547394, 78016.60991695005, 84782.0, 87695.56152219453, 12961.675958101123, 13049.34753262314, 13240.933795330962, 13376.331183440983, 13440.596782096552, 14548.636284092983, 15032.624184395478, 15170.165640889856, 15171.24143792828, 15231.847681523042, 13723.656908577366, 13850.307484625528, 13872.098313609584, 13966.231857247949, 14550.563483095524, 11838.467268972745, 13945.651358715708, 14005.159690418608, 14053.22707251111, 14601.342939567532, 13646.24945628, 13737.519186828413, 13889.65275868071, 14071.437142514185, 14202.360893759598, 11137.888621114009, 11424.0, 11456.427178641201, 11562.537498499965, 11634.6509604712, 10721.30311529748, 10743.355398676105, 11241.831372529256, 11589.594364197214, 11788.410579471163], "value": 7843.369925991708, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1588.3, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [130.0, 109.0, 149.0, 172.0, 138.0, 120.0, 115.0, 119.0, 117.0, 119.0], "value": 128.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 118.0, 136.0, 158.0, 113.0, 164.0, 123.0, 113.0, 146.0, 99.0], "value": 131.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [202.0, 206.0, 218.0, 219.0, 198.0, 200.0, 200.0, 200.0, 201.0, 198.0], "value": 204.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 105.0, 101.0, 157.0, 52.0, 76.0, 84.0, 89.0, 165.0, 81.0], "value": 98.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 72.0, 117.0, 70.0, 72.0, 88.0, 115.0, 71.0, 74.0, 115.0], "value": 86.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 132.0, 90.0, 89.0, 121.0, 87.0, 91.0, 88.0, 110.0, 87.0], "value": 103.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 95.0, 95.0, 110.0, 95.0, 151.0, 139.0, 95.0, 97.0], "value": 106.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 144.0, 92.0, 140.0, 142.0, 94.0, 137.0, 85.0, 143.0, 143.0], "value": 125.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 59.0, 56.0, 56.0, 57.0, 58.0, 55.0, 56.0, 57.0, 56.0], "value": 56.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 75.0, 70.0, 78.0, 74.0, 78.0, 103.0, 105.0, 89.0, 74.0], "value": 81.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 86.0, 84.0, 82.0, 87.0, 83.0, 85.0, 87.0, 90.0, 85.0], "value": 85.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 141.0, 135.0, 159.0, 147.0, 150.0, 133.0, 138.0, 171.0, 131.0], "value": 144.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 170.0, 164.0, 168.0, 167.0, 168.0, 171.0, 165.0, 168.0, 165.0], "value": 167.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 68.0, 68.0, 63.0, 66.0, 66.0, 61.0, 78.0, 83.0], "value": 68.8, "unit": "score"}]}]} 07:26:54 INFO - Return code: 0 07:26:54 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:26:54 ERROR - # TBPL SUCCESS # 07:26:54 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:26:54 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:26:54 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:26:54 INFO - 2016-08-09 07:26:54.778 screenresolution[1675:11367] starting screenresolution argv=screenresolution get 07:26:54 INFO - 2016-08-09 07:26:54.781 screenresolution[1675:11367] Display 0: 1600x1200x32@60 07:26:54 INFO - 2016-08-09 07:26:54.787 screenresolution[1676:11370] starting screenresolution argv=screenresolution list 07:26:54 INFO - Available Modes on Display 0 07:26:54 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:26:54 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:26:54 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:26:54 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:26:55 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:26:55 INFO - Intel Iris: 07:26:55 INFO - Chipset Model: Intel Iris 07:26:55 INFO - Type: GPU 07:26:55 INFO - Bus: Built-In 07:26:55 INFO - VRAM (Dynamic, Max): 1536 MB 07:26:55 INFO - Vendor: Intel (0x8086) 07:26:55 INFO - Device ID: 0x0a2e 07:26:55 INFO - Revision ID: 0x0009 07:26:55 INFO - Displays: 07:26:55 INFO - Display: 07:26:55 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:26:55 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:26:55 INFO - Display Serial Number: 1600x1200 60 07:26:55 INFO - Main Display: Yes 07:26:55 INFO - Mirror: Off 07:26:55 INFO - Online: Yes 07:26:55 INFO - Rotation: Supported 07:26:55 INFO - Return code: 0 07:26:55 INFO - Running post-action listener: _resource_record_post_action 07:26:55 INFO - [mozharness: 2016-08-09 14:26:55.024549Z] Finished run-tests step (success) 07:26:55 INFO - Running post-run listener: _resource_record_post_run 07:26:55 INFO - Total resource usage - Wall time: 1211s; CPU: 54.0%; Read bytes: 32922624; Write bytes: 708807168; Read time: 309; Write time: 2182 07:26:55 INFO - TinderboxPrint: CPU usage
54.3% 07:26:55 INFO - TinderboxPrint: I/O read bytes / time
32,922,624 / 309 07:26:55 INFO - TinderboxPrint: I/O write bytes / time
708,807,168 / 2,182 07:26:55 INFO - TinderboxPrint: CPU idle
2,214.6 (45.7%) 07:26:55 INFO - TinderboxPrint: CPU system
978.5 (20.2%) 07:26:55 INFO - TinderboxPrint: CPU user
1,652.5 (34.1%) 07:26:55 INFO - TinderboxPrint: Swap in / out
436,649,984 / 0 07:26:55 INFO - install - Wall time: 35s; CPU: 55.0%; Read bytes: 388143616; Write bytes: 382752256; Read time: 29227; Write time: 977 07:26:55 INFO - run-tests - Wall time: 1177s; CPU: 54.0%; Read bytes: 31898624; Write bytes: 298636288; Read time: 294; Write time: 1154 07:26:55 INFO - Running post-run listener: _upload_blobber_files 07:26:55 INFO - Blob upload gear active. 07:26:55 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:26:55 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 07:26:55 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'] 07:26:55 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 07:26:55 INFO - (blobuploader) - INFO - Open directory for files ... 07:26:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 07:26:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:26:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:26:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 07:26:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:26:57 INFO - (blobuploader) - INFO - Done attempting. 07:26:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 07:26:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:26:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:26:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 07:26:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:26:58 INFO - (blobuploader) - INFO - Done attempting. 07:26:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:26:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:26:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:27:00 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:27:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:27:00 INFO - (blobuploader) - INFO - Done attempting. 07:27:00 INFO - (blobuploader) - INFO - Iteration through files over. 07:27:00 INFO - Return code: 0 07:27:00 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:27:00 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:27:00 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/df2d6268d31dced74d776fea5295e9e71f6699bfc54ef2055c0fc0d913f21f6e7a4d1680e99ecb91f956e8cc38f974a53a757edb5c81908a21f8e21a06ab922c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5005967d246b0157551b5d0d453808cb5916f9aa854d67d65898bc72150b7456c244b980b7b6ca0502a871df479eff87c8c4ace9e6962144134c20ae21f1f8e4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/937ef1bbf66fbc39757b5c963730162eee3a43abc48e52c8be3754a677bdb1a953e753dbcf5d365ff68ef1983e6b113e1b5fcf05fe54a37c2a2a615d2187114a"} 07:27:00 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:27:00 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:27:00 INFO - Contents: 07:27:00 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/df2d6268d31dced74d776fea5295e9e71f6699bfc54ef2055c0fc0d913f21f6e7a4d1680e99ecb91f956e8cc38f974a53a757edb5c81908a21f8e21a06ab922c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5005967d246b0157551b5d0d453808cb5916f9aa854d67d65898bc72150b7456c244b980b7b6ca0502a871df479eff87c8c4ace9e6962144134c20ae21f1f8e4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/937ef1bbf66fbc39757b5c963730162eee3a43abc48e52c8be3754a677bdb1a953e753dbcf5d365ff68ef1983e6b113e1b5fcf05fe54a37c2a2a615d2187114a"} 07:27:00 INFO - Running post-run listener: copy_logs_to_upload_dir 07:27:00 INFO - Copying logs to upload dir... 07:27:00 INFO - mkdir: /builds/slave/test/build/upload/logs 07:27:00 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1265.186041 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2016-08-09 07:27:00.667894) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-09 07:27:00.670990) ========= 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.uxsQ52DNdQ/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.GdKp0pwELi/Listeners TMPDIR=/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/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/df2d6268d31dced74d776fea5295e9e71f6699bfc54ef2055c0fc0d913f21f6e7a4d1680e99ecb91f956e8cc38f974a53a757edb5c81908a21f8e21a06ab922c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5005967d246b0157551b5d0d453808cb5916f9aa854d67d65898bc72150b7456c244b980b7b6ca0502a871df479eff87c8c4ace9e6962144134c20ae21f1f8e4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/937ef1bbf66fbc39757b5c963730162eee3a43abc48e52c8be3754a677bdb1a953e753dbcf5d365ff68ef1983e6b113e1b5fcf05fe54a37c2a2a615d2187114a"} build_url:https://queue.taskcluster.net/v1/task/LTxvbTt-RGqMQz91mm4qeA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011123 build_url: 'https://queue.taskcluster.net/v1/task/LTxvbTt-RGqMQz91mm4qeA/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/df2d6268d31dced74d776fea5295e9e71f6699bfc54ef2055c0fc0d913f21f6e7a4d1680e99ecb91f956e8cc38f974a53a757edb5c81908a21f8e21a06ab922c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5005967d246b0157551b5d0d453808cb5916f9aa854d67d65898bc72150b7456c244b980b7b6ca0502a871df479eff87c8c4ace9e6962144134c20ae21f1f8e4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/937ef1bbf66fbc39757b5c963730162eee3a43abc48e52c8be3754a677bdb1a953e753dbcf5d365ff68ef1983e6b113e1b5fcf05fe54a37c2a2a615d2187114a"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-09 07:27:00.703916) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-09 07:27:00.704232) ========= 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.uxsQ52DNdQ/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.GdKp0pwELi/Listeners TMPDIR=/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/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.005041 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-09 07:27:00.752592) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-09 07:27:00.752901) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-09 07:27:00.753226) ========= ========= Total master_lag: 5.87 =========