builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0253 starttime: 1470941875.48 results: success (0) buildid: 20160811083720 builduid: b3c6cb78963c488188d7073e30824951 revision: 9dae91a2c31d1d7ee1f426b4f61179a42e0dab64 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-11 11:57:55.483236) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-11 11:57:55.483661) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-11 11:57:55.483945) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-11 11:57:55.505801) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-11 11:57:55.506065) ========= 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.FVpAHFgsxI/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.xRhzLN6nhp/Listeners TMPDIR=/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/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-11 11:57:55-- 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% 19.0M=0.001s 2016-08-11 11:57:55 (19.0 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.096329 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-11 11:57:55.624039) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-11 11:57:55.624336) ========= 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.FVpAHFgsxI/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.xRhzLN6nhp/Listeners TMPDIR=/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/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.025523 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-11 11:57:55.671961) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-11 11:57:55.672263) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 9dae91a2c31d1d7ee1f426b4f61179a42e0dab64 --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 9dae91a2c31d1d7ee1f426b4f61179a42e0dab64 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.FVpAHFgsxI/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.xRhzLN6nhp/Listeners TMPDIR=/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/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-11 11:57:55,755 truncating revision to first 12 chars 2016-08-11 11:57:55,755 Setting DEBUG logging. 2016-08-11 11:57:55,755 attempt 1/10 2016-08-11 11:57:55,755 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/9dae91a2c31d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-11 11:57:56,055 unpacking tar archive at: fx-team-9dae91a2c31d/testing/mozharness/ program finished with exit code 0 elapsedTime=0.579728 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-11 11:57:56.270749) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-11 11:57:56.271065) ========= script_repo_revision: 9dae91a2c31d1d7ee1f426b4f61179a42e0dab64 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-11 11:57:56.271457) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-11 11:57:56.271761) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-11 11:57:56.289414) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2016-08-11 11:57:56.289897) ========= /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.FVpAHFgsxI/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.xRhzLN6nhp/Listeners TMPDIR=/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/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 11:57:56 INFO - MultiFileLogger online at 20160811 11:57:56 in /builds/slave/test 11:57:56 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 11:57:56 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:57:56 INFO - {'append_to_log': False, 11:57:56 INFO - 'base_work_dir': '/builds/slave/test', 11:57:56 INFO - 'blob_upload_branch': 'Fx-Team', 11:57:56 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:57:56 INFO - 'branch': 'Fx-Team', 11:57:56 INFO - 'buildbot_json_path': 'buildprops.json', 11:57:56 INFO - 'config_files': ('talos/mac_config.py',), 11:57:56 INFO - 'default_actions': ('clobber', 11:57:56 INFO - 'read-buildbot-config', 11:57:56 INFO - 'download-and-extract', 11:57:56 INFO - 'populate-webroot', 11:57:56 INFO - 'create-virtualenv', 11:57:56 INFO - 'install', 11:57:56 INFO - 'run-tests'), 11:57:56 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:57:56 INFO - 'download_minidump_stackwalk': True, 11:57:56 INFO - 'download_symbols': 'ondemand', 11:57:56 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:57:56 INFO - 'tooltool.py': '/tools/tooltool.py', 11:57:56 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:57:56 INFO - '/tools/misc-python/virtualenv.py')}, 11:57:56 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:57:56 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:57:56 INFO - 'installer_path': 'installer.exe', 11:57:56 INFO - 'log_level': 'info', 11:57:56 INFO - 'log_name': 'talos', 11:57:56 INFO - 'log_to_console': True, 11:57:56 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 11:57:56 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 11:57:56 INFO - 'opt_config_files': (), 11:57:56 INFO - 'pip_index': False, 11:57:56 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 11:57:56 INFO - 'cmd': ('bash', 11:57:56 INFO - '-c', 11:57:56 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 11:57:56 INFO - 'enabled': True, 11:57:56 INFO - 'halt_on_failure': False, 11:57:56 INFO - 'name': 'check_screen_resolution'},), 11:57:56 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 11:57:56 INFO - 'cmd': ('bash', 11:57:56 INFO - '-c', 11:57:56 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 11:57:56 INFO - 'enabled': True, 11:57:56 INFO - 'halt_on_failure': False, 11:57:56 INFO - 'name': 'check_screen_resolution'},), 11:57:56 INFO - 'run_cmd_checks_enabled': True, 11:57:56 INFO - 'sps_profile': False, 11:57:56 INFO - 'sps_profile_interval': 0, 11:57:56 INFO - 'suite': 'dromaeojs-e10s', 11:57:56 INFO - 'system_bits': '32', 11:57:56 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:57:56 INFO - 'title': 't-yosemite-r7-0253', 11:57:56 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:57:56 INFO - 'use_talos_json': True, 11:57:56 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:57:56 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:57:56 INFO - 'work_dir': 'build'} 11:57:56 INFO - [mozharness: 2016-08-11 18:57:56.483092Z] Running clobber step. 11:57:56 INFO - Running pre-action listener: _resource_record_pre_action 11:57:56 INFO - Running main action method: clobber 11:57:56 INFO - rmtree: /builds/slave/test/build 11:57:56 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:57:58 INFO - Running post-action listener: _resource_record_post_action 11:57:58 INFO - [mozharness: 2016-08-11 18:57:58.551245Z] Finished clobber step (success) 11:57:58 INFO - [mozharness: 2016-08-11 18:57:58.551456Z] Running read-buildbot-config step. 11:57:58 INFO - Running pre-action listener: _resource_record_pre_action 11:57:58 INFO - Running main action method: read_buildbot_config 11:57:58 INFO - Using buildbot properties: 11:57:58 INFO - { 11:57:58 INFO - "project": "", 11:57:58 INFO - "product": "firefox", 11:57:58 INFO - "script_repo_revision": "production", 11:57:58 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 11:57:58 INFO - "repository": "", 11:57:58 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 11:57:58 INFO - "buildid": "20160811083720", 11:57:58 INFO - "pgo_build": "False", 11:57:58 INFO - "basedir": "/builds/slave/test", 11:57:58 INFO - "buildnumber": 86, 11:57:58 INFO - "slavename": "t-yosemite-r7-0253", 11:57:58 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 11:57:58 INFO - "platform": "yosemite_r7", 11:57:58 INFO - "scheduler": "tests-fx-team-macosx64-talos-7-3600", 11:57:58 INFO - "branch": "fx-team", 11:57:58 INFO - "repo_path": "integration/fx-team", 11:57:58 INFO - "revision": "9dae91a2c31d1d7ee1f426b4f61179a42e0dab64", 11:57:58 INFO - "stage_platform": "macosx64", 11:57:58 INFO - "builduid": "b3c6cb78963c488188d7073e30824951", 11:57:58 INFO - "slavebuilddir": "test" 11:57:58 INFO - } 11:57:58 INFO - Found installer url https://queue.taskcluster.net/v1/task/L_NRwNL6S5KrmlNkvftLTw/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg. 11:57:58 INFO - Running post-action listener: _resource_record_post_action 11:57:58 INFO - [mozharness: 2016-08-11 18:57:58.557278Z] Finished read-buildbot-config step (success) 11:57:58 INFO - [mozharness: 2016-08-11 18:57:58.557520Z] Running download-and-extract step. 11:57:58 INFO - Running pre-action listener: _resource_record_pre_action 11:57:58 INFO - Running main action method: download_and_extract 11:57:58 INFO - mkdir: /builds/slave/test/build/tests 11:57: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')]} 11:57:58 INFO - trying https://queue.taskcluster.net/v1/task/L_NRwNL6S5KrmlNkvftLTw/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json 11:57:58 INFO - Downloading https://queue.taskcluster.net/v1/task/L_NRwNL6S5KrmlNkvftLTw/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 11:57:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/L_NRwNL6S5KrmlNkvftLTw/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 11:57:59 INFO - Downloaded 1199 bytes. 11:57:59 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 11:57:59 INFO - Using the following test package requirements: 11:57:59 INFO - {u'common': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 11:57:59 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 11:57:59 INFO - u'firefox-51.0a1.en-US.mac.cppunittest.tests.zip'], 11:57:59 INFO - u'gtest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 11:57:59 INFO - u'firefox-51.0a1.en-US.mac.gtest.tests.zip'], 11:57:59 INFO - u'jittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 11:57:59 INFO - u'jsshell-mac.zip'], 11:57:59 INFO - u'mochitest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 11:57:59 INFO - u'firefox-51.0a1.en-US.mac.mochitest.tests.zip'], 11:57:59 INFO - u'mozbase': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 11:57:59 INFO - u'reftest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 11:57:59 INFO - u'firefox-51.0a1.en-US.mac.reftest.tests.zip'], 11:57:59 INFO - u'talos': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 11:57:59 INFO - u'firefox-51.0a1.en-US.mac.talos.tests.zip'], 11:57:59 INFO - u'web-platform': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 11:57:59 INFO - u'firefox-51.0a1.en-US.mac.web-platform.tests.zip'], 11:57:59 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 11:57:59 INFO - u'firefox-51.0a1.en-US.mac.xpcshell.tests.zip']} 11:57:59 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip'] for test suite category: common 11:57:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:57:59 INFO - trying https://queue.taskcluster.net/v1/task/L_NRwNL6S5KrmlNkvftLTw/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 11:57:59 INFO - Downloading https://queue.taskcluster.net/v1/task/L_NRwNL6S5KrmlNkvftLTw/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 11:57:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/L_NRwNL6S5KrmlNkvftLTw/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 11:58:00 INFO - Downloaded 16328359 bytes. 11:58:00 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'] 11:58:00 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 11:58:03 INFO - Return code: 0 11:58:03 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 11:58:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:58:03 INFO - trying https://queue.taskcluster.net/v1/task/L_NRwNL6S5KrmlNkvftLTw/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 11:58:03 INFO - Downloading https://queue.taskcluster.net/v1/task/L_NRwNL6S5KrmlNkvftLTw/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 11:58:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/L_NRwNL6S5KrmlNkvftLTw/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 11:58:04 INFO - Downloaded 16328359 bytes. 11:58:04 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'] 11:58:04 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 11:58:08 INFO - Return code: 0 11:58: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')]} 11:58:08 INFO - trying https://queue.taskcluster.net/v1/task/L_NRwNL6S5KrmlNkvftLTw/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip 11:58:08 INFO - Downloading https://queue.taskcluster.net/v1/task/L_NRwNL6S5KrmlNkvftLTw/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 11:58:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/L_NRwNL6S5KrmlNkvftLTw/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 11:58:08 INFO - Downloaded 14413719 bytes. 11:58:08 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'] 11:58:08 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 11:58:09 INFO - Return code: 0 11:58:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:58:09 INFO - trying https://queue.taskcluster.net/v1/task/L_NRwNL6S5KrmlNkvftLTw/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 11:58:09 INFO - Downloading https://queue.taskcluster.net/v1/task/L_NRwNL6S5KrmlNkvftLTw/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg 11:58:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/L_NRwNL6S5KrmlNkvftLTw/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 11:58:12 INFO - Downloaded 110898778 bytes. 11:58:12 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/L_NRwNL6S5KrmlNkvftLTw/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 11:58:12 INFO - mkdir: /builds/slave/test/properties 11:58:12 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:58:12 INFO - Writing to file /builds/slave/test/properties/build_url 11:58:12 INFO - Contents: 11:58:12 INFO - build_url:https://queue.taskcluster.net/v1/task/L_NRwNL6S5KrmlNkvftLTw/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 11:58:12 INFO - Running post-action listener: _resource_record_post_action 11:58:12 INFO - Running post-action listener: set_extra_try_arguments 11:58:12 INFO - [mozharness: 2016-08-11 18:58:12.815346Z] Finished download-and-extract step (success) 11:58:12 INFO - [mozharness: 2016-08-11 18:58:12.815492Z] Running populate-webroot step. 11:58:12 INFO - Running pre-action listener: _resource_record_pre_action 11:58:12 INFO - Running main action method: populate_webroot 11:58:12 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:58:12 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:58:12 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:58:12 INFO - '--tppagecycles', 11:58:12 INFO - '7'], 11:58:12 INFO - 'tests': ['tsvgm']}}, 11:58:12 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:58:12 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:58:12 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:58:12 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:58:12 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:58:12 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:58:12 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:58:12 INFO - 'talos_options': ['--disable-e10s'], 11:58:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:58:12 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:58:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:58:12 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:58:12 INFO - 'talos_options': ['--disable-e10s'], 11:58:12 INFO - 'tests': ['damp', 'tps']}, 11:58:12 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:58:12 INFO - 'tests': ['damp', 'tps']}, 11:58:12 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:58:12 INFO - 'tests': ['dromaeo_dom']}, 11:58:12 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:58:12 INFO - 'g4': {'talos_options': ['--disable-e10s'], 11:58:12 INFO - 'tests': ['basic_compositor_video']}, 11:58:12 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 11:58:12 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:58:12 INFO - 'tests': ['a11yr', 11:58:12 INFO - 'ts_paint', 11:58:12 INFO - 'tpaint', 11:58:12 INFO - 'sessionrestore', 11:58:12 INFO - 'sessionrestore_no_auto_restore', 11:58:12 INFO - 'tabpaint']}, 11:58:12 INFO - 'other-e10s': {'tests': ['a11yr', 11:58:12 INFO - 'ts_paint', 11:58:12 INFO - 'tpaint', 11:58:12 INFO - 'sessionrestore', 11:58:12 INFO - 'sessionrestore_no_auto_restore', 11:58:12 INFO - 'tabpaint']}, 11:58:12 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:58:12 INFO - 'ts_paint', 11:58:12 INFO - 'tpaint', 11:58:12 INFO - 'sessionrestore', 11:58:12 INFO - 'sessionrestore_no_auto_restore', 11:58:12 INFO - 'tabpaint']}, 11:58:12 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:58:12 INFO - 'ts_paint', 11:58:12 INFO - 'tpaint', 11:58:12 INFO - 'sessionrestore', 11:58:12 INFO - 'sessionrestore_no_auto_restore', 11:58:12 INFO - 'tabpaint']}, 11:58:12 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:58:12 INFO - 'tests': ['a11yr', 11:58:12 INFO - 'ts_paint', 11:58:12 INFO - 'tpaint', 11:58:12 INFO - 'sessionrestore', 11:58:12 INFO - 'sessionrestore_no_auto_restore', 11:58:12 INFO - 'tabpaint']}, 11:58:12 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:58:12 INFO - 'tests': ['a11yr', 11:58:12 INFO - 'ts_paint', 11:58:12 INFO - 'tpaint', 11:58:12 INFO - 'sessionrestore', 11:58:12 INFO - 'sessionrestore_no_auto_restore', 11:58:12 INFO - 'tabpaint']}, 11:58:12 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:58:12 INFO - 'tests': ['tsvgx', 11:58:12 INFO - 'tsvgr_opacity', 11:58:12 INFO - 'tart', 11:58:12 INFO - 'tscrollx', 11:58:12 INFO - 'cart']}, 11:58:12 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:58:12 INFO - 'tsvgr_opacity', 11:58:12 INFO - 'tart', 11:58:12 INFO - 'tscrollx', 11:58:12 INFO - 'cart']}, 11:58:12 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:58:12 INFO - 'talos_options': ['--disable-e10s'], 11:58:12 INFO - 'tests': ['tp5o']}, 11:58:12 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:58:12 INFO - 'tests': ['tp5o']}, 11:58:12 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:58:12 INFO - 'talos_options': ['--disable-e10s', 11:58:12 INFO - '--xperf_path', 11:58:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:58:12 INFO - 'tests': ['tp5n']}, 11:58:12 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:58:12 INFO - 'talos_options': ['--xperf_path', 11:58:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:58:12 INFO - 'tests': ['tp5n']}}, 11:58:12 INFO - 'talos.zip': {'path': '', 11:58:12 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:58:12 INFO - Running post-action listener: _resource_record_post_action 11:58:12 INFO - [mozharness: 2016-08-11 18:58:12.834419Z] Finished populate-webroot step (success) 11:58:12 INFO - [mozharness: 2016-08-11 18:58:12.834534Z] Running create-virtualenv step. 11:58:12 INFO - Running pre-action listener: _resource_record_pre_action 11:58:12 INFO - Running main action method: create_virtualenv 11:58:12 INFO - Creating virtualenv /builds/slave/test/build/venv 11:58:12 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 11:58:12 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:58:12 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:58:12 INFO - Using real prefix '/tools/python27' 11:58:12 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:58:13 INFO - Installing distribute.............................................................................................................................................................................................done. 11:58:16 INFO - Installing pip.................done. 11:58:16 INFO - Return code: 0 11:58:16 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:58:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:58:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:58:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:58:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:58:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:58:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:58:16 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 0x10ee7ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ef13618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa951578f60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ede2d30>, '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 0x10eb47db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10eddab20>, '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.FVpAHFgsxI/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.xRhzLN6nhp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/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 11:58:16 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 11:58:16 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 11:58:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FVpAHFgsxI/Render', 11:58:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:58:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:58:16 INFO - 'HOME': '/Users/cltbld', 11:58:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:58:16 INFO - 'LOGNAME': 'cltbld', 11:58:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:58:16 INFO - 'MOZ_NO_REMOTE': '1', 11:58:16 INFO - 'NO_EM_RESTART': '1', 11:58:16 INFO - 'PAGER': '/bin/cat', 11:58:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:58:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:58:16 INFO - 'PWD': '/builds/slave/test', 11:58:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:58:16 INFO - 'SHELL': '/bin/bash', 11:58:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xRhzLN6nhp/Listeners', 11:58:16 INFO - 'TMPDIR': '/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/', 11:58:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:58:16 INFO - 'USER': 'cltbld', 11:58:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:58:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:58:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:58:16 INFO - 'XPC_FLAGS': '0x0', 11:58:16 INFO - 'XPC_SERVICE_NAME': '0', 11:58:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:58:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:58:16 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 11:58:16 INFO - Cleaning up... 11:58:16 INFO - Return code: 0 11:58:16 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:58:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:58:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:58:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:58:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:58:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:58:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:58:16 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 0x10ee7ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ef13618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa951578f60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ede2d30>, '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 0x10eb47db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10eddab20>, '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.FVpAHFgsxI/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.xRhzLN6nhp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/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 11:58:16 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 11:58:16 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 11:58:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FVpAHFgsxI/Render', 11:58:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:58:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:58:16 INFO - 'HOME': '/Users/cltbld', 11:58:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:58:16 INFO - 'LOGNAME': 'cltbld', 11:58:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:58:16 INFO - 'MOZ_NO_REMOTE': '1', 11:58:16 INFO - 'NO_EM_RESTART': '1', 11:58:16 INFO - 'PAGER': '/bin/cat', 11:58:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:58:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:58:16 INFO - 'PWD': '/builds/slave/test', 11:58:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:58:16 INFO - 'SHELL': '/bin/bash', 11:58:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xRhzLN6nhp/Listeners', 11:58:16 INFO - 'TMPDIR': '/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/', 11:58:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:58:16 INFO - 'USER': 'cltbld', 11:58:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:58:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:58:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:58:16 INFO - 'XPC_FLAGS': '0x0', 11:58:16 INFO - 'XPC_SERVICE_NAME': '0', 11:58:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:58:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:58:17 INFO - Downloading/unpacking psutil>=3.1.1 11:58:17 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 11:58:17 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 11:58:17 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 11:58:17 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 11:58:17 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 11:58:17 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 11:58:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:58:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:58:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:58:20 INFO - Installing collected packages: psutil 11:58:20 INFO - Running setup.py install for psutil 11:58:20 INFO - building 'psutil._psutil_osx' extension 11:58:20 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 11:58:20 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 11:58:20 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 11:58: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 11:58:21 INFO - building 'psutil._psutil_posix' extension 11:58:21 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 11:58:21 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 11:58:21 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 11:58:21 INFO - ^ 11:58:21 INFO - 1 warning generated. 11:58:21 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 11:58:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:58:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:58:21 INFO - Successfully installed psutil 11:58:21 INFO - Cleaning up... 11:58:21 INFO - Return code: 0 11:58:21 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:58:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:58:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:58:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:58:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:58:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:58:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:58:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ee7ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ef13618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa951578f60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ede2d30>, '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 0x10eb47db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10eddab20>, '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.FVpAHFgsxI/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.xRhzLN6nhp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/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 11:58:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 11:58:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 11:58:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FVpAHFgsxI/Render', 11:58:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:58:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:58:21 INFO - 'HOME': '/Users/cltbld', 11:58:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:58:21 INFO - 'LOGNAME': 'cltbld', 11:58:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:58:21 INFO - 'MOZ_NO_REMOTE': '1', 11:58:21 INFO - 'NO_EM_RESTART': '1', 11:58:21 INFO - 'PAGER': '/bin/cat', 11:58:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:58:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:58:21 INFO - 'PWD': '/builds/slave/test', 11:58:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:58:21 INFO - 'SHELL': '/bin/bash', 11:58:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xRhzLN6nhp/Listeners', 11:58:21 INFO - 'TMPDIR': '/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/', 11:58:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:58:21 INFO - 'USER': 'cltbld', 11:58:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:58:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:58:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:58:21 INFO - 'XPC_FLAGS': '0x0', 11:58:21 INFO - 'XPC_SERVICE_NAME': '0', 11:58:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:58:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:58:21 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:58:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:58:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:58:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:58:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:58:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:58:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:58:24 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:58:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:58:24 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:58:24 INFO - Installing collected packages: mozsystemmonitor 11:58:24 INFO - Running setup.py install for mozsystemmonitor 11:58:24 INFO - Successfully installed mozsystemmonitor 11:58:24 INFO - Cleaning up... 11:58:24 INFO - Return code: 0 11:58:24 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:58:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:58:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:58:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:58:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:58:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:58:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:58:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ee7ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ef13618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa951578f60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ede2d30>, '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 0x10eb47db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10eddab20>, '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.FVpAHFgsxI/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.xRhzLN6nhp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/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 11:58:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 11:58:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 11:58:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FVpAHFgsxI/Render', 11:58:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:58:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:58:24 INFO - 'HOME': '/Users/cltbld', 11:58:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:58:24 INFO - 'LOGNAME': 'cltbld', 11:58:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:58:24 INFO - 'MOZ_NO_REMOTE': '1', 11:58:24 INFO - 'NO_EM_RESTART': '1', 11:58:24 INFO - 'PAGER': '/bin/cat', 11:58:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:58:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:58:24 INFO - 'PWD': '/builds/slave/test', 11:58:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:58:24 INFO - 'SHELL': '/bin/bash', 11:58:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xRhzLN6nhp/Listeners', 11:58:24 INFO - 'TMPDIR': '/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/', 11:58:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:58:24 INFO - 'USER': 'cltbld', 11:58:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:58:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:58:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:58:24 INFO - 'XPC_FLAGS': '0x0', 11:58:24 INFO - 'XPC_SERVICE_NAME': '0', 11:58:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:58:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:58:24 INFO - Downloading/unpacking jsonschema==2.5.1 11:58:24 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 11:58:24 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 11:58:24 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 11:58:24 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 11:58:24 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 11:58:24 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 11:58:27 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:58:27 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:58: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 11:58: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 11:58: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 11:58: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 11:58: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 11:58: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 11:58:27 INFO - Downloading functools32-3.2.3-2.tar.gz 11:58:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:58:27 INFO - warning: no files found matching '*.txt' 11:58:27 INFO - no previously-included directories found matching 'build' 11:58:27 INFO - no previously-included directories found matching 'dist' 11:58:27 INFO - no previously-included directories found matching '.git*' 11:58:27 INFO - Installing collected packages: jsonschema, functools32 11:58:27 INFO - Running setup.py install for functools32 11:58:27 INFO - warning: no files found matching '*.txt' 11:58:27 INFO - no previously-included directories found matching 'build' 11:58:27 INFO - no previously-included directories found matching 'dist' 11:58:27 INFO - no previously-included directories found matching '.git*' 11:58:27 INFO - Successfully installed jsonschema functools32 11:58:27 INFO - Cleaning up... 11:58:27 INFO - Return code: 0 11:58:27 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:58: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')]} 11:58:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:58:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:58: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')]} 11:58:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:58:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:58: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', '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 0x10ee7ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ef13618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa951578f60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ede2d30>, '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 0x10eb47db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10eddab20>, '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.FVpAHFgsxI/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.xRhzLN6nhp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/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 11:58: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 11:58: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 functools32==3.2.3-2 11:58:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FVpAHFgsxI/Render', 11:58:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:58:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:58:27 INFO - 'HOME': '/Users/cltbld', 11:58:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:58:27 INFO - 'LOGNAME': 'cltbld', 11:58:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:58:27 INFO - 'MOZ_NO_REMOTE': '1', 11:58:27 INFO - 'NO_EM_RESTART': '1', 11:58:27 INFO - 'PAGER': '/bin/cat', 11:58:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:58:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:58:27 INFO - 'PWD': '/builds/slave/test', 11:58:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:58:27 INFO - 'SHELL': '/bin/bash', 11:58:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xRhzLN6nhp/Listeners', 11:58:27 INFO - 'TMPDIR': '/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/', 11:58:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:58:27 INFO - 'USER': 'cltbld', 11:58:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:58:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:58:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:58:27 INFO - 'XPC_FLAGS': '0x0', 11:58:27 INFO - 'XPC_SERVICE_NAME': '0', 11:58:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:58:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:58:28 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:58:28 INFO - Cleaning up... 11:58:28 INFO - Return code: 0 11:58:28 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:58:28 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')]} 11:58:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:58:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:58:28 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')]} 11:58:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:58:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:58:28 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 0x10ee7ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ef13618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa951578f60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ede2d30>, '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 0x10eb47db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10eddab20>, '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.FVpAHFgsxI/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.xRhzLN6nhp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/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 11:58:28 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 11:58:28 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 11:58:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FVpAHFgsxI/Render', 11:58:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:58:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:58:28 INFO - 'HOME': '/Users/cltbld', 11:58:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:58:28 INFO - 'LOGNAME': 'cltbld', 11:58:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:58:28 INFO - 'MOZ_NO_REMOTE': '1', 11:58:28 INFO - 'NO_EM_RESTART': '1', 11:58:28 INFO - 'PAGER': '/bin/cat', 11:58:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:58:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:58:28 INFO - 'PWD': '/builds/slave/test', 11:58:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:58:28 INFO - 'SHELL': '/bin/bash', 11:58:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xRhzLN6nhp/Listeners', 11:58:28 INFO - 'TMPDIR': '/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/', 11:58:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:58:28 INFO - 'USER': 'cltbld', 11:58:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:58:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:58:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:58:28 INFO - 'XPC_FLAGS': '0x0', 11:58:28 INFO - 'XPC_SERVICE_NAME': '0', 11:58:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:58:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:58:28 INFO - Downloading/unpacking blobuploader==1.2.4 11:58:28 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 11:58:28 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 11:58:28 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 11:58:28 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 11:58:28 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 11:58:28 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 11:58:30 INFO - Downloading blobuploader-1.2.4.tar.gz 11:58:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:58:30 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:58: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 11:58: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 11:58: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 11:58: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 11:58: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 11:58: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 11:58:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:58:31 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:58:31 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 11:58:31 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 11:58:31 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 11:58:31 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 11:58:31 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 11:58:31 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 11:58:32 INFO - Downloading docopt-0.6.1.tar.gz 11:58:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:58:32 INFO - Installing collected packages: blobuploader, requests, docopt 11:58:32 INFO - Running setup.py install for blobuploader 11:58:32 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:58:32 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:58:32 INFO - Running setup.py install for requests 11:58:32 INFO - Running setup.py install for docopt 11:58:32 INFO - Successfully installed blobuploader requests docopt 11:58:32 INFO - Cleaning up... 11:58:33 INFO - Return code: 0 11:58:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:58:33 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')]} 11:58:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:58:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:58:33 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')]} 11:58:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:58:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:58:33 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 0x10ee7ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ef13618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa951578f60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ede2d30>, '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 0x10eb47db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10eddab20>, '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.FVpAHFgsxI/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.xRhzLN6nhp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/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 11:58:33 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 11:58:33 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 11:58:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FVpAHFgsxI/Render', 11:58:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:58:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:58:33 INFO - 'HOME': '/Users/cltbld', 11:58:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:58:33 INFO - 'LOGNAME': 'cltbld', 11:58:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:58:33 INFO - 'MOZ_NO_REMOTE': '1', 11:58:33 INFO - 'NO_EM_RESTART': '1', 11:58:33 INFO - 'PAGER': '/bin/cat', 11:58:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:58:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:58:33 INFO - 'PWD': '/builds/slave/test', 11:58:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:58:33 INFO - 'SHELL': '/bin/bash', 11:58:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xRhzLN6nhp/Listeners', 11:58:33 INFO - 'TMPDIR': '/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/', 11:58:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:58:33 INFO - 'USER': 'cltbld', 11:58:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:58:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:58:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:58:33 INFO - 'XPC_FLAGS': '0x0', 11:58:33 INFO - 'XPC_SERVICE_NAME': '0', 11:58:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:58:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:58:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:58:33 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-9XN23s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:58:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:58:33 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-juXVQS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:58:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:58:33 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-ShZUE8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:58:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:58:33 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-8UUnFB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:58:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:58:33 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-xh8rkB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:58:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:58:33 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-SdaJ53-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:58:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:58:33 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-SEOQF6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:58:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:58:33 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-lEBkrH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:58:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:58:34 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-vUkRJ1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:58:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:58:34 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-c1vuwm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:58:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:58:34 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-FMeuJ1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:58:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:58:34 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-m25yjI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:58:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:58:34 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-XzRHIc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:58:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:58:34 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-fR8uwF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:58:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:58:34 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-NwXMTK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:58:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:58:34 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-GrCRSt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:58:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:58:34 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-tHeswg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:58:35 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:58:35 INFO - Running setup.py install for manifestparser 11:58:35 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:58:35 INFO - Running setup.py install for mozcrash 11:58:35 INFO - Running setup.py install for mozdebug 11:58:35 INFO - Running setup.py install for mozdevice 11:58:35 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:58:35 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:58:35 INFO - Running setup.py install for mozfile 11:58:35 INFO - Running setup.py install for mozhttpd 11:58:35 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:58:35 INFO - Running setup.py install for mozinfo 11:58:36 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:58:36 INFO - Running setup.py install for mozInstall 11:58:36 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:58:36 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:58:36 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:58:36 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:58:36 INFO - Running setup.py install for mozleak 11:58:36 INFO - Running setup.py install for mozlog 11:58:36 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:58:36 INFO - Running setup.py install for moznetwork 11:58:36 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:58:36 INFO - Running setup.py install for mozprocess 11:58:36 INFO - Running setup.py install for mozprofile 11:58:36 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:58:36 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:58:36 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:58:37 INFO - Running setup.py install for mozrunner 11:58:37 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:58:37 INFO - Running setup.py install for mozscreenshot 11:58:37 INFO - Running setup.py install for moztest 11:58:37 INFO - Running setup.py install for mozversion 11:58:37 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:58:37 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:58:37 INFO - Cleaning up... 11:58:37 INFO - Return code: 0 11:58:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:58:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:58:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:58:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:58:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:58:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:58:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:58:37 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 0x10ee7ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ef13618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa951578f60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ede2d30>, '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 0x10eb47db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10eddab20>, '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.FVpAHFgsxI/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.xRhzLN6nhp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/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 11:58:37 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 11:58:37 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 11:58:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FVpAHFgsxI/Render', 11:58:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:58:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:58:37 INFO - 'HOME': '/Users/cltbld', 11:58:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:58:37 INFO - 'LOGNAME': 'cltbld', 11:58:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:58:37 INFO - 'MOZ_NO_REMOTE': '1', 11:58:37 INFO - 'NO_EM_RESTART': '1', 11:58:37 INFO - 'PAGER': '/bin/cat', 11:58:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:58:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:58:37 INFO - 'PWD': '/builds/slave/test', 11:58:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:58:37 INFO - 'SHELL': '/bin/bash', 11:58:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xRhzLN6nhp/Listeners', 11:58:37 INFO - 'TMPDIR': '/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/', 11:58:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:58:37 INFO - 'USER': 'cltbld', 11:58:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:58:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:58:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:58:37 INFO - 'XPC_FLAGS': '0x0', 11:58:37 INFO - 'XPC_SERVICE_NAME': '0', 11:58:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:58:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:58:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:58:37 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-ubhe8F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:58:38 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)) 11:58:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:58:38 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-iV7Ns2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:58:38 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)) 11:58:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:58:38 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-32bkLl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:58:38 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)) 11:58:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:58:38 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-X8NkO7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:58:38 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)) 11:58:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:58:38 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-s_Iyeq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:58:38 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)) 11:58:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:58:38 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-IqqYVQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:58:38 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)) 11:58:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:58:38 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-1BjWkh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:58:38 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)) 11:58:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:58:38 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-PcfZz0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:58:38 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)) 11:58:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:58:38 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-EohA12-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:58: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)) 11:58:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:58:38 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-crv0u8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:58: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)) 11:58:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:58:38 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-b12Xj2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:58:39 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)) 11:58:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:58:39 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-QgwI87-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:58:39 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)) 11:58:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:58:39 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-A9OEuv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:58:39 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)) 11:58:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:58:39 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-S7_5n5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:58:39 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)) 11:58:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:58:39 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-cSyiaJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:58:39 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)) 11:58:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:58:39 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-_RBgWb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:58:39 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)) 11:58:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:58:39 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-xwOjtd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:58:39 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)) 11:58:39 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)) 11:58:39 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)) 11:58:39 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)) 11:58:39 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)) 11:58:39 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)) 11:58:39 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:58:39 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 11:58:39 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 11:58:39 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 11:58:39 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 11:58:39 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 11:58:39 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 11:58:42 INFO - Downloading blessings-1.6.tar.gz 11:58:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:58:42 INFO - Installing collected packages: blessings 11:58:42 INFO - Running setup.py install for blessings 11:58:42 INFO - Successfully installed blessings 11:58:42 INFO - Cleaning up... 11:58:42 INFO - Return code: 0 11:58:42 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:58:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:58:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:58:42 INFO - Reading from file tmpfile_stdout 11:58:42 INFO - Current package versions: 11:58:42 INFO - blessings == 1.6 11:58:42 INFO - blobuploader == 1.2.4 11:58:42 INFO - docopt == 0.6.1 11:58:42 INFO - functools32 == 3.2.3-2 11:58:42 INFO - jsonschema == 2.5.1 11:58:42 INFO - manifestparser == 1.1 11:58:42 INFO - mozInstall == 1.12 11:58:42 INFO - mozcrash == 0.17 11:58:42 INFO - mozdebug == 0.1 11:58:42 INFO - mozdevice == 0.48 11:58:42 INFO - mozfile == 1.2 11:58:42 INFO - mozhttpd == 0.7 11:58:42 INFO - mozinfo == 0.9 11:58:42 INFO - mozleak == 0.1 11:58:42 INFO - mozlog == 3.3 11:58:42 INFO - moznetwork == 0.27 11:58:42 INFO - mozprocess == 0.23 11:58:42 INFO - mozprofile == 0.28 11:58:42 INFO - mozrunner == 6.12 11:58:42 INFO - mozscreenshot == 0.1 11:58:42 INFO - mozsystemmonitor == 0.3 11:58:42 INFO - moztest == 0.7 11:58:42 INFO - mozversion == 1.4 11:58:42 INFO - psutil == 3.1.1 11:58:42 INFO - requests == 1.2.3 11:58:42 INFO - wsgiref == 0.1.2 11:58:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:58: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')]} 11:58:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:58:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:58: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')]} 11:58:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:58:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:58: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 0x10ee7ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ef13618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa951578f60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ede2d30>, '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 0x10eb47db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10eddab20>, '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.FVpAHFgsxI/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.xRhzLN6nhp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/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 11:58: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 11:58: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 11:58:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FVpAHFgsxI/Render', 11:58:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:58:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:58:42 INFO - 'HOME': '/Users/cltbld', 11:58:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:58:42 INFO - 'LOGNAME': 'cltbld', 11:58:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:58:42 INFO - 'MOZ_NO_REMOTE': '1', 11:58:42 INFO - 'NO_EM_RESTART': '1', 11:58:42 INFO - 'PAGER': '/bin/cat', 11:58:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:58:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:58:42 INFO - 'PWD': '/builds/slave/test', 11:58:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:58:42 INFO - 'SHELL': '/bin/bash', 11:58:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xRhzLN6nhp/Listeners', 11:58:42 INFO - 'TMPDIR': '/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/', 11:58:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:58:42 INFO - 'USER': 'cltbld', 11:58:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:58:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:58:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:58:42 INFO - 'XPC_FLAGS': '0x0', 11:58:42 INFO - 'XPC_SERVICE_NAME': '0', 11:58:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:58:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:58: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)) 11:58: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)) 11:58: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)) 11:58: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)) 11:58: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)) 11:58: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)) 11:58: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)) 11:58: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)) 11:58: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)) 11:58: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)) 11:58: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)) 11:58:43 INFO - Cleaning up... 11:58:43 INFO - Return code: 0 11:58:43 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:58: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')]} 11:58:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:58:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:58: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')]} 11:58:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:58:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:58: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 0x10ee7ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ef13618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa951578f60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ede2d30>, '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 0x10eb47db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10eddab20>, '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.FVpAHFgsxI/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.xRhzLN6nhp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/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 11:58: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 11:58: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 11:58:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FVpAHFgsxI/Render', 11:58:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:58:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:58:43 INFO - 'HOME': '/Users/cltbld', 11:58:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:58:43 INFO - 'LOGNAME': 'cltbld', 11:58:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:58:43 INFO - 'MOZ_NO_REMOTE': '1', 11:58:43 INFO - 'NO_EM_RESTART': '1', 11:58:43 INFO - 'PAGER': '/bin/cat', 11:58:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:58:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:58:43 INFO - 'PWD': '/builds/slave/test', 11:58:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:58:43 INFO - 'SHELL': '/bin/bash', 11:58:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xRhzLN6nhp/Listeners', 11:58:43 INFO - 'TMPDIR': '/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/', 11:58:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:58:43 INFO - 'USER': 'cltbld', 11:58:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:58:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:58:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:58:43 INFO - 'XPC_FLAGS': '0x0', 11:58:43 INFO - 'XPC_SERVICE_NAME': '0', 11:58:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:58:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:58:43 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:58:43 INFO - Cleaning up... 11:58:43 INFO - Return code: 0 11:58:43 INFO - Running post-action listener: _resource_record_post_action 11:58:43 INFO - Running post-action listener: _start_resource_monitoring 11:58:43 INFO - Starting resource monitoring. 11:58:43 INFO - [mozharness: 2016-08-11 18:58:43.399950Z] Finished create-virtualenv step (success) 11:58:43 INFO - [mozharness: 2016-08-11 18:58:43.400878Z] Running install step. 11:58:43 INFO - Running pre-action listener: _resource_record_pre_action 11:58:43 INFO - Running main action method: install 11:58:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:58:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:58:43 INFO - Reading from file tmpfile_stdout 11:58:43 INFO - Detecting whether we're running mozinstall >=1.0... 11:58:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:58:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:58:43 INFO - Reading from file tmpfile_stdout 11:58:43 INFO - Output received: 11:58:43 INFO - Usage: mozinstall [options] installer 11:58:43 INFO - Options: 11:58:43 INFO - -h, --help show this help message and exit 11:58:43 INFO - -d DEST, --destination=DEST 11:58:43 INFO - Directory to install application into. [default: 11:58:43 INFO - "/builds/slave/test"] 11:58:43 INFO - --app=APP Application being installed. [default: firefox] 11:58:43 INFO - mkdir: /builds/slave/test/build/application 11:58: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'] 11:58: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 11:59:18 INFO - Reading from file tmpfile_stdout 11:59:18 INFO - Output received: 11:59:18 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 11:59:18 INFO - Running post-action listener: _resource_record_post_action 11:59:18 INFO - [mozharness: 2016-08-11 18:59:18.413918Z] Finished install step (success) 11:59:18 INFO - [mozharness: 2016-08-11 18:59:18.414066Z] Running run-tests step. 11:59:18 INFO - Running pre-action listener: _resource_record_pre_action 11:59:18 INFO - Running main action method: run_tests 11:59:18 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 11:59:18 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 11:59:18 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 11:59:18 INFO - 2016-08-11 11:59:18.426 screenresolution[1637:7382] starting screenresolution argv=screenresolution get 11:59:18 INFO - 2016-08-11 11:59:18.429 screenresolution[1637:7382] Display 0: 1600x1200x32@60 11:59:18 INFO - 2016-08-11 11:59:18.434 screenresolution[1638:7384] starting screenresolution argv=screenresolution list 11:59:18 INFO - Available Modes on Display 0 11:59:18 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 11:59:18 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 11:59:18 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 11:59:18 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 11:59:18 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 11:59:18 INFO - Intel Iris: 11:59:18 INFO - Chipset Model: Intel Iris 11:59:18 INFO - Type: GPU 11:59:18 INFO - Bus: Built-In 11:59:18 INFO - VRAM (Dynamic, Max): 1536 MB 11:59:18 INFO - Vendor: Intel (0x8086) 11:59:18 INFO - Device ID: 0x0a2e 11:59:18 INFO - Revision ID: 0x0009 11:59:18 INFO - Displays: 11:59:18 INFO - Display: 11:59:18 INFO - Resolution: 1600 x 1200 @ 60 Hz 11:59:18 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 11:59:18 INFO - Display Serial Number: 1600x1200 60 11:59:18 INFO - Main Display: Yes 11:59:18 INFO - Mirror: Off 11:59:18 INFO - Online: Yes 11:59:18 INFO - Rotation: Supported 11:59:18 INFO - Return code: 0 11:59:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:59:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:59:18 INFO - Python 2.7.3 11:59:18 INFO - Return code: 0 11:59:18 INFO - grabbing minidump binary from tooltool 11:59: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')]} 11:59: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 0x10ede2d30>, '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 0x10eb47db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10eddab20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:59: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 11:59: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 11:59: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 11:59:18 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:59:18 INFO - Return code: 0 11:59:18 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 11:59:18 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:59:18 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:59:18 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 11:59:18 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:59: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/L_NRwNL6S5KrmlNkvftLTw/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0253', '--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 11:59: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/L_NRwNL6S5KrmlNkvftLTw/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0253 --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 11:59:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FVpAHFgsxI/Render', 11:59:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:59:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:59:18 INFO - 'HOME': '/Users/cltbld', 11:59:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:59:18 INFO - 'LOGNAME': 'cltbld', 11:59:18 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:59:18 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 11:59:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:59:18 INFO - 'MOZ_NO_REMOTE': '1', 11:59:18 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:59:18 INFO - 'NO_EM_RESTART': '1', 11:59:18 INFO - 'PAGER': '/bin/cat', 11:59:18 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:59:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:59:18 INFO - 'PWD': '/builds/slave/test', 11:59:18 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:59:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:59:18 INFO - 'SHELL': '/bin/bash', 11:59:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xRhzLN6nhp/Listeners', 11:59:18 INFO - 'TMPDIR': '/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/', 11:59:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:59:18 INFO - 'USER': 'cltbld', 11:59:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:59:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:59:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:59:18 INFO - 'XPC_FLAGS': '0x0', 11:59:18 INFO - 'XPC_SERVICE_NAME': '0', 11:59:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:59: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/L_NRwNL6S5KrmlNkvftLTw/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0253', '--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 11:59:19 INFO - mozversion application_buildid: 20160811083720 11:59:19 INFO - mozversion application_changeset: 9dae91a2c31d1d7ee1f426b4f61179a42e0dab64 11:59:19 INFO - mozversion application_display_name: Nightly 11:59:19 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:59:19 INFO - mozversion application_name: Firefox 11:59:19 INFO - mozversion application_remotingname: firefox 11:59:19 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 11:59:19 INFO - mozversion application_vendor: Mozilla 11:59:19 INFO - mozversion application_version: 51.0a1 11:59:19 INFO - mozversion platform_buildid: 20160811083720 11:59:19 INFO - mozversion platform_changeset: 9dae91a2c31d1d7ee1f426b4f61179a42e0dab64 11:59:19 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 11:59:19 INFO - mozversion platform_version: 51.0a1 11:59:19 INFO - using testdate: 1470941959 11:59:19 INFO - actual date: 1470941959 11:59:19 INFO - starting webserver on 'localhost:49266' 11:59:19 INFO - SUITE-START | Running 2 tests 11:59:19 INFO - TEST-START | dromaeo_css 11:59:19 INFO - operating with platform_type : mac_ 11:59:19 INFO - Initialising browser for dromaeo_css test... 11:59:19 INFO - TEST-INFO | started process 1648 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/tmpNS4tNJ/profile http://localhost:49266/getInfo.html) 11:59:21 INFO - PROCESS | 1648 | __metrics Screen width/height:1600/1200 11:59:21 INFO - PROCESS | 1648 | colorDepth:24 11:59:21 INFO - PROCESS | 1648 | Browser inner width/height: 1024/689 11:59:21 INFO - PROCESS | 1648 | __metrics 11:59:22 ERROR - PROCESS | 1648 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2983: TypeError: this.tabs is undefined 11:59:22 INFO - TEST-INFO | 1648: exit 0 11:59:22 INFO - Browser initialized. 11:59:22 INFO - Running cycle 1/1 for dromaeo_css test... 11:59:22 INFO - TEST-INFO | started process 1651 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/tmpNS4tNJ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:59:34 INFO - PROCESS | 1651 | RSS: Main: 254689280 11:59:34 INFO - PROCESS | 1651 | 12:00:24 INFO - PROCESS | 1651 | 1470942024324 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 12:02:36 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49266/tests/dromaeo/cssquery-ext.html) 12:02:37 INFO - PROCESS | 1651 | RSS: Main: 267251712 12:02:37 INFO - PROCESS | 1651 | 12:05:39 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-ext.html (next: http://localhost:49266/tests/dromaeo/cssquery-jquery.html) 12:05:40 INFO - PROCESS | 1651 | RSS: Main: 275554304 12:05:40 INFO - PROCESS | 1651 | 12:08:42 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49266/tests/dromaeo/cssquery-mootools.html) 12:08:42 INFO - PROCESS | 1651 | RSS: Main: 280395776 12:08:42 INFO - PROCESS | 1651 | 12:11:44 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49266/tests/dromaeo/cssquery-prototype.html) 12:11:45 INFO - PROCESS | 1651 | RSS: Main: 278597632 12:11:45 INFO - PROCESS | 1651 | 12:14:48 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49266/tests/dromaeo/cssquery-yui.html) 12:14:48 INFO - PROCESS | 1651 | RSS: Main: 282832896 12:14:48 INFO - PROCESS | 1651 | 12:17:52 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-yui.html (next: http://localhost:49266/tests/dromaeo/cssquery-dojo.html) 12:17:52 INFO - PROCESS | 1651 | RSS: Main: 284618752 12:17:52 INFO - PROCESS | 1651 | 12:17:52 INFO - PROCESS | 1651 | __start_tp_report 12:17:52 INFO - PROCESS | 1651 | _x_x_mozilla_page_load 12:17:52 INFO - PROCESS | 1651 | _x_x_mozilla_page_load_details 12:17:52 INFO - PROCESS | 1651 | |i|pagename|runs| 12:17:52 INFO - PROCESS | 1651 | |0;dojo.html;3436.0894362993804;3442.896713098608;3462.411390063689;3467.7399195060375;3486.6339034401385;4693.249080147177;5683.2895888014;5709.800156994501;5745.6839873806975;5820.53435725142;5782.942170578293;5797.536197104232;5809.854753631151;5847.239858818359;5910.143029260755;3825.08198032473;4094.8943785177985;5161.200013997836;5259.921101183466;5364.249005139264;5418.647787893774;5420.5934554908345;5435.2934118564535;5463.972680136613;5486.698231597261;4478.462584489849;5195;5248;5313.229581710669;5417.404085550586;5297.894042119175;5343.305370301875;5344.732763361816;5361.973190134064;5385.434529374437;4425.291953287458;5294.126469132627;5300.681959082467;5301.231321458406;5381.085215513333;5600.551955843523;5770.79802206925;5819.214406055171;5873.324567674729;5940.227770389865;5871.588988770788;6298.653574053471;6300.243970723543;6307.810765677037;6318.894193516162;6153.969230153821;6232.878081945248;6271.372862713738;6278.152449419361;6292.811215663537;5933;5984.790532331347;6000.219971403733;6031.849203769941;6082.9695851520455;5643.971780141155;6158.891399548124;6336.366363363719;6401.807945761635;6421.935780642134;6013.819585412444;6216.191895053614;6279.403456671609;6282.780102696383;6283.465905398001;6165.0444181152;6188.938110618927;6213.2233470816145;6247.187865577446;6306.054091886253;6170;6264.373562643699;6273.0904018917;6307.716152773136;6310.5267104967315;6247.781327653601;6263.248410190715;6281.748730050746;6286.339934306923;6293.056041593798;4395.318725597537;4942.28336891156;4984.40187177541;5002.824901128443;5002.957829797985;4473.188358714726;4511.052678937394;4526.0721552082405;4546.272596384562;4562.84030058953;5287.471252874759;5847.181394604759;5851.531877449794;5865.35481097079;5873.383294754075;6184.257889053252;6190.0405437157315;6226.875462490725;6241.375862413723;6265;5808.215890854765;5818.2436283282905;5821.505172060338;5851.64890106595;5861.0915308127305;5457.945420545823;5488.902219556025;5512.889742205133;5515.172724091338;5516.613837031369;6205.5345849060595;6373.74505019794;6374.362563743589;6383.4574061204385;6397.328280530571;6267.310595834363;6301.590396624205;6309.779157729457;6316.273628532594;6320.1467801848;6470;6473.935260647521;6496.935030649633;6503.2196136462035;6517.674116294072;6131.509479241739;6154.446099851035;6170.938290617037;6276.937230627818;6299.212598425197;5295.814646487354;6244.781432649836;6291.433770960452;6291.937080629135;6296.496280297657;6163.318986130902;6185.474234689922;6205.968970155121;6237;6240.500759939103;6075.362086980804;6144.832481828438;6145.784897528565;6199.576643501942;6250.3749625037135;5942.762289508544;6121.204243448501;6121.574916084701;6159;6161.383861613803;5891.764329426775;6223.301407437356;6239.37993739749;6251.499880009497;6259.123722678738;5893.145493903446;6065.332813390435;6114.174586430953;6126.989046807227;6162.876742465036 12:17:52 INFO - PROCESS | 1651 | |1;ext.html;475.3748820301304;496.32995456134245;505.5399586376397;536.5198147657844;537.175435706191;38644;41986.58013419865;42145.15330736966;42216;42223.155536889244;42300.57699423005;42717.35923961143;42763.358549621706;42833.35749963745;42927;9636.325457218016;9827.754306142368;9839.655612053579;9856.901430985707;9881.505924703735;9636.566354514029;9758.658446954358;9785.657501987433;9788.168005719523;9789.510524473748;9768.316217864753;9789.412635241873;9791.510424478784;9801.970793066732;9835.90164098357;9781.41311521311;9781.755456113582;9782.119609235131;9783.119519243266;9798.804023919552;9724.465154416504;9806.068423499755;9817.263705222136;9824;9828.066333698287;40663;40737;40847.774566763044;41008;41069.589304107176;2802.8028028028084;3282.2122690554334;3487.8256087195537;3563;3570.339487194877;30803.767849286003;31528.36943261145;31634.525482117788;31780.364392712247;31869.521957170662;3131.7181453669277;3134.7492200623897;3134.9686503134903;3169;3265.216348076445;428895;433501;433979.6602033971;435609;436250;34066.97799066032;34482;34660.133496662784;34796.956091316795;34978.475322870174;30623.540646890313;35785;35835.64164358323;36043.279134417164;36195.457068144;14878.181700006604;14891.925540372229;14999.32503037344;15012;15041.473548425753;12263.693407664701;12470.376481175905;12483.687907802196;12578.119531632881;12609.991200703922;7719.92280077192;7846.136924938252;7858.489198202098;7886.684532618631;7911.643976021093;3265.8856940007463;3294.4399452093203;3302.884399046022;3307.074019274607;3326.7338612910908;895.4582477601087;910.2581396162107;1065;1068.7435015596202;1077.3589714120087;28537.57193642097;30839.383212336077;30911;31343.68656313453;31863.044108676775;1010.0909181736496;1015.57345914716;1035.8498017787379;1065.1638463805875;1083.7940791249637;15786.21068946548;15822.52532424029;16253.024818510927;16295.59261018484;16616.58458538522;157621;188826;190854;191453;191686;61832.38167618266;61928;62262.37737622656;62643.373566263755;62912;1227.533537255837;1341.698117923479;1371.8559551247174;1417.0364152376483;1420.155007770375;26859.32851678724;29647.25881852971;29870.25324366908;30439.54340684936;30531.542026870058;48963.75518122387;54083.45916540784;54139.72930135324;54184.18723719069;54291.91416171575;591175;592217;592219;593660;593875;27574;27591.586126208524;27665.861670692324;27832;27833.16500504988;48825.5117448821;49672.50327496679;49725;50195.498045019085;50587.49412505975;40152.1969560613;40652.59347406607;40708.38937415882;40768.388474172316;41811.581884181986;40622.79688601538;40853.77438676845;41608.791956040026;42306;42387.788061059495;37433.25133497261;39127.63053293121;39300;39975.40098396032;40123.598764011986;34556.481652774724;35035.124121897155;35898.28203435969;36024.63975360318;36086;25899.87050064813;26391.4721705561;26473.205803825917;26860.194194174204;27173 12:17:52 INFO - PROCESS | 1651 | |2;jquery.html;364.41875209041586;377.15705398434494;380.47114510829954;390.29162070841437;405.50528355406414;19016;21124.57750844982;21295.25466608669;21402.57194856104;21832.454188645293;16951.91524042378;20335.28826491073;21396.823174725385;21439.678404823902;21696.566068678658;5581.274434323533;5646.54827613792;5840.386759390267;6033.215681961339;6052.636841789485;4121.711480196387;5967.731452084645;6025.668588227646;6033.7888173913925;6298.842528936768;6494.805155845309;6638.93361066388;6648.069270302161;6656.134702488694;6659.101021362103;6485.735281620086;6543.869122617521;6568.376004279586;6612.041254018189;6615.272320044791;5580.804671836507;5653.717314134318;5679.574031947621;5722.799702010451;5751.367349591542;22070.88964555183;22117;25332.73336333176;25741.613875791878;25875.353116172057;2240.8207343412487;2287.74174204187;2330.6270996640624;2408.5303365843665;3047.4514587374265;11409.20135590509;13231.66920826987;13633.727325453436;15896.84103158965;16513.853199084042;1642.82750311218;1886.3303527247904;1888.1975160556708;1891.498752830501;1909.6849019911697;93503;115030.1242468945;125749;127491.36254318761;129150;9049.276057915351;10785.56857725698;10811.081058110149;11245.212835101463;11374.31754094757;12032.81950770739;13867.23730194849;13922.860771392156;13924.443022278996;13963.860361396257;8468;8718.651253949898;8762.956185219033;8860.601272942733;8873.112688731075;8027.956365672425;8117.878231826528;8791.428557143765;8804.075572064841;8940.68707595231;6601.570897891717;6853.828654283683;6877.931220687729;6918.584884906922;6943.479239057091;1600.8959417637816;1686.2833295849216;1850.9722354164699;1890.773107227114;1893.7727472703089;295.3222354695978;378.36434789553266;402.0992975734334;696.9024336592881;944.4805357053593;9838.409695418297;11823.645290641294;11951.22317049389;12173.391330433444;12357.011439084852;407.52523310343116;426.60112794537207;428.36815696847526;436.7117702316456;468.3630262842531;5303.761330740049;5851.795187168514;6183.938160618426;6282.120503129566;6324.557280990379;602064;626201;626738;629561;651470;137635;138183.30908345393;140510;142393;143699;386.7238114223053;434.35932000299306;446.94189755332246;449.55494060879494;449.5571861716207;11037.83443248368;11240.662780116609;11267.323960562393;11502.884971150515;11553;52615.73692131668;53529;53805.73097134489;54092.72953635207;55177.448225518834;77686;79247;82080.358392833;82136;88321.55839220763;7920.920790792018;8155.7766335047845;8160.387970902088;8501.404901656824;8532.061473238064;8444.282236010007;8946.821063578822;9017.143371379709;9303.534823258946;9484.715458536255;6653.467722582279;6742.696578653874;7752.224777522429;7992.5204487730925;8230.83538329242;5849.005669036189;7952;8160.551169685724;8364.498130112213;8453.91546084556;8091.433599647969;8208.302294304813;8340.332773377993;8501.617427215666;8592.78518037029;12435.564755233523;12965.546205883125;13053.934730326288;13284.468621255042;13374.732505349644;11810.17328787011;11875.346855922662;11928.76142477163;12176.75646487083;12268 12:17:52 INFO - PROCESS | 1651 | |3;mootools.html;1536.4852774320605;1565.6868626274745;1793.8744287899851;1842.5946291815796;1891.659501289768;7062.5056246062795;7607.54354738716;7847.489913155641;8376.581170941452;8940.418872773265;8596.183362580545;8806.77983050424;8822.558872056388;8823.647054117844;8849.646014159442;2333.883305834706;2374.4182675244588;2374.5013547155118;2381.9642705359433;2390.760923907613;2341.110378056345;2357.3635118518077;2381.6427535869584;2383.261189031397;2383.9642405363848;2101.770464278399;2279.7378301495373;2279.9886000569973;2342.016353131689;2382.094803974487;2045.8158765711082;2332.953340933172;2364.621660534306;2364.7280562735245;2369.490559529701;2341.438054866837;2348.8825558722165;2349.201271567675;2352;2353.7881590656925;8739.694110706096;8899.110088991114;8941.59762810675;8963.55182240892;8997.910020899773;4545.181867263891;5166.199239117943;5337.946620533784;5338.145896656516;5364.678119312854;2977.910662680123;3000.1899487138567;3283.819389933553;3368.3936891359544;3499.5100685903994;1084.821004534251;1089.7330154112294;1090.1878100814865;1111.9166062545341;1116.4696769034724;11453.255538389978;11453.828192577119;11563.826542601868;11591.594294199662;11600.535978560847;3878.45701601776;4502;4574.931376029363;4699.577038066591;4806.182948898696;9804.852927206097;9895.554700038516;9905.851412228822;9906.712127423389;9937.950310248403;5315.282436870973;5324.5207931285595;5331.093714068617;5332.226827110125;5385.111456609616;4372.3878656988045;4699.224627936353;4818;4854;4879.756012199376;3362.815045172539;3885.8834234972996;3902.102516421239;4043.0903046814233;4079.4084857695466;1288.8195652608642;1298.1497119386818;1299.8635143310005;1307.6796184934751;1307.82344383507;636.4558302651259;932.9020452852353;964.8842138943231;976.5703090640095;977.7018009507026;5905.616134951214;5925.822225333247;6034.48706859913;6216.689165541705;6236.812895613139;436.85583757359996;438.6863392674253;441.3071477779855;447.0968643340434;459.5037359651568;4037.4953130858644;4058.898527536835;4147.751134931854;4167.562405947392;4191.832326706958;10485.213608979204;10669.253152279265;10763.677089687322;10797.46012699362;10892.836607450894;10300.845487317696;10715.83926241107;10717.678469645924;10738.624148154777;10747.086497647631;6316;8178;8201.95899020513;8208.548529830798;8223.794405139799;5792.7103644818435;5919.141724450017;5923.763049478145;6008.489278411384;6026.427489388501;9948.552315145691;9979.501024948579;9992.200623950212;10005.149562287286;10022.298439109192;9671.806563868542;10104;10109.494525273854;10146.79706405853;10357;6752.3922846944015;7599.506032107895;8154.8175514548875;8296.170382961656;8380.24577788002;8573.785655358666;8580.570971451527;8618;8641.783955401166;8655.91344086551;7493.662785174572;7537.924620753942;7582.54504729718;7627.961860190663;7647.694092236248;7035;7380.1512826023545;7435.33082022599;7442.181360050498;7495.17553069151;6985.231624521401;7160.856782864209;7161.820954476179;7178.533395329287;7196.96401517989;4999.375078115236;5143.022825663112;5151.571044721084;5180.637355385087;5201.037808005531;5048.495150484922;5063.493650634907;5135.897282054413;5213.608979326642;5274.287971123849 12:17:52 INFO - PROCESS | 1651 | |4;prototype.html;303.87085488667327;309.91787176398253;317.71247021445595;318.6415282806842;320.67451536690265;5367.543758780508;5457.454254574541;5498.862528436791;5662.405447428023;5692.772289108436;4408.603225709686;4668.766561671911;5495.670259784406;5699.173619825133;5723.856903577413;3412.931741365171;4176.2900306947895;4303.13937212558;4353.67347448941;4354.695171338008;3551.769135006229;4212.726172798773;4266.424032755584;4350.3474478828275;4376.737395756249;3564.8930532084078;3717.925641487169;4258.91482170358;4317.460317460317;4346.978265108686;3735.711179643019;4274.465691788527;4283.935740963888;4302.784860756965;4331.848385306499;3242.540856614533;3637.236180402119;3750.924981500382;3754.4180651998986;3759.4360845873066;5131.153359695646;5277.736113194325;5498.45015498451;5504.779808807642;5575.414581468968;4806.702190408605;4851.733154676492;4854.563089321978;4948.540180646718;4993.952479483431;4821.421429428456;5743.45437183471;6022.879542409171;6053.485453736438;6056.121862329982;3266.950995735066;3859.710521710883;4083.5099788025627;4087.693422993287;4100.159467309194;5281.894362112736;5524.364698059734;5757.366689664133;6406.814739273249;6435.485161187094;3694.2980833641523;3837;4175.995522149325;4184;4210.326442708902;3862.8261728221737;4134.193832202692;4134.4831896013;4146.91706165881;4152.460180176618;4089.468369112056;4499.392582001388;4663.230566956482;4765;4896.4858689837765;4745.00709701926;5955.13650520672;5970.73092738694;6033.276006879115;6092.573519853568;1202.7955247607927;1265.0322503284995;1364.6110858405307;1399.6982805990324;1413.9151650900978;831.4055450353027;833.9416240863081;839.5368474178161;868.2186032570737;872.2193636695249;3801.581825999138;4130.8691308691305;4148.62662360389;4263.997960479285;4528.011512401865;4224.894377640584;4371.890702732394;5003.870258932779;5236.00515901985;5287.365516138088;4187.361961964004;4628.958484340997;4641.303804429295;4655.371524844103;4720.504347043511;2198.5383069555573;2408.674828898111;2596.039465397815;2627.908023219178;2769.0754925327105;4848.9757551212015;5098.770555324945;5126.949465068278;5352.343461188713;5362.839114826562;4633.594308183482;4635.397398338262;4776.379070720784;4852.568492294781;5128.794848206105;4507.81968721254;4973.234501751826;5087.949120508822;5294.444083371268;5330.387005494418;4445.533219011957;5070.935103628131;5181.222816577393;5292.576593872558;5308.309919710413;4280.78596070189;4758.500357462417;4796.232602783538;4943.887625284282;5221.624161006809;4333.8515293446635;5379.33722807213;5409.754951695002;5430.185472179205;5473.589480789036;3404.438267685804;3614.7108231340903;3815.275097731422;3833.7955675487265;3908.397557001729;6103.298120716175;6133.294671112701;6155.569110162246;6161.599496032743;6208.696173803552;4958.528939750718;5507.366652834815;6016.699165041643;6039.516838652809;6068.21113255274;4380.956190438055;5213.322268105122;5479.315085614298;5529.079119583494;5972;5401.945980540301;5814.94185058144;5818.563607729353;5821.650700957956;5878.882422351615;4941.382327209099;5233.790648374023;5717.742701578522;5932.822015339547;5940.79207227745;5402.621816472809;5614.877024595179;5833.300003999378;5847.26909136358;5852.561057920758 12:17:52 INFO - PROCESS | 1651 | |5;yui.html;693.5630552751766;744.4081954845897;771.1825465007089;774.2219069834813;800.3637108498743;15150.621234469143;15871.206439677999;15883.841161588382;15930;15931.522054338375;14208.573742787707;14355.71288574228;14357.282135893216;14361.066530675525;14375.712485750279;677.5832862789374;821.5276216175693;831.9251267385933;858.6393714639867;860.6772460327377;845.8942632170979;849.133883438892;853.4196746212573;853.6585365853646;855.6534603485599;884.7168905950099;910.3400034974624;915.281504019345;917.0416914324547;917.5824999625188;799.6041959230189;876.750126214026;905.7373361725092;906.6690657909882;907.0249481807051;643.6781609195402;658.9736410543572;661.2395744893411;679.2833560593572;681.0669382945397;14530.273486325641;14766.926165369105;14829.703405931929;14884.255787210705;14900.031497952707;14459;14528.636784080376;14536.200508972002;14559.417623295056;14567.854321456756;11943.761124777542;12212;12455.190412623151;12462.75074498514;12560.120791544596;3815.4276858471176;3827.4832897558754;4029.073313137965;4058.0260737422805;4058.8376464941366;118976;121721.39139304335;121815;122326;123065;11077.224594278323;11200.327980321206;11206;11277.830832537518;11801.40992950349;22953.311400658007;23037.308880733606;23042.539149216922;23044.65433018506;23146;7921.683132674743;8124.634391452399;8139.918600814034;8220.8355832883;8411.411201215979;3898.6686131679126;4533.410656614619;4533.637309015271;4568.383268258809;4589.885252868705;3575.8390872410805;3594.8741794037082;3652.8356223969454;3671.173985853162;3796.9430458543143;711.779348401997;719.3993015831735;724.4928550014905;728.9903483675148;740.489062546841;510.68082448469704;657.5298661457081;688.7761477519826;697.9965100174467;701.3792793377897;9192.356535042483;9304.813903721888;9493.430394176372;9493.810123797486;9683.467409292556;601.9277686677626;625.1747693045137;651.9543631945813;659.4691273524762;684.165318311659;3903.701372340368;4294.957050429518;4426.734395936254;4624.398828152386;4786.6888652238185;99653;138382;156935;159137.20431398;162774;141902.2904885469;142665;143462;143694.9999999979;145333;100320;107046;119781;125679.3716031414;126233.36883315709;7964.7654613535;8231.629576668944;8979.10208979097;8982.640694372152;9089.545522723969;55992;66469;66861.33138668552;67204.6639766798;69237;80913;83395;84901;101807;108282.91717082728;13508.32458377097;13523.256220907944;13643.113197642122;13678.384472698554;13927.721445570829;15015;15211;15584;15605.687886241985;15624;13952.372143253375;13961.232132232824;14478.058926169766;14540.41838326455;14554.053986490844;13328.733425331633;13966.58100256994;13993.720125597227;14272.500462484179;14306.752999086104;10545.156387489136;11557.422128893353;12531;13599.388027538982;13617.455301787817;9578.425294482353;11442.828357574477;11603.767924641292;11681.824772628248;11986.580469683518;10803.621873234713;11242.437878105899;11485.970841551272;11743.060555155396;11778.587749428729 12:17:52 INFO - PROCESS | 1651 | __end_tp_report 12:17:52 INFO - PROCESS | 1651 | __start_cc_report 12:17:52 INFO - PROCESS | 1651 | _x_x_mozilla_cycle_collect,403 12:17:52 INFO - PROCESS | 1651 | __end_cc_report 12:17:52 INFO - PROCESS | 1651 | __startTimestamp1470943072251__endTimestamp 12:17:52 INFO - PROCESS | 1651 | 12:17:52 INFO - PROCESS | 1651 | ------- Summary: start ------- 12:17:52 INFO - PROCESS | 1651 | Number of tests: 6 12:17:52 INFO - PROCESS | 1651 | 12:17:52 INFO - PROCESS | 1651 | [#0] dojo.html Cycles:165 Average:5784.93 Median:6075.36 stddev:680.87 (11.2%) stddev-sans-first:657.55 12:17:52 INFO - PROCESS | 1651 | Values: 3436.1 3442.9 3462.4 3467.7 3486.6 4693.2 5683.3 5709.8 5745.7 5820.5 5782.9 5797.5 5809.9 5847.2 5910.1 3825.1 4094.9 5161.2 5259.9 5364.2 5418.6 5420.6 5435.3 5464.0 5486.7 4478.5 5195.0 5248.0 5313.2 5417.4 5297.9 5343.3 5344.7 5362.0 5385.4 4425.3 5294.1 5300.7 5301.2 5381.1 5600.6 5770.8 5819.2 5873.3 5940.2 5871.6 6298.7 6300.2 6307.8 6318.9 6154.0 6232.9 6271.4 6278.2 6292.8 5933.0 5984.8 6000.2 6031.8 6083.0 5644.0 6158.9 6336.4 6401.8 6421.9 6013.8 6216.2 6279.4 6282.8 6283.5 6165.0 6188.9 6213.2 6247.2 6306.1 6170.0 6264.4 6273.1 6307.7 6310.5 6247.8 6263.2 6281.7 6286.3 6293.1 4395.3 4942.3 4984.4 5002.8 5003.0 4473.2 4511.1 4526.1 4546.3 4562.8 5287.5 5847.2 5851.5 5865.4 5873.4 6184.3 6190.0 6226.9 6241.4 6265.0 5808.2 5818.2 5821.5 5851.6 5861.1 5457.9 5488.9 5512.9 5515.2 5516.6 6205.5 6373.7 6374.4 6383.5 6397.3 6267.3 6301.6 6309.8 6316.3 6320.1 6470.0 6473.9 6496.9 6503.2 6517.7 6131.5 6154.4 6170.9 6276.9 6299.2 5295.8 6244.8 6291.4 6291.9 6296.5 6163.3 6185.5 6206.0 6237.0 6240.5 6075.4 6144.8 6145.8 6199.6 6250.4 5942.8 6121.2 6121.6 6159.0 6161.4 5891.8 6223.3 6239.4 6251.5 6259.1 5893.1 6065.3 6114.2 6127.0 6162.9 12:17:52 INFO - PROCESS | 1651 | 12:17:52 INFO - PROCESS | 1651 | [#1] ext.html Cycles:180 Average:55201.88 Median:39213.82 stddev:117248.00 (299.0%) stddev-sans-first:117504.91 12:17:52 INFO - PROCESS | 1651 | Values: 475.4 496.3 505.5 536.5 537.2 38644.0 41986.6 42145.2 42216.0 42223.2 42300.6 42717.4 42763.4 42833.4 42927.0 9636.3 9827.8 9839.7 9856.9 9881.5 9636.6 9758.7 9785.7 9788.2 9789.5 9768.3 9789.4 9791.5 9802.0 9835.9 9781.4 9781.8 9782.1 9783.1 9798.8 9724.5 9806.1 9817.3 9824.0 9828.1 40663.0 40737.0 40847.8 41008.0 41069.6 2802.8 3282.2 3487.8 3563.0 3570.3 30803.8 31528.4 31634.5 31780.4 31869.5 3131.7 3134.7 3135.0 3169.0 3265.2 428895.0 433501.0 433979.7 435609.0 436250.0 34067.0 34482.0 34660.1 34797.0 34978.5 30623.5 35785.0 35835.6 36043.3 36195.5 14878.2 14891.9 14999.3 15012.0 15041.5 12263.7 12470.4 12483.7 12578.1 12610.0 7719.9 7846.1 7858.5 7886.7 7911.6 3265.9 3294.4 3302.9 3307.1 3326.7 895.5 910.3 1065.0 1068.7 1077.4 28537.6 30839.4 30911.0 31343.7 31863.0 1010.1 1015.6 1035.8 1065.2 1083.8 15786.2 15822.5 16253.0 16295.6 16616.6 157621.0 188826.0 190854.0 191453.0 191686.0 61832.4 61928.0 62262.4 62643.4 62912.0 1227.5 1341.7 1371.9 1417.0 1420.2 26859.3 29647.3 29870.3 30439.5 30531.5 48963.8 54083.5 54139.7 54184.2 54291.9 591175.0 592217.0 592219.0 593660.0 593875.0 27574.0 27591.6 27665.9 27832.0 27833.2 48825.5 49672.5 49725.0 50195.5 50587.5 40152.2 40652.6 40708.4 40768.4 41811.6 40622.8 40853.8 41608.8 42306.0 42387.8 37433.3 39127.6 39300.0 39975.4 40123.6 34556.5 35035.1 35898.3 36024.6 36086.0 25899.9 26391.5 26473.2 26860.2 27173.0 12:17:52 INFO - PROCESS | 1651 | 12:17:52 INFO - PROCESS | 1651 | [#2] jquery.html Cycles:180 Average:35630.43 Median:26542.05 stddev:105004.93 (395.6%) stddev-sans-first:105266.11 12:17:52 INFO - PROCESS | 1651 | Values: 364.4 377.2 380.5 390.3 405.5 19016.0 21124.6 21295.3 21402.6 21832.5 16951.9 20335.3 21396.8 21439.7 21696.6 5581.3 5646.5 5840.4 6033.2 6052.6 4121.7 5967.7 6025.7 6033.8 6298.8 6494.8 6638.9 6648.1 6656.1 6659.1 6485.7 6543.9 6568.4 6612.0 6615.3 5580.8 5653.7 5679.6 5722.8 5751.4 22070.9 22117.0 25332.7 25741.6 25875.4 2240.8 2287.7 2330.6 2408.5 3047.5 11409.2 13231.7 13633.7 15896.8 16513.9 1642.8 1886.3 1888.2 1891.5 1909.7 93503.0 115030.1 125749.0 127491.4 129150.0 9049.3 10785.6 10811.1 11245.2 11374.3 12032.8 13867.2 13922.9 13924.4 13963.9 8468.0 8718.7 8763.0 8860.6 8873.1 8028.0 8117.9 8791.4 8804.1 8940.7 6601.6 6853.8 6877.9 6918.6 6943.5 1600.9 1686.3 1851.0 1890.8 1893.8 295.3 378.4 402.1 696.9 944.5 9838.4 11823.6 11951.2 12173.4 12357.0 407.5 426.6 428.4 436.7 468.4 5303.8 5851.8 6183.9 6282.1 6324.6 602064.0 626201.0 626738.0 629561.0 651470.0 137635.0 138183.3 140510.0 142393.0 143699.0 386.7 434.4 446.9 449.6 449.6 11037.8 11240.7 11267.3 11502.9 11553.0 52615.7 53529.0 53805.7 54092.7 55177.4 77686.0 79247.0 82080.4 82136.0 88321.6 7920.9 8155.8 8160.4 8501.4 8532.1 8444.3 8946.8 9017.1 9303.5 9484.7 6653.5 6742.7 7752.2 7992.5 8230.8 5849.0 7952.0 8160.6 8364.5 8453.9 8091.4 8208.3 8340.3 8501.6 8592.8 12435.6 12965.5 13053.9 13284.5 13374.7 11810.2 11875.3 11928.8 12176.8 12268.0 12:17:52 INFO - PROCESS | 1651 | 12:17:52 INFO - PROCESS | 1651 | [#3] mootools.html Cycles:180 Average:5699.33 Median:4866.88 stddev:3219.12 (66.1%) stddev-sans-first:3212.95 12:17:52 INFO - PROCESS | 1651 | Values: 1536.5 1565.7 1793.9 1842.6 1891.7 7062.5 7607.5 7847.5 8376.6 8940.4 8596.2 8806.8 8822.6 8823.6 8849.6 2333.9 2374.4 2374.5 2382.0 2390.8 2341.1 2357.4 2381.6 2383.3 2384.0 2101.8 2279.7 2280.0 2342.0 2382.1 2045.8 2333.0 2364.6 2364.7 2369.5 2341.4 2348.9 2349.2 2352.0 2353.8 8739.7 8899.1 8941.6 8963.6 8997.9 4545.2 5166.2 5337.9 5338.1 5364.7 2977.9 3000.2 3283.8 3368.4 3499.5 1084.8 1089.7 1090.2 1111.9 1116.5 11453.3 11453.8 11563.8 11591.6 11600.5 3878.5 4502.0 4574.9 4699.6 4806.2 9804.9 9895.6 9905.9 9906.7 9938.0 5315.3 5324.5 5331.1 5332.2 5385.1 4372.4 4699.2 4818.0 4854.0 4879.8 3362.8 3885.9 3902.1 4043.1 4079.4 1288.8 1298.1 1299.9 1307.7 1307.8 636.5 932.9 964.9 976.6 977.7 5905.6 5925.8 6034.5 6216.7 6236.8 436.9 438.7 441.3 447.1 459.5 4037.5 4058.9 4147.8 4167.6 4191.8 10485.2 10669.3 10763.7 10797.5 10892.8 10300.8 10715.8 10717.7 10738.6 10747.1 6316.0 8178.0 8202.0 8208.5 8223.8 5792.7 5919.1 5923.8 6008.5 6026.4 9948.6 9979.5 9992.2 10005.1 10022.3 9671.8 10104.0 10109.5 10146.8 10357.0 6752.4 7599.5 8154.8 8296.2 8380.2 8573.8 8580.6 8618.0 8641.8 8655.9 7493.7 7537.9 7582.5 7628.0 7647.7 7035.0 7380.2 7435.3 7442.2 7495.2 6985.2 7160.9 7161.8 7178.5 7197.0 4999.4 5143.0 5151.6 5180.6 5201.0 5048.5 5063.5 5135.9 5213.6 5274.3 12:17:52 INFO - PROCESS | 1651 | 12:17:52 INFO - PROCESS | 1651 | [#4] prototype.html Cycles:180 Average:4490.49 Median:4835.20 stddev:1391.98 (28.8%) stddev-sans-first:1359.96 12:17:52 INFO - PROCESS | 1651 | Values: 303.9 309.9 317.7 318.6 320.7 5367.5 5457.5 5498.9 5662.4 5692.8 4408.6 4668.8 5495.7 5699.2 5723.9 3412.9 4176.3 4303.1 4353.7 4354.7 3551.8 4212.7 4266.4 4350.3 4376.7 3564.9 3717.9 4258.9 4317.5 4347.0 3735.7 4274.5 4283.9 4302.8 4331.8 3242.5 3637.2 3750.9 3754.4 3759.4 5131.2 5277.7 5498.5 5504.8 5575.4 4806.7 4851.7 4854.6 4948.5 4994.0 4821.4 5743.5 6022.9 6053.5 6056.1 3267.0 3859.7 4083.5 4087.7 4100.2 5281.9 5524.4 5757.4 6406.8 6435.5 3694.3 3837.0 4176.0 4184.0 4210.3 3862.8 4134.2 4134.5 4146.9 4152.5 4089.5 4499.4 4663.2 4765.0 4896.5 4745.0 5955.1 5970.7 6033.3 6092.6 1202.8 1265.0 1364.6 1399.7 1413.9 831.4 833.9 839.5 868.2 872.2 3801.6 4130.9 4148.6 4264.0 4528.0 4224.9 4371.9 5003.9 5236.0 5287.4 4187.4 4629.0 4641.3 4655.4 4720.5 2198.5 2408.7 2596.0 2627.9 2769.1 4849.0 5098.8 5126.9 5352.3 5362.8 4633.6 4635.4 4776.4 4852.6 5128.8 4507.8 4973.2 5087.9 5294.4 5330.4 4445.5 5070.9 5181.2 5292.6 5308.3 4280.8 4758.5 4796.2 4943.9 5221.6 4333.9 5379.3 5409.8 5430.2 5473.6 3404.4 3614.7 3815.3 3833.8 3908.4 6103.3 6133.3 6155.6 6161.6 6208.7 4958.5 5507.4 6016.7 6039.5 6068.2 4381.0 5213.3 5479.3 5529.1 5972.0 5401.9 5814.9 5818.6 5821.7 5878.9 4941.4 5233.8 5717.7 5932.8 5940.8 5402.6 5614.9 5833.3 5847.3 5852.6 12:17:52 INFO - PROCESS | 1651 | 12:17:52 INFO - PROCESS | 1651 | [#5] yui.html Cycles:180 Average:25812.12 Median:3585.36 stddev:41633.51 (1161.2%) stddev-sans-first:41707.58 12:17:52 INFO - PROCESS | 1651 | Values: 693.6 744.4 771.2 774.2 800.4 15150.6 15871.2 15883.8 15930.0 15931.5 14208.6 14355.7 14357.3 14361.1 14375.7 677.6 821.5 831.9 858.6 860.7 845.9 849.1 853.4 853.7 855.7 884.7 910.3 915.3 917.0 917.6 799.6 876.8 905.7 906.7 907.0 643.7 659.0 661.2 679.3 681.1 14530.3 14766.9 14829.7 14884.3 14900.0 14459.0 14528.6 14536.2 14559.4 14567.9 11943.8 12212.0 12455.2 12462.8 12560.1 3815.4 3827.5 4029.1 4058.0 4058.8 118976.0 121721.4 121815.0 122326.0 123065.0 11077.2 11200.3 11206.0 11277.8 11801.4 22953.3 23037.3 23042.5 23044.7 23146.0 7921.7 8124.6 8139.9 8220.8 8411.4 3898.7 4533.4 4533.6 4568.4 4589.9 3575.8 3594.9 3652.8 3671.2 3796.9 711.8 719.4 724.5 729.0 740.5 510.7 657.5 688.8 698.0 701.4 9192.4 9304.8 9493.4 9493.8 9683.5 601.9 625.2 652.0 659.5 684.2 3903.7 4295.0 4426.7 4624.4 4786.7 99653.0 138382.0 156935.0 159137.2 162774.0 141902.3 142665.0 143462.0 143695.0 145333.0 100320.0 107046.0 119781.0 125679.4 126233.4 7964.8 8231.6 8979.1 8982.6 9089.5 55992.0 66469.0 66861.3 67204.7 69237.0 80913.0 83395.0 84901.0 101807.0 108282.9 13508.3 13523.3 13643.1 13678.4 13927.7 15015.0 15211.0 15584.0 15605.7 15624.0 13952.4 13961.2 14478.1 14540.4 14554.1 13328.7 13966.6 13993.7 14272.5 14306.8 10545.2 11557.4 12531.0 13599.4 13617.5 9578.4 11442.8 11603.8 11681.8 11986.6 10803.6 11242.4 11486.0 11743.1 11778.6 12:17:52 INFO - PROCESS | 1651 | -------- Summary: end -------- 12:17:52 INFO - PROCESS | 1651 | 12:17:52 INFO - TEST-INFO | 1651: exit 0 12:17:52 INFO - TEST-OK | dromaeo_css | took 1113859ms 12:17:52 INFO - TEST-START | kraken 12:17:52 INFO - operating with platform_type : mac_ 12:17:52 INFO - Initialising browser for kraken test... 12:17:52 INFO - TEST-INFO | started process 1663 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/tmpZ1T6hy/profile http://localhost:49266/getInfo.html) 12:17:55 INFO - PROCESS | 1663 | __metrics Screen width/height:1600/1200 12:17:55 INFO - PROCESS | 1663 | colorDepth:24 12:17:55 INFO - PROCESS | 1663 | Browser inner width/height: 1024/689 12:17:55 INFO - PROCESS | 1663 | __metrics 12:17:55 ERROR - PROCESS | 1663 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2983: TypeError: this.tabs is undefined 12:17:56 INFO - TEST-INFO | 1663: exit 0 12:17:56 INFO - Browser initialized. 12:17:56 INFO - Running cycle 1/1 for kraken test... 12:17:56 INFO - TEST-INFO | started process 1665 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/tmpZ1T6hy/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:18:08 INFO - PROCESS | 1665 | RSS: Main: 254844928 12:18:08 INFO - PROCESS | 1665 | 12:18:11 INFO - PROCESS | 1665 | 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) 12:18:12 INFO - PROCESS | 1665 | RSS: Main: 267386880 12:18:12 INFO - PROCESS | 1665 | 12:18:14 INFO - PROCESS | 1665 | 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) 12:18:15 INFO - PROCESS | 1665 | RSS: Main: 276127744 12:18:15 INFO - PROCESS | 1665 | 12:18:18 INFO - PROCESS | 1665 | 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) 12:18:19 INFO - PROCESS | 1665 | RSS: Main: 278999040 12:18:19 INFO - PROCESS | 1665 | 12:18:21 INFO - PROCESS | 1665 | 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) 12:18:22 INFO - PROCESS | 1665 | RSS: Main: 281485312 12:18:22 INFO - PROCESS | 1665 | 12:18:24 INFO - PROCESS | 1665 | 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) 12:18:25 INFO - PROCESS | 1665 | RSS: Main: 281903104 12:18:25 INFO - PROCESS | 1665 | 12:18:28 INFO - PROCESS | 1665 | 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) 12:18:28 INFO - PROCESS | 1665 | RSS: Main: 282005504 12:18:28 INFO - PROCESS | 1665 | 12:18:31 INFO - PROCESS | 1665 | 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) 12:18:32 INFO - PROCESS | 1665 | RSS: Main: 282243072 12:18:32 INFO - PROCESS | 1665 | 12:18:35 INFO - PROCESS | 1665 | 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) 12:18:36 INFO - PROCESS | 1665 | RSS: Main: 282697728 12:18:36 INFO - PROCESS | 1665 | 12:18:37 INFO - PROCESS | 1665 | 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) 12:18:38 INFO - PROCESS | 1665 | RSS: Main: 282669056 12:18:38 INFO - PROCESS | 1665 | 12:18:40 INFO - PROCESS | 1665 | 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) 12:18:40 INFO - PROCESS | 1665 | RSS: Main: 282963968 12:18:40 INFO - PROCESS | 1665 | 12:18:43 INFO - PROCESS | 1665 | 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) 12:18:43 INFO - PROCESS | 1665 | RSS: Main: 283037696 12:18:43 INFO - PROCESS | 1665 | 12:18:46 INFO - PROCESS | 1665 | 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) 12:18:47 INFO - PROCESS | 1665 | RSS: Main: 282910720 12:18:47 INFO - PROCESS | 1665 | 12:18:50 INFO - PROCESS | 1665 | 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) 12:18:50 INFO - PROCESS | 1665 | RSS: Main: 282873856 12:18:50 INFO - PROCESS | 1665 | 12:18:52 INFO - PROCESS | 1665 | 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) 12:18:52 INFO - PROCESS | 1665 | RSS: Main: 283959296 12:18:52 INFO - PROCESS | 1665 | 12:18:52 INFO - PROCESS | 1665 | __start_tp_report 12:18:52 INFO - PROCESS | 1665 | _x_x_mozilla_page_load 12:18:52 INFO - PROCESS | 1665 | _x_x_mozilla_page_load_details 12:18:52 INFO - PROCESS | 1665 | |i|pagename|runs| 12:18:52 INFO - PROCESS | 1665 | |0;ai-astar;113;117;107;119;117;126;164;169;126;116 12:18:52 INFO - PROCESS | 1665 | |1;audio-beat-detection;141;134;120;192;147;165;166;97;159;141 12:18:52 INFO - PROCESS | 1665 | |2;audio-dft;206;236;196;199;194;202;192;197;194;194 12:18:52 INFO - PROCESS | 1665 | |3;audio-fft;75;77;95;167;76;82;82;90;160;58 12:18:52 INFO - PROCESS | 1665 | |4;audio-oscillator;69;75;122;71;73;83;146;105;75;110 12:18:52 INFO - PROCESS | 1665 | |5;imaging-gaussian-blur;77;134;137;90;95;120;90;93;136;116 12:18:52 INFO - PROCESS | 1665 | |6;imaging-darkroom;95;94;95;96;97;95;111;153;114;96 12:18:52 INFO - PROCESS | 1665 | |7;imaging-desaturate;149;146;93;94;92;91;95;90;93;139 12:18:52 INFO - PROCESS | 1665 | |8;json-parse-financial;56;54;58;54;58;57;57;59;57;57 12:18:52 INFO - PROCESS | 1665 | |9;json-stringify-tinderbox;68;71;99;67;101;118;116;114;60;93 12:18:52 INFO - PROCESS | 1665 | |10;stanford-crypto-aes;83;82;87;88;85;102;87;87;87;84 12:18:52 INFO - PROCESS | 1665 | |11;stanford-crypto-ccm;132;135;156;138;168;161;155;148;165;140 12:18:52 INFO - PROCESS | 1665 | |12;stanford-crypto-pbkdf2;169;166;195;164;163;226;229;174;166;166 12:18:52 INFO - PROCESS | 1665 | |13;stanford-crypto-sha256-iterative;67;68;67;69;69;68;68;80;86;74 12:18:52 INFO - PROCESS | 1665 | __end_tp_report 12:18:52 INFO - PROCESS | 1665 | __start_cc_report 12:18:52 INFO - PROCESS | 1665 | _x_x_mozilla_cycle_collect,1045 12:18:52 INFO - PROCESS | 1665 | __end_cc_report 12:18:52 INFO - PROCESS | 1665 | __startTimestamp1470943132987__endTimestamp 12:18:52 INFO - PROCESS | 1665 | 12:18:52 INFO - PROCESS | 1665 | ------- Summary: start ------- 12:18:52 INFO - PROCESS | 1665 | Number of tests: 14 12:18:52 INFO - PROCESS | 1665 | 12:18:52 INFO - PROCESS | 1665 | [#0] ai-astar Cycles:10 Average:127.40 Median:122.50 stddev:21.38 (17.5%) stddev-sans-first:22.03 12:18:52 INFO - PROCESS | 1665 | Values: 113.0 117.0 107.0 119.0 117.0 126.0 164.0 169.0 126.0 116.0 12:18:52 INFO - PROCESS | 1665 | 12:18:52 INFO - PROCESS | 1665 | [#1] audio-beat-detection Cycles:10 Average:146.20 Median:162.00 stddev:26.49 (16.4%) stddev-sans-first:28.03 12:18:52 INFO - PROCESS | 1665 | Values: 141.0 134.0 120.0 192.0 147.0 165.0 166.0 97.0 159.0 141.0 12:18:52 INFO - PROCESS | 1665 | 12:18:52 INFO - PROCESS | 1665 | [#2] audio-dft Cycles:10 Average:201.00 Median:198.00 stddev:13.01 (6.6%) stddev-sans-first:13.68 12:18:52 INFO - PROCESS | 1665 | Values: 206.0 236.0 196.0 199.0 194.0 202.0 192.0 197.0 194.0 194.0 12:18:52 INFO - PROCESS | 1665 | 12:18:52 INFO - PROCESS | 1665 | [#3] audio-fft Cycles:10 Average:96.20 Median:79.50 stddev:36.84 (46.3%) stddev-sans-first:38.26 12:18:52 INFO - PROCESS | 1665 | Values: 75.0 77.0 95.0 167.0 76.0 82.0 82.0 90.0 160.0 58.0 12:18:52 INFO - PROCESS | 1665 | 12:18:52 INFO - PROCESS | 1665 | [#4] audio-oscillator Cycles:10 Average:92.90 Median:72.00 stddev:26.44 (36.7%) stddev-sans-first:26.59 12:18:52 INFO - PROCESS | 1665 | Values: 69.0 75.0 122.0 71.0 73.0 83.0 146.0 105.0 75.0 110.0 12:18:52 INFO - PROCESS | 1665 | 12:18:52 INFO - PROCESS | 1665 | [#5] imaging-gaussian-blur Cycles:10 Average:108.80 Median:83.50 stddev:22.37 (26.8%) stddev-sans-first:20.56 12:18:52 INFO - PROCESS | 1665 | Values: 77.0 134.0 137.0 90.0 95.0 120.0 90.0 93.0 136.0 116.0 12:18:52 INFO - PROCESS | 1665 | 12:18:52 INFO - PROCESS | 1665 | [#6] imaging-darkroom Cycles:10 Average:104.60 Median:95.00 stddev:18.46 (19.4%) stddev-sans-first:19.25 12:18:52 INFO - PROCESS | 1665 | Values: 95.0 94.0 95.0 96.0 97.0 95.0 111.0 153.0 114.0 96.0 12:18:52 INFO - PROCESS | 1665 | 12:18:52 INFO - PROCESS | 1665 | [#7] imaging-desaturate Cycles:10 Average:108.20 Median:92.50 stddev:25.32 (27.4%) stddev-sans-first:22.14 12:18:52 INFO - PROCESS | 1665 | Values: 149.0 146.0 93.0 94.0 92.0 91.0 95.0 90.0 93.0 139.0 12:18:52 INFO - PROCESS | 1665 | 12:18:53 INFO - PROCESS | 1665 | [#8] json-parse-financial Cycles:10 Average:56.70 Median:57.00 stddev:1.64 (2.9%) stddev-sans-first:1.72 12:18:53 INFO - PROCESS | 1665 | Values: 56.0 54.0 58.0 54.0 58.0 57.0 57.0 59.0 57.0 57.0 12:18:53 INFO - PROCESS | 1665 | 12:18:53 INFO - PROCESS | 1665 | [#9] json-stringify-tinderbox Cycles:10 Average:90.70 Median:67.50 stddev:22.40 (33.2%) stddev-sans-first:22.20 12:18:53 INFO - PROCESS | 1665 | Values: 68.0 71.0 99.0 67.0 101.0 118.0 116.0 114.0 60.0 93.0 12:18:53 INFO - PROCESS | 1665 | 12:18:53 INFO - PROCESS | 1665 | [#10] stanford-crypto-aes Cycles:10 Average:87.20 Median:87.00 stddev:5.57 (6.4%) stddev-sans-first:5.70 12:18:53 INFO - PROCESS | 1665 | Values: 83.0 82.0 87.0 88.0 85.0 102.0 87.0 87.0 87.0 84.0 12:18:53 INFO - PROCESS | 1665 | 12:18:53 INFO - PROCESS | 1665 | [#11] stanford-crypto-ccm Cycles:10 Average:149.80 Median:155.50 stddev:13.03 (8.4%) stddev-sans-first:12.12 12:18:53 INFO - PROCESS | 1665 | Values: 132.0 135.0 156.0 138.0 168.0 161.0 155.0 148.0 165.0 140.0 12:18:53 INFO - PROCESS | 1665 | 12:18:53 INFO - PROCESS | 1665 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:181.80 Median:171.50 stddev:25.82 (15.1%) stddev-sans-first:26.97 12:18:53 INFO - PROCESS | 1665 | Values: 169.0 166.0 195.0 164.0 163.0 226.0 229.0 174.0 166.0 166.0 12:18:53 INFO - PROCESS | 1665 | 12:18:53 INFO - PROCESS | 1665 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.60 Median:69.00 stddev:6.48 (9.4%) stddev-sans-first:6.66 12:18:53 INFO - PROCESS | 1665 | Values: 67.0 68.0 67.0 69.0 69.0 68.0 68.0 80.0 86.0 74.0 12:18:53 INFO - PROCESS | 1665 | -------- Summary: end -------- 12:18:53 INFO - PROCESS | 1665 | 12:18:53 INFO - TEST-INFO | 1665: exit 0 12:18:53 INFO - TEST-OK | kraken | took 60974ms 12:18:53 INFO - SUITE-END | took 1174s 12:18:54 INFO - Completed test suite (00:19:35) 12:18:54 INFO - javascript benchmark 12:18:54 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7125.284574224684, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3436.0894362993804, 3442.896713098608, 3462.411390063689, 3467.7399195060375, 3486.6339034401385, 4693.249080147177, 5683.2895888014, 5709.800156994501, 5745.6839873806975, 5820.53435725142, 5782.942170578293, 5797.536197104232, 5809.854753631151, 5847.239858818359, 5910.143029260755, 3825.08198032473, 4094.8943785177985, 5161.200013997836, 5259.921101183466, 5364.249005139264, 5418.647787893774, 5420.5934554908345, 5435.2934118564535, 5463.972680136613, 5486.698231597261, 4478.462584489849, 5195.0, 5248.0, 5313.229581710669, 5417.404085550586, 5297.894042119175, 5343.305370301875, 5344.732763361816, 5361.973190134064, 5385.434529374437, 4425.291953287458, 5294.126469132627, 5300.681959082467, 5301.231321458406, 5381.085215513333, 5600.551955843523, 5770.79802206925, 5819.214406055171, 5873.324567674729, 5940.227770389865, 5871.588988770788, 6298.653574053471, 6300.243970723543, 6307.810765677037, 6318.894193516162, 6153.969230153821, 6232.878081945248, 6271.372862713738, 6278.152449419361, 6292.811215663537, 5933.0, 5984.790532331347, 6000.219971403733, 6031.849203769941, 6082.9695851520455, 5643.971780141155, 6158.891399548124, 6336.366363363719, 6401.807945761635, 6421.935780642134, 6013.819585412444, 6216.191895053614, 6279.403456671609, 6282.780102696383, 6283.465905398001, 6165.0444181152, 6188.938110618927, 6213.2233470816145, 6247.187865577446, 6306.054091886253, 6170.0, 6264.373562643699, 6273.0904018917, 6307.716152773136, 6310.5267104967315, 6247.781327653601, 6263.248410190715, 6281.748730050746, 6286.339934306923, 6293.056041593798, 4395.318725597537, 4942.28336891156, 4984.40187177541, 5002.824901128443, 5002.957829797985, 4473.188358714726, 4511.052678937394, 4526.0721552082405, 4546.272596384562, 4562.84030058953, 5287.471252874759, 5847.181394604759, 5851.531877449794, 5865.35481097079, 5873.383294754075, 6184.257889053252, 6190.0405437157315, 6226.875462490725, 6241.375862413723, 6265.0, 5808.215890854765, 5818.2436283282905, 5821.505172060338, 5851.64890106595, 5861.0915308127305, 5457.945420545823, 5488.902219556025, 5512.889742205133, 5515.172724091338, 5516.613837031369, 6205.5345849060595, 6373.74505019794, 6374.362563743589, 6383.4574061204385, 6397.328280530571, 6267.310595834363, 6301.590396624205, 6309.779157729457, 6316.273628532594, 6320.1467801848, 6470.0, 6473.935260647521, 6496.935030649633, 6503.2196136462035, 6517.674116294072, 6131.509479241739, 6154.446099851035, 6170.938290617037, 6276.937230627818, 6299.212598425197, 5295.814646487354, 6244.781432649836, 6291.433770960452, 6291.937080629135, 6296.496280297657, 6163.318986130902, 6185.474234689922, 6205.968970155121, 6237.0, 6240.500759939103, 6075.362086980804, 6144.832481828438, 6145.784897528565, 6199.576643501942, 6250.3749625037135, 5942.762289508544, 6121.204243448501, 6121.574916084701, 6159.0, 6161.383861613803, 5891.764329426775, 6223.301407437356, 6239.37993739749, 6251.499880009497, 6259.123722678738, 5893.145493903446, 6065.332813390435, 6114.174586430953, 6126.989046807227, 6162.876742465036], "value": 5742.064815266068, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [475.3748820301304, 496.32995456134245, 505.5399586376397, 536.5198147657844, 537.175435706191, 38644.0, 41986.58013419865, 42145.15330736966, 42216.0, 42223.155536889244, 42300.57699423005, 42717.35923961143, 42763.358549621706, 42833.35749963745, 42927.0, 9636.325457218016, 9827.754306142368, 9839.655612053579, 9856.901430985707, 9881.505924703735, 9636.566354514029, 9758.658446954358, 9785.657501987433, 9788.168005719523, 9789.510524473748, 9768.316217864753, 9789.412635241873, 9791.510424478784, 9801.970793066732, 9835.90164098357, 9781.41311521311, 9781.755456113582, 9782.119609235131, 9783.119519243266, 9798.804023919552, 9724.465154416504, 9806.068423499755, 9817.263705222136, 9824.0, 9828.066333698287, 40663.0, 40737.0, 40847.774566763044, 41008.0, 41069.589304107176, 2802.8028028028084, 3282.2122690554334, 3487.8256087195537, 3563.0, 3570.339487194877, 30803.767849286003, 31528.36943261145, 31634.525482117788, 31780.364392712247, 31869.521957170662, 3131.7181453669277, 3134.7492200623897, 3134.9686503134903, 3169.0, 3265.216348076445, 428895.0, 433501.0, 433979.6602033971, 435609.0, 436250.0, 34066.97799066032, 34482.0, 34660.133496662784, 34796.956091316795, 34978.475322870174, 30623.540646890313, 35785.0, 35835.64164358323, 36043.279134417164, 36195.457068144, 14878.181700006604, 14891.925540372229, 14999.32503037344, 15012.0, 15041.473548425753, 12263.693407664701, 12470.376481175905, 12483.687907802196, 12578.119531632881, 12609.991200703922, 7719.92280077192, 7846.136924938252, 7858.489198202098, 7886.684532618631, 7911.643976021093, 3265.8856940007463, 3294.4399452093203, 3302.884399046022, 3307.074019274607, 3326.7338612910908, 895.4582477601087, 910.2581396162107, 1065.0, 1068.7435015596202, 1077.3589714120087, 28537.57193642097, 30839.383212336077, 30911.0, 31343.68656313453, 31863.044108676775, 1010.0909181736496, 1015.57345914716, 1035.8498017787379, 1065.1638463805875, 1083.7940791249637, 15786.21068946548, 15822.52532424029, 16253.024818510927, 16295.59261018484, 16616.58458538522, 157621.0, 188826.0, 190854.0, 191453.0, 191686.0, 61832.38167618266, 61928.0, 62262.37737622656, 62643.373566263755, 62912.0, 1227.533537255837, 1341.698117923479, 1371.8559551247174, 1417.0364152376483, 1420.155007770375, 26859.32851678724, 29647.25881852971, 29870.25324366908, 30439.54340684936, 30531.542026870058, 48963.75518122387, 54083.45916540784, 54139.72930135324, 54184.18723719069, 54291.91416171575, 591175.0, 592217.0, 592219.0, 593660.0, 593875.0, 27574.0, 27591.586126208524, 27665.861670692324, 27832.0, 27833.16500504988, 48825.5117448821, 49672.50327496679, 49725.0, 50195.498045019085, 50587.49412505975, 40152.1969560613, 40652.59347406607, 40708.38937415882, 40768.388474172316, 41811.581884181986, 40622.79688601538, 40853.77438676845, 41608.791956040026, 42306.0, 42387.788061059495, 37433.25133497261, 39127.63053293121, 39300.0, 39975.40098396032, 40123.598764011986, 34556.481652774724, 35035.124121897155, 35898.28203435969, 36024.63975360318, 36086.0, 25899.87050064813, 26391.4721705561, 26473.205803825917, 26860.194194174204, 27173.0], "value": 18081.483922567648, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [364.41875209041586, 377.15705398434494, 380.47114510829954, 390.29162070841437, 405.50528355406414, 19016.0, 21124.57750844982, 21295.25466608669, 21402.57194856104, 21832.454188645293, 16951.91524042378, 20335.28826491073, 21396.823174725385, 21439.678404823902, 21696.566068678658, 5581.274434323533, 5646.54827613792, 5840.386759390267, 6033.215681961339, 6052.636841789485, 4121.711480196387, 5967.731452084645, 6025.668588227646, 6033.7888173913925, 6298.842528936768, 6494.805155845309, 6638.93361066388, 6648.069270302161, 6656.134702488694, 6659.101021362103, 6485.735281620086, 6543.869122617521, 6568.376004279586, 6612.041254018189, 6615.272320044791, 5580.804671836507, 5653.717314134318, 5679.574031947621, 5722.799702010451, 5751.367349591542, 22070.88964555183, 22117.0, 25332.73336333176, 25741.613875791878, 25875.353116172057, 2240.8207343412487, 2287.74174204187, 2330.6270996640624, 2408.5303365843665, 3047.4514587374265, 11409.20135590509, 13231.66920826987, 13633.727325453436, 15896.84103158965, 16513.853199084042, 1642.82750311218, 1886.3303527247904, 1888.1975160556708, 1891.498752830501, 1909.6849019911697, 93503.0, 115030.1242468945, 125749.0, 127491.36254318761, 129150.0, 9049.276057915351, 10785.56857725698, 10811.081058110149, 11245.212835101463, 11374.31754094757, 12032.81950770739, 13867.23730194849, 13922.860771392156, 13924.443022278996, 13963.860361396257, 8468.0, 8718.651253949898, 8762.956185219033, 8860.601272942733, 8873.112688731075, 8027.956365672425, 8117.878231826528, 8791.428557143765, 8804.075572064841, 8940.68707595231, 6601.570897891717, 6853.828654283683, 6877.931220687729, 6918.584884906922, 6943.479239057091, 1600.8959417637816, 1686.2833295849216, 1850.9722354164699, 1890.773107227114, 1893.7727472703089, 295.3222354695978, 378.36434789553266, 402.0992975734334, 696.9024336592881, 944.4805357053593, 9838.409695418297, 11823.645290641294, 11951.22317049389, 12173.391330433444, 12357.011439084852, 407.52523310343116, 426.60112794537207, 428.36815696847526, 436.7117702316456, 468.3630262842531, 5303.761330740049, 5851.795187168514, 6183.938160618426, 6282.120503129566, 6324.557280990379, 602064.0, 626201.0, 626738.0, 629561.0, 651470.0, 137635.0, 138183.30908345393, 140510.0, 142393.0, 143699.0, 386.7238114223053, 434.35932000299306, 446.94189755332246, 449.55494060879494, 449.5571861716207, 11037.83443248368, 11240.662780116609, 11267.323960562393, 11502.884971150515, 11553.0, 52615.73692131668, 53529.0, 53805.73097134489, 54092.72953635207, 55177.448225518834, 77686.0, 79247.0, 82080.358392833, 82136.0, 88321.55839220763, 7920.920790792018, 8155.7766335047845, 8160.387970902088, 8501.404901656824, 8532.061473238064, 8444.282236010007, 8946.821063578822, 9017.143371379709, 9303.534823258946, 9484.715458536255, 6653.467722582279, 6742.696578653874, 7752.224777522429, 7992.5204487730925, 8230.83538329242, 5849.005669036189, 7952.0, 8160.551169685724, 8364.498130112213, 8453.91546084556, 8091.433599647969, 8208.302294304813, 8340.332773377993, 8501.617427215666, 8592.78518037029, 12435.564755233523, 12965.546205883125, 13053.934730326288, 13284.468621255042, 13374.732505349644, 11810.17328787011, 11875.346855922662, 11928.76142477163, 12176.75646487083, 12268.0], "value": 8665.398074377932, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1536.4852774320605, 1565.6868626274745, 1793.8744287899851, 1842.5946291815796, 1891.659501289768, 7062.5056246062795, 7607.54354738716, 7847.489913155641, 8376.581170941452, 8940.418872773265, 8596.183362580545, 8806.77983050424, 8822.558872056388, 8823.647054117844, 8849.646014159442, 2333.883305834706, 2374.4182675244588, 2374.5013547155118, 2381.9642705359433, 2390.760923907613, 2341.110378056345, 2357.3635118518077, 2381.6427535869584, 2383.261189031397, 2383.9642405363848, 2101.770464278399, 2279.7378301495373, 2279.9886000569973, 2342.016353131689, 2382.094803974487, 2045.8158765711082, 2332.953340933172, 2364.621660534306, 2364.7280562735245, 2369.490559529701, 2341.438054866837, 2348.8825558722165, 2349.201271567675, 2352.0, 2353.7881590656925, 8739.694110706096, 8899.110088991114, 8941.59762810675, 8963.55182240892, 8997.910020899773, 4545.181867263891, 5166.199239117943, 5337.946620533784, 5338.145896656516, 5364.678119312854, 2977.910662680123, 3000.1899487138567, 3283.819389933553, 3368.3936891359544, 3499.5100685903994, 1084.821004534251, 1089.7330154112294, 1090.1878100814865, 1111.9166062545341, 1116.4696769034724, 11453.255538389978, 11453.828192577119, 11563.826542601868, 11591.594294199662, 11600.535978560847, 3878.45701601776, 4502.0, 4574.931376029363, 4699.577038066591, 4806.182948898696, 9804.852927206097, 9895.554700038516, 9905.851412228822, 9906.712127423389, 9937.950310248403, 5315.282436870973, 5324.5207931285595, 5331.093714068617, 5332.226827110125, 5385.111456609616, 4372.3878656988045, 4699.224627936353, 4818.0, 4854.0, 4879.756012199376, 3362.815045172539, 3885.8834234972996, 3902.102516421239, 4043.0903046814233, 4079.4084857695466, 1288.8195652608642, 1298.1497119386818, 1299.8635143310005, 1307.6796184934751, 1307.82344383507, 636.4558302651259, 932.9020452852353, 964.8842138943231, 976.5703090640095, 977.7018009507026, 5905.616134951214, 5925.822225333247, 6034.48706859913, 6216.689165541705, 6236.812895613139, 436.85583757359996, 438.6863392674253, 441.3071477779855, 447.0968643340434, 459.5037359651568, 4037.4953130858644, 4058.898527536835, 4147.751134931854, 4167.562405947392, 4191.832326706958, 10485.213608979204, 10669.253152279265, 10763.677089687322, 10797.46012699362, 10892.836607450894, 10300.845487317696, 10715.83926241107, 10717.678469645924, 10738.624148154777, 10747.086497647631, 6316.0, 8178.0, 8201.95899020513, 8208.548529830798, 8223.794405139799, 5792.7103644818435, 5919.141724450017, 5923.763049478145, 6008.489278411384, 6026.427489388501, 9948.552315145691, 9979.501024948579, 9992.200623950212, 10005.149562287286, 10022.298439109192, 9671.806563868542, 10104.0, 10109.494525273854, 10146.79706405853, 10357.0, 6752.3922846944015, 7599.506032107895, 8154.8175514548875, 8296.170382961656, 8380.24577788002, 8573.785655358666, 8580.570971451527, 8618.0, 8641.783955401166, 8655.91344086551, 7493.662785174572, 7537.924620753942, 7582.54504729718, 7627.961860190663, 7647.694092236248, 7035.0, 7380.1512826023545, 7435.33082022599, 7442.181360050498, 7495.17553069151, 6985.231624521401, 7160.856782864209, 7161.820954476179, 7178.533395329287, 7196.96401517989, 4999.375078115236, 5143.022825663112, 5151.571044721084, 5180.637355385087, 5201.037808005531, 5048.495150484922, 5063.493650634907, 5135.897282054413, 5213.608979326642, 5274.287971123849], "value": 4501.859548662266, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [303.87085488667327, 309.91787176398253, 317.71247021445595, 318.6415282806842, 320.67451536690265, 5367.543758780508, 5457.454254574541, 5498.862528436791, 5662.405447428023, 5692.772289108436, 4408.603225709686, 4668.766561671911, 5495.670259784406, 5699.173619825133, 5723.856903577413, 3412.931741365171, 4176.2900306947895, 4303.13937212558, 4353.67347448941, 4354.695171338008, 3551.769135006229, 4212.726172798773, 4266.424032755584, 4350.3474478828275, 4376.737395756249, 3564.8930532084078, 3717.925641487169, 4258.91482170358, 4317.460317460317, 4346.978265108686, 3735.711179643019, 4274.465691788527, 4283.935740963888, 4302.784860756965, 4331.848385306499, 3242.540856614533, 3637.236180402119, 3750.924981500382, 3754.4180651998986, 3759.4360845873066, 5131.153359695646, 5277.736113194325, 5498.45015498451, 5504.779808807642, 5575.414581468968, 4806.702190408605, 4851.733154676492, 4854.563089321978, 4948.540180646718, 4993.952479483431, 4821.421429428456, 5743.45437183471, 6022.879542409171, 6053.485453736438, 6056.121862329982, 3266.950995735066, 3859.710521710883, 4083.5099788025627, 4087.693422993287, 4100.159467309194, 5281.894362112736, 5524.364698059734, 5757.366689664133, 6406.814739273249, 6435.485161187094, 3694.2980833641523, 3837.0, 4175.995522149325, 4184.0, 4210.326442708902, 3862.8261728221737, 4134.193832202692, 4134.4831896013, 4146.91706165881, 4152.460180176618, 4089.468369112056, 4499.392582001388, 4663.230566956482, 4765.0, 4896.4858689837765, 4745.00709701926, 5955.13650520672, 5970.73092738694, 6033.276006879115, 6092.573519853568, 1202.7955247607927, 1265.0322503284995, 1364.6110858405307, 1399.6982805990324, 1413.9151650900978, 831.4055450353027, 833.9416240863081, 839.5368474178161, 868.2186032570737, 872.2193636695249, 3801.581825999138, 4130.8691308691305, 4148.62662360389, 4263.997960479285, 4528.011512401865, 4224.894377640584, 4371.890702732394, 5003.870258932779, 5236.00515901985, 5287.365516138088, 4187.361961964004, 4628.958484340997, 4641.303804429295, 4655.371524844103, 4720.504347043511, 2198.5383069555573, 2408.674828898111, 2596.039465397815, 2627.908023219178, 2769.0754925327105, 4848.9757551212015, 5098.770555324945, 5126.949465068278, 5352.343461188713, 5362.839114826562, 4633.594308183482, 4635.397398338262, 4776.379070720784, 4852.568492294781, 5128.794848206105, 4507.81968721254, 4973.234501751826, 5087.949120508822, 5294.444083371268, 5330.387005494418, 4445.533219011957, 5070.935103628131, 5181.222816577393, 5292.576593872558, 5308.309919710413, 4280.78596070189, 4758.500357462417, 4796.232602783538, 4943.887625284282, 5221.624161006809, 4333.8515293446635, 5379.33722807213, 5409.754951695002, 5430.185472179205, 5473.589480789036, 3404.438267685804, 3614.7108231340903, 3815.275097731422, 3833.7955675487265, 3908.397557001729, 6103.298120716175, 6133.294671112701, 6155.569110162246, 6161.599496032743, 6208.696173803552, 4958.528939750718, 5507.366652834815, 6016.699165041643, 6039.516838652809, 6068.21113255274, 4380.956190438055, 5213.322268105122, 5479.315085614298, 5529.079119583494, 5972.0, 5401.945980540301, 5814.94185058144, 5818.563607729353, 5821.650700957956, 5878.882422351615, 4941.382327209099, 5233.790648374023, 5717.742701578522, 5932.822015339547, 5940.79207227745, 5402.621816472809, 5614.877024595179, 5833.300003999378, 5847.26909136358, 5852.561057920758], "value": 4051.2360616178203, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [693.5630552751766, 744.4081954845897, 771.1825465007089, 774.2219069834813, 800.3637108498743, 15150.621234469143, 15871.206439677999, 15883.841161588382, 15930.0, 15931.522054338375, 14208.573742787707, 14355.71288574228, 14357.282135893216, 14361.066530675525, 14375.712485750279, 677.5832862789374, 821.5276216175693, 831.9251267385933, 858.6393714639867, 860.6772460327377, 845.8942632170979, 849.133883438892, 853.4196746212573, 853.6585365853646, 855.6534603485599, 884.7168905950099, 910.3400034974624, 915.281504019345, 917.0416914324547, 917.5824999625188, 799.6041959230189, 876.750126214026, 905.7373361725092, 906.6690657909882, 907.0249481807051, 643.6781609195402, 658.9736410543572, 661.2395744893411, 679.2833560593572, 681.0669382945397, 14530.273486325641, 14766.926165369105, 14829.703405931929, 14884.255787210705, 14900.031497952707, 14459.0, 14528.636784080376, 14536.200508972002, 14559.417623295056, 14567.854321456756, 11943.761124777542, 12212.0, 12455.190412623151, 12462.75074498514, 12560.120791544596, 3815.4276858471176, 3827.4832897558754, 4029.073313137965, 4058.0260737422805, 4058.8376464941366, 118976.0, 121721.39139304335, 121815.0, 122326.0, 123065.0, 11077.224594278323, 11200.327980321206, 11206.0, 11277.830832537518, 11801.40992950349, 22953.311400658007, 23037.308880733606, 23042.539149216922, 23044.65433018506, 23146.0, 7921.683132674743, 8124.634391452399, 8139.918600814034, 8220.8355832883, 8411.411201215979, 3898.6686131679126, 4533.410656614619, 4533.637309015271, 4568.383268258809, 4589.885252868705, 3575.8390872410805, 3594.8741794037082, 3652.8356223969454, 3671.173985853162, 3796.9430458543143, 711.779348401997, 719.3993015831735, 724.4928550014905, 728.9903483675148, 740.489062546841, 510.68082448469704, 657.5298661457081, 688.7761477519826, 697.9965100174467, 701.3792793377897, 9192.356535042483, 9304.813903721888, 9493.430394176372, 9493.810123797486, 9683.467409292556, 601.9277686677626, 625.1747693045137, 651.9543631945813, 659.4691273524762, 684.165318311659, 3903.701372340368, 4294.957050429518, 4426.734395936254, 4624.398828152386, 4786.6888652238185, 99653.0, 138382.0, 156935.0, 159137.20431398, 162774.0, 141902.2904885469, 142665.0, 143462.0, 143694.9999999979, 145333.0, 100320.0, 107046.0, 119781.0, 125679.3716031414, 126233.36883315709, 7964.7654613535, 8231.629576668944, 8979.10208979097, 8982.640694372152, 9089.545522723969, 55992.0, 66469.0, 66861.33138668552, 67204.6639766798, 69237.0, 80913.0, 83395.0, 84901.0, 101807.0, 108282.91717082728, 13508.32458377097, 13523.256220907944, 13643.113197642122, 13678.384472698554, 13927.721445570829, 15015.0, 15211.0, 15584.0, 15605.687886241985, 15624.0, 13952.372143253375, 13961.232132232824, 14478.058926169766, 14540.41838326455, 14554.053986490844, 13328.733425331633, 13966.58100256994, 13993.720125597227, 14272.500462484179, 14306.752999086104, 10545.156387489136, 11557.422128893353, 12531.0, 13599.388027538982, 13617.455301787817, 9578.425294482353, 11442.828357574477, 11603.767924641292, 11681.824772628248, 11986.580469683518, 10803.621873234713, 11242.437878105899, 11485.970841551272, 11743.060555155396, 11778.587749428729], "value": 7974.453540409096, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1623.1, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 117.0, 107.0, 119.0, 117.0, 126.0, 164.0, 169.0, 126.0, 116.0], "value": 127.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 134.0, 120.0, 192.0, 147.0, 165.0, 166.0, 97.0, 159.0, 141.0], "value": 146.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [206.0, 236.0, 196.0, 199.0, 194.0, 202.0, 192.0, 197.0, 194.0, 194.0], "value": 201.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 77.0, 95.0, 167.0, 76.0, 82.0, 82.0, 90.0, 160.0, 58.0], "value": 96.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 75.0, 122.0, 71.0, 73.0, 83.0, 146.0, 105.0, 75.0, 110.0], "value": 92.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 134.0, 137.0, 90.0, 95.0, 120.0, 90.0, 93.0, 136.0, 116.0], "value": 108.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 95.0, 96.0, 97.0, 95.0, 111.0, 153.0, 114.0, 96.0], "value": 104.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 146.0, 93.0, 94.0, 92.0, 91.0, 95.0, 90.0, 93.0, 139.0], "value": 108.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 54.0, 58.0, 54.0, 58.0, 57.0, 57.0, 59.0, 57.0, 57.0], "value": 56.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 71.0, 99.0, 67.0, 101.0, 118.0, 116.0, 114.0, 60.0, 93.0], "value": 90.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 87.0, 88.0, 85.0, 102.0, 87.0, 87.0, 87.0, 84.0], "value": 87.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 135.0, 156.0, 138.0, 168.0, 161.0, 155.0, 148.0, 165.0, 140.0], "value": 149.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 166.0, 195.0, 164.0, 163.0, 226.0, 229.0, 174.0, 166.0, 166.0], "value": 181.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 67.0, 69.0, 69.0, 68.0, 68.0, 80.0, 86.0, 74.0], "value": 71.6, "unit": "score"}]}]} 12:18:54 INFO - Return code: 0 12:18:54 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 12:18:54 ERROR - # TBPL SUCCESS # 12:18:54 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 12:18:54 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 12:18:54 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 12:18:54 INFO - 2016-08-11 12:18:54.285 screenresolution[1670:10250] starting screenresolution argv=screenresolution get 12:18:54 INFO - 2016-08-11 12:18:54.288 screenresolution[1670:10250] Display 0: 1600x1200x32@60 12:18:54 INFO - 2016-08-11 12:18:54.293 screenresolution[1671:10253] starting screenresolution argv=screenresolution list 12:18:54 INFO - Available Modes on Display 0 12:18:54 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 12:18:54 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 12:18:54 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 12:18:54 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 12:18:54 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 12:18:54 INFO - Intel Iris: 12:18:54 INFO - Chipset Model: Intel Iris 12:18:54 INFO - Type: GPU 12:18:54 INFO - Bus: Built-In 12:18:54 INFO - VRAM (Dynamic, Max): 1536 MB 12:18:54 INFO - Vendor: Intel (0x8086) 12:18:54 INFO - Device ID: 0x0a2e 12:18:54 INFO - Revision ID: 0x0009 12:18:54 INFO - Displays: 12:18:54 INFO - Display: 12:18:54 INFO - Resolution: 1600 x 1200 @ 60 Hz 12:18:54 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 12:18:54 INFO - Display Serial Number: 1600x1200 60 12:18:54 INFO - Main Display: Yes 12:18:54 INFO - Mirror: Off 12:18:54 INFO - Online: Yes 12:18:54 INFO - Rotation: Supported 12:18:54 INFO - Return code: 0 12:18:54 INFO - Running post-action listener: _resource_record_post_action 12:18:54 INFO - [mozharness: 2016-08-11 19:18:54.528079Z] Finished run-tests step (success) 12:18:54 INFO - Running post-run listener: _resource_record_post_run 12:18:54 INFO - Total resource usage - Wall time: 1210s; CPU: 55.0%; Read bytes: 37176320; Write bytes: 703326208; Read time: 246; Write time: 1939 12:18:54 INFO - TinderboxPrint: CPU usage
54.6% 12:18:54 INFO - TinderboxPrint: I/O read bytes / time
37,176,320 / 246 12:18:54 INFO - TinderboxPrint: I/O write bytes / time
703,326,208 / 1,939 12:18:54 INFO - TinderboxPrint: CPU idle
2,199.9 (45.4%) 12:18:54 INFO - TinderboxPrint: CPU system
984.0 (20.3%) 12:18:54 INFO - TinderboxPrint: CPU user
1,657.8 (34.2%) 12:18:54 INFO - TinderboxPrint: Swap in / out
440,991,744 / 0 12:18:54 INFO - install - Wall time: 35s; CPU: 54.0%; Read bytes: 382824960; Write bytes: 376776704; Read time: 29720; Write time: 749 12:18:54 INFO - run-tests - Wall time: 1176s; CPU: 55.0%; Read bytes: 36230144; Write bytes: 297000960; Read time: 235; Write time: 1124 12:18:55 INFO - Running post-run listener: _upload_blobber_files 12:18:55 INFO - Blob upload gear active. 12:18:55 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:18: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 12:18: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'] 12:18: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 12:18:55 INFO - (blobuploader) - INFO - Open directory for files ... 12:18:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 12:18:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:18:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:18:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 12:18:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:18:56 INFO - (blobuploader) - INFO - Done attempting. 12:18:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 12:18:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:18:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:18:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 12:18:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:18:57 INFO - (blobuploader) - INFO - Done attempting. 12:18:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 12:18:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:18:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:18:59 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 12:18:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:18:59 INFO - (blobuploader) - INFO - Done attempting. 12:18:59 INFO - (blobuploader) - INFO - Iteration through files over. 12:18:59 INFO - Return code: 0 12:18:59 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:18:59 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:18:59 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/157f6d02d9d3f2bbc256ac11e135884c7d0105b14b179b3a9327388583307d35d6654116da93433fdfb6a6d20ac726bc4ec0fec3aa592aaee17f7bec06e1eef2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0a803e3a5a0c1e123de2a2b69cc02677511979fe7432508dd6c0f6d720f17d598ac486dd2f0db00d5b5c759936fff8629f9025da841308f624cab91a5b857f26", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bd3bfea60b3a36714155a5351a3dec6a814e982a439822613f018ef25e03f5d44d5cf5a72f41f53182cc5a2bc2be25fa576b4a11e8162231a4535863b3907a8e"} 12:18:59 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:18:59 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:18:59 INFO - Contents: 12:18:59 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/157f6d02d9d3f2bbc256ac11e135884c7d0105b14b179b3a9327388583307d35d6654116da93433fdfb6a6d20ac726bc4ec0fec3aa592aaee17f7bec06e1eef2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0a803e3a5a0c1e123de2a2b69cc02677511979fe7432508dd6c0f6d720f17d598ac486dd2f0db00d5b5c759936fff8629f9025da841308f624cab91a5b857f26", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bd3bfea60b3a36714155a5351a3dec6a814e982a439822613f018ef25e03f5d44d5cf5a72f41f53182cc5a2bc2be25fa576b4a11e8162231a4535863b3907a8e"} 12:18:59 INFO - Running post-run listener: copy_logs_to_upload_dir 12:18:59 INFO - Copying logs to upload dir... 12:18:59 INFO - mkdir: /builds/slave/test/build/upload/logs 12:18:59 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1263.548297 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2016-08-11 12:18:59.874289) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-11 12:18:59.878056) ========= 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.FVpAHFgsxI/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.xRhzLN6nhp/Listeners TMPDIR=/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/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/157f6d02d9d3f2bbc256ac11e135884c7d0105b14b179b3a9327388583307d35d6654116da93433fdfb6a6d20ac726bc4ec0fec3aa592aaee17f7bec06e1eef2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0a803e3a5a0c1e123de2a2b69cc02677511979fe7432508dd6c0f6d720f17d598ac486dd2f0db00d5b5c759936fff8629f9025da841308f624cab91a5b857f26", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bd3bfea60b3a36714155a5351a3dec6a814e982a439822613f018ef25e03f5d44d5cf5a72f41f53182cc5a2bc2be25fa576b4a11e8162231a4535863b3907a8e"} build_url:https://queue.taskcluster.net/v1/task/L_NRwNL6S5KrmlNkvftLTw/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010856 build_url: 'https://queue.taskcluster.net/v1/task/L_NRwNL6S5KrmlNkvftLTw/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/157f6d02d9d3f2bbc256ac11e135884c7d0105b14b179b3a9327388583307d35d6654116da93433fdfb6a6d20ac726bc4ec0fec3aa592aaee17f7bec06e1eef2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0a803e3a5a0c1e123de2a2b69cc02677511979fe7432508dd6c0f6d720f17d598ac486dd2f0db00d5b5c759936fff8629f9025da841308f624cab91a5b857f26", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bd3bfea60b3a36714155a5351a3dec6a814e982a439822613f018ef25e03f5d44d5cf5a72f41f53182cc5a2bc2be25fa576b4a11e8162231a4535863b3907a8e"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-11 12:18:59.909882) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-11 12:18:59.910179) ========= 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.FVpAHFgsxI/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.xRhzLN6nhp/Listeners TMPDIR=/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/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.005243 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-11 12:18:59.958220) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-11 12:18:59.958517) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-11 12:18:59.958829) ========= ========= Total master_lag: 0.16 =========