builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0350 starttime: 1470786865.43 results: success (0) buildid: 20160809142816 builduid: a8e1c4e9156e42d2bf0bd05b34aa0300 revision: 0b1fc540eace69753abe0f344e061dba3e9df6fc ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-09 16:54:25.426818) ========= master: http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-09 16:54:25.427229) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-09 16:54:25.427497) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-09 16:54:25.450909) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-09 16:54:25.451171) ========= 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.f0HgucWfr7/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.H9ogqVjJnt/Listeners TMPDIR=/var/folders/tm/bb1xmxh10h32jsf94bs0tnvh00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-08-09 16:54:25-- 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% 44.2M=0s 2016-08-09 16:54:25 (44.2 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.342320 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-09 16:54:25.815131) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-09 16:54:25.815457) ========= 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.f0HgucWfr7/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.H9ogqVjJnt/Listeners TMPDIR=/var/folders/tm/bb1xmxh10h32jsf94bs0tnvh00000w/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.021430 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-09 16:54:25.864364) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-09 16:54:25.864784) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 0b1fc540eace69753abe0f344e061dba3e9df6fc --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 0b1fc540eace69753abe0f344e061dba3e9df6fc --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.f0HgucWfr7/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.H9ogqVjJnt/Listeners TMPDIR=/var/folders/tm/bb1xmxh10h32jsf94bs0tnvh00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-08-09 16:54:25,947 truncating revision to first 12 chars 2016-08-09 16:54:25,947 Setting DEBUG logging. 2016-08-09 16:54:25,947 attempt 1/10 2016-08-09 16:54:25,947 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/0b1fc540eace?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-09 16:54:27,079 unpacking tar archive at: fx-team-0b1fc540eace/testing/mozharness/ program finished with exit code 0 elapsedTime=1.409586 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-09 16:54:27.295772) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-09 16:54:27.296089) ========= script_repo_revision: 0b1fc540eace69753abe0f344e061dba3e9df6fc ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-09 16:54:27.296532) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-09 16:54:27.296812) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-09 16:54:27.315109) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2016-08-09 16:54:27.315377) ========= /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.f0HgucWfr7/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.H9ogqVjJnt/Listeners TMPDIR=/var/folders/tm/bb1xmxh10h32jsf94bs0tnvh00000w/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 16:54:27 INFO - MultiFileLogger online at 20160809 16:54:27 in /builds/slave/test 16:54:27 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 16:54:27 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:54:27 INFO - {'append_to_log': False, 16:54:27 INFO - 'base_work_dir': '/builds/slave/test', 16:54:27 INFO - 'blob_upload_branch': 'Fx-Team', 16:54:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:54:27 INFO - 'branch': 'Fx-Team', 16:54:27 INFO - 'buildbot_json_path': 'buildprops.json', 16:54:27 INFO - 'config_files': ('talos/mac_config.py',), 16:54:27 INFO - 'default_actions': ('clobber', 16:54:27 INFO - 'read-buildbot-config', 16:54:27 INFO - 'download-and-extract', 16:54:27 INFO - 'populate-webroot', 16:54:27 INFO - 'create-virtualenv', 16:54:27 INFO - 'install', 16:54:27 INFO - 'run-tests'), 16:54:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:54:27 INFO - 'download_minidump_stackwalk': True, 16:54:27 INFO - 'download_symbols': 'ondemand', 16:54:27 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:54:27 INFO - 'tooltool.py': '/tools/tooltool.py', 16:54:27 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:54:27 INFO - '/tools/misc-python/virtualenv.py')}, 16:54:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:54:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:54:27 INFO - 'installer_path': 'installer.exe', 16:54:27 INFO - 'log_level': 'info', 16:54:27 INFO - 'log_name': 'talos', 16:54:27 INFO - 'log_to_console': True, 16:54:27 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 16:54:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 16:54:27 INFO - 'opt_config_files': (), 16:54:27 INFO - 'pip_index': False, 16:54:27 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 16:54:27 INFO - 'cmd': ('bash', 16:54:27 INFO - '-c', 16:54:27 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 16:54:27 INFO - 'enabled': True, 16:54:27 INFO - 'halt_on_failure': False, 16:54:27 INFO - 'name': 'check_screen_resolution'},), 16:54:27 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 16:54:27 INFO - 'cmd': ('bash', 16:54:27 INFO - '-c', 16:54:27 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 16:54:27 INFO - 'enabled': True, 16:54:27 INFO - 'halt_on_failure': False, 16:54:27 INFO - 'name': 'check_screen_resolution'},), 16:54:27 INFO - 'run_cmd_checks_enabled': True, 16:54:27 INFO - 'sps_profile': False, 16:54:27 INFO - 'sps_profile_interval': 0, 16:54:27 INFO - 'suite': 'dromaeojs-e10s', 16:54:27 INFO - 'system_bits': '32', 16:54:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:54:27 INFO - 'title': 't-yosemite-r7-0350', 16:54:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:54:27 INFO - 'use_talos_json': True, 16:54:27 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:54:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:54:27 INFO - 'work_dir': 'build'} 16:54:27 INFO - [mozharness: 2016-08-09 23:54:27.503720Z] Running clobber step. 16:54:27 INFO - Running pre-action listener: _resource_record_pre_action 16:54:27 INFO - Running main action method: clobber 16:54:27 INFO - rmtree: /builds/slave/test/build 16:54:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:54:27 INFO - Running post-action listener: _resource_record_post_action 16:54:27 INFO - [mozharness: 2016-08-09 23:54:27.975163Z] Finished clobber step (success) 16:54:27 INFO - [mozharness: 2016-08-09 23:54:27.975294Z] Running read-buildbot-config step. 16:54:27 INFO - Running pre-action listener: _resource_record_pre_action 16:54:27 INFO - Running main action method: read_buildbot_config 16:54:27 INFO - Using buildbot properties: 16:54:27 INFO - { 16:54:27 INFO - "project": "", 16:54:27 INFO - "product": "firefox", 16:54:27 INFO - "script_repo_revision": "production", 16:54:27 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 16:54:27 INFO - "repository": "", 16:54:27 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 16:54:27 INFO - "buildid": "20160809142816", 16:54:27 INFO - "pgo_build": "False", 16:54:27 INFO - "basedir": "/builds/slave/test", 16:54:27 INFO - "buildnumber": 86, 16:54:27 INFO - "slavename": "t-yosemite-r7-0350", 16:54:27 INFO - "master": "http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/", 16:54:27 INFO - "platform": "yosemite_r7", 16:54:27 INFO - "scheduler": "tests-fx-team-macosx64-talos-7-3600", 16:54:27 INFO - "branch": "fx-team", 16:54:27 INFO - "repo_path": "integration/fx-team", 16:54:27 INFO - "revision": "0b1fc540eace69753abe0f344e061dba3e9df6fc", 16:54:27 INFO - "stage_platform": "macosx64", 16:54:27 INFO - "builduid": "a8e1c4e9156e42d2bf0bd05b34aa0300", 16:54:27 INFO - "slavebuilddir": "test" 16:54:27 INFO - } 16:54:27 INFO - Found installer url https://queue.taskcluster.net/v1/task/OgXNqcGaSB-gL9abrbxfbA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg. 16:54:27 INFO - Running post-action listener: _resource_record_post_action 16:54:27 INFO - [mozharness: 2016-08-09 23:54:27.978623Z] Finished read-buildbot-config step (success) 16:54:27 INFO - [mozharness: 2016-08-09 23:54:27.978705Z] Running download-and-extract step. 16:54:27 INFO - Running pre-action listener: _resource_record_pre_action 16:54:27 INFO - Running main action method: download_and_extract 16:54:27 INFO - mkdir: /builds/slave/test/build/tests 16:54: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')]} 16:54:27 INFO - trying https://queue.taskcluster.net/v1/task/OgXNqcGaSB-gL9abrbxfbA/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json 16:54:27 INFO - Downloading https://queue.taskcluster.net/v1/task/OgXNqcGaSB-gL9abrbxfbA/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 16:54:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OgXNqcGaSB-gL9abrbxfbA/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 16:54:29 INFO - Downloaded 1199 bytes. 16:54:29 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 16:54:29 INFO - Using the following test package requirements: 16:54:29 INFO - {u'common': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 16:54:29 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 16:54:29 INFO - u'firefox-51.0a1.en-US.mac.cppunittest.tests.zip'], 16:54:29 INFO - u'gtest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 16:54:29 INFO - u'firefox-51.0a1.en-US.mac.gtest.tests.zip'], 16:54:29 INFO - u'jittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 16:54:29 INFO - u'jsshell-mac.zip'], 16:54:29 INFO - u'mochitest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 16:54:29 INFO - u'firefox-51.0a1.en-US.mac.mochitest.tests.zip'], 16:54:29 INFO - u'mozbase': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 16:54:29 INFO - u'reftest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 16:54:29 INFO - u'firefox-51.0a1.en-US.mac.reftest.tests.zip'], 16:54:29 INFO - u'talos': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 16:54:29 INFO - u'firefox-51.0a1.en-US.mac.talos.tests.zip'], 16:54:29 INFO - u'web-platform': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 16:54:29 INFO - u'firefox-51.0a1.en-US.mac.web-platform.tests.zip'], 16:54:29 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 16:54:29 INFO - u'firefox-51.0a1.en-US.mac.xpcshell.tests.zip']} 16:54:29 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip'] for test suite category: common 16:54:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:54:29 INFO - trying https://queue.taskcluster.net/v1/task/OgXNqcGaSB-gL9abrbxfbA/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 16:54:29 INFO - Downloading https://queue.taskcluster.net/v1/task/OgXNqcGaSB-gL9abrbxfbA/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 16:54:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OgXNqcGaSB-gL9abrbxfbA/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 16:54:30 INFO - Downloaded 16325977 bytes. 16:54:30 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'] 16:54:30 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 16:54:33 INFO - Return code: 0 16:54:33 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 16:54: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')]} 16:54:33 INFO - trying https://queue.taskcluster.net/v1/task/OgXNqcGaSB-gL9abrbxfbA/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 16:54:33 INFO - Downloading https://queue.taskcluster.net/v1/task/OgXNqcGaSB-gL9abrbxfbA/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 16:54:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OgXNqcGaSB-gL9abrbxfbA/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 16:54:34 INFO - Downloaded 16325977 bytes. 16:54:34 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'] 16:54:34 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 16:54:37 INFO - Return code: 0 16:54: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')]} 16:54:37 INFO - trying https://queue.taskcluster.net/v1/task/OgXNqcGaSB-gL9abrbxfbA/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip 16:54:37 INFO - Downloading https://queue.taskcluster.net/v1/task/OgXNqcGaSB-gL9abrbxfbA/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 16:54:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OgXNqcGaSB-gL9abrbxfbA/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 16:54:38 INFO - Downloaded 14413723 bytes. 16:54:38 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'] 16:54:38 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 16:54:39 INFO - Return code: 0 16:54:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:54:39 INFO - trying https://queue.taskcluster.net/v1/task/OgXNqcGaSB-gL9abrbxfbA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 16:54:39 INFO - Downloading https://queue.taskcluster.net/v1/task/OgXNqcGaSB-gL9abrbxfbA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg 16:54:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OgXNqcGaSB-gL9abrbxfbA/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 16:54:42 INFO - Downloaded 110868679 bytes. 16:54:42 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/OgXNqcGaSB-gL9abrbxfbA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 16:54:42 INFO - mkdir: /builds/slave/test/properties 16:54:42 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:54:42 INFO - Writing to file /builds/slave/test/properties/build_url 16:54:42 INFO - Contents: 16:54:42 INFO - build_url:https://queue.taskcluster.net/v1/task/OgXNqcGaSB-gL9abrbxfbA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 16:54:42 INFO - Running post-action listener: _resource_record_post_action 16:54:42 INFO - Running post-action listener: set_extra_try_arguments 16:54:42 INFO - [mozharness: 2016-08-09 23:54:42.680348Z] Finished download-and-extract step (success) 16:54:42 INFO - [mozharness: 2016-08-09 23:54:42.680508Z] Running populate-webroot step. 16:54:42 INFO - Running pre-action listener: _resource_record_pre_action 16:54:42 INFO - Running main action method: populate_webroot 16:54:42 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:54:42 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:54:42 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:54:42 INFO - '--tppagecycles', 16:54:42 INFO - '7'], 16:54:42 INFO - 'tests': ['tsvgm']}}, 16:54:42 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 16:54:42 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:54:42 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:54:42 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 16:54:42 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:54:42 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:54:42 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:54:42 INFO - 'talos_options': ['--disable-e10s'], 16:54:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:54:42 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:54:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:54:42 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:54:42 INFO - 'talos_options': ['--disable-e10s'], 16:54:42 INFO - 'tests': ['damp', 'tps']}, 16:54:42 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:54:42 INFO - 'tests': ['damp', 'tps']}, 16:54:42 INFO - 'g3': {'talos_options': ['--disable-e10s'], 16:54:42 INFO - 'tests': ['dromaeo_dom']}, 16:54:42 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:54:42 INFO - 'g4': {'talos_options': ['--disable-e10s'], 16:54:42 INFO - 'tests': ['basic_compositor_video']}, 16:54:42 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 16:54:42 INFO - 'other': {'talos_options': ['--disable-e10s'], 16:54:42 INFO - 'tests': ['a11yr', 16:54:42 INFO - 'ts_paint', 16:54:42 INFO - 'tpaint', 16:54:42 INFO - 'sessionrestore', 16:54:42 INFO - 'sessionrestore_no_auto_restore', 16:54:42 INFO - 'tabpaint']}, 16:54:42 INFO - 'other-e10s': {'tests': ['a11yr', 16:54:42 INFO - 'ts_paint', 16:54:42 INFO - 'tpaint', 16:54:42 INFO - 'sessionrestore', 16:54:42 INFO - 'sessionrestore_no_auto_restore', 16:54:42 INFO - 'tabpaint']}, 16:54:42 INFO - 'other-e10s_l64': {'tests': ['a11yr', 16:54:42 INFO - 'ts_paint', 16:54:42 INFO - 'tpaint', 16:54:42 INFO - 'sessionrestore', 16:54:42 INFO - 'sessionrestore_no_auto_restore', 16:54:42 INFO - 'tabpaint']}, 16:54:42 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 16:54:42 INFO - 'ts_paint', 16:54:42 INFO - 'tpaint', 16:54:42 INFO - 'sessionrestore', 16:54:42 INFO - 'sessionrestore_no_auto_restore', 16:54:42 INFO - 'tabpaint']}, 16:54:42 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 16:54:42 INFO - 'tests': ['a11yr', 16:54:42 INFO - 'ts_paint', 16:54:42 INFO - 'tpaint', 16:54:42 INFO - 'sessionrestore', 16:54:42 INFO - 'sessionrestore_no_auto_restore', 16:54:42 INFO - 'tabpaint']}, 16:54:42 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 16:54:42 INFO - 'tests': ['a11yr', 16:54:42 INFO - 'ts_paint', 16:54:42 INFO - 'tpaint', 16:54:42 INFO - 'sessionrestore', 16:54:42 INFO - 'sessionrestore_no_auto_restore', 16:54:42 INFO - 'tabpaint']}, 16:54:42 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 16:54:42 INFO - 'tests': ['tsvgx', 16:54:42 INFO - 'tsvgr_opacity', 16:54:42 INFO - 'tart', 16:54:42 INFO - 'tscrollx', 16:54:42 INFO - 'cart']}, 16:54:42 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:54:42 INFO - 'tsvgr_opacity', 16:54:42 INFO - 'tart', 16:54:42 INFO - 'tscrollx', 16:54:42 INFO - 'cart']}, 16:54:42 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:54:42 INFO - 'talos_options': ['--disable-e10s'], 16:54:42 INFO - 'tests': ['tp5o']}, 16:54:42 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:54:42 INFO - 'tests': ['tp5o']}, 16:54:42 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:54:42 INFO - 'talos_options': ['--disable-e10s', 16:54:42 INFO - '--xperf_path', 16:54:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:54:42 INFO - 'tests': ['tp5n']}, 16:54:42 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:54:42 INFO - 'talos_options': ['--xperf_path', 16:54:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:54:42 INFO - 'tests': ['tp5n']}}, 16:54:42 INFO - 'talos.zip': {'path': '', 16:54:42 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:54:42 INFO - Running post-action listener: _resource_record_post_action 16:54:42 INFO - [mozharness: 2016-08-09 23:54:42.699892Z] Finished populate-webroot step (success) 16:54:42 INFO - [mozharness: 2016-08-09 23:54:42.700034Z] Running create-virtualenv step. 16:54:42 INFO - Running pre-action listener: _resource_record_pre_action 16:54:42 INFO - Running main action method: create_virtualenv 16:54:42 INFO - Creating virtualenv /builds/slave/test/build/venv 16:54:42 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 16:54:42 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:54:42 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:54:42 INFO - Using real prefix '/tools/python27' 16:54:42 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:54:43 INFO - Installing distribute.............................................................................................................................................................................................done. 16:54:46 INFO - Installing pip.................done. 16:54:46 INFO - Return code: 0 16:54:46 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:54:46 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')]} 16:54:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:54:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:54:46 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')]} 16:54:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:54:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:54:46 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 0x102162a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1021f7618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f867bc979d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1020c6d30>, '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 0x101e2bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1020beb20>, '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.f0HgucWfr7/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.H9ogqVjJnt/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tm/bb1xmxh10h32jsf94bs0tnvh00000w/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 16:54:46 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 16:54:46 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 16:54:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.f0HgucWfr7/Render', 16:54:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:54:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:54:46 INFO - 'HOME': '/Users/cltbld', 16:54:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:54:46 INFO - 'LOGNAME': 'cltbld', 16:54:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:54:46 INFO - 'MOZ_NO_REMOTE': '1', 16:54:46 INFO - 'NO_EM_RESTART': '1', 16:54:46 INFO - 'PAGER': '/bin/cat', 16:54:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:54:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:54:46 INFO - 'PWD': '/builds/slave/test', 16:54:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:54:46 INFO - 'SHELL': '/bin/bash', 16:54:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.H9ogqVjJnt/Listeners', 16:54:46 INFO - 'TMPDIR': '/var/folders/tm/bb1xmxh10h32jsf94bs0tnvh00000w/T/', 16:54:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:54:46 INFO - 'USER': 'cltbld', 16:54:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:54:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:54:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:54:46 INFO - 'XPC_FLAGS': '0x0', 16:54:46 INFO - 'XPC_SERVICE_NAME': '0', 16:54:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:54:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:54:46 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 16:54:46 INFO - Cleaning up... 16:54:46 INFO - Return code: 0 16:54:46 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:54:46 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')]} 16:54:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:54:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:54:46 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')]} 16:54:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:54:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:54:46 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 0x102162a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1021f7618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f867bc979d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1020c6d30>, '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 0x101e2bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1020beb20>, '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.f0HgucWfr7/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.H9ogqVjJnt/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tm/bb1xmxh10h32jsf94bs0tnvh00000w/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 16:54:46 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 16:54:46 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 16:54:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.f0HgucWfr7/Render', 16:54:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:54:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:54:46 INFO - 'HOME': '/Users/cltbld', 16:54:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:54:46 INFO - 'LOGNAME': 'cltbld', 16:54:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:54:46 INFO - 'MOZ_NO_REMOTE': '1', 16:54:46 INFO - 'NO_EM_RESTART': '1', 16:54:46 INFO - 'PAGER': '/bin/cat', 16:54:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:54:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:54:46 INFO - 'PWD': '/builds/slave/test', 16:54:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:54:46 INFO - 'SHELL': '/bin/bash', 16:54:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.H9ogqVjJnt/Listeners', 16:54:46 INFO - 'TMPDIR': '/var/folders/tm/bb1xmxh10h32jsf94bs0tnvh00000w/T/', 16:54:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:54:46 INFO - 'USER': 'cltbld', 16:54:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:54:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:54:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:54:46 INFO - 'XPC_FLAGS': '0x0', 16:54:46 INFO - 'XPC_SERVICE_NAME': '0', 16:54:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:54:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:54:46 INFO - Downloading/unpacking psutil>=3.1.1 16:54:46 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 16:54:46 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 16:54:46 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 16:54:46 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 16:54:46 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 16:54:46 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 16:54:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:54:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:54:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:54:50 INFO - Installing collected packages: psutil 16:54:50 INFO - Running setup.py install for psutil 16:54:50 INFO - building 'psutil._psutil_osx' extension 16:54:50 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 16:54:50 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 16:54:50 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 16:54:50 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 16:54:50 INFO - building 'psutil._psutil_posix' extension 16:54:50 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 16:54:50 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 16:54:50 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 16:54:50 INFO - ^ 16:54:50 INFO - 1 warning generated. 16:54:50 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 16:54:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:54:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:54:51 INFO - Successfully installed psutil 16:54:51 INFO - Cleaning up... 16:54:51 INFO - Return code: 0 16:54:51 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:54:51 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')]} 16:54:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:54:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:54:51 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')]} 16:54:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:54:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:54:51 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 0x102162a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1021f7618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f867bc979d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1020c6d30>, '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 0x101e2bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1020beb20>, '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.f0HgucWfr7/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.H9ogqVjJnt/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tm/bb1xmxh10h32jsf94bs0tnvh00000w/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 16:54:51 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 16:54:51 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 16:54:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.f0HgucWfr7/Render', 16:54:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:54:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:54:51 INFO - 'HOME': '/Users/cltbld', 16:54:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:54:51 INFO - 'LOGNAME': 'cltbld', 16:54:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:54:51 INFO - 'MOZ_NO_REMOTE': '1', 16:54:51 INFO - 'NO_EM_RESTART': '1', 16:54:51 INFO - 'PAGER': '/bin/cat', 16:54:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:54:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:54:51 INFO - 'PWD': '/builds/slave/test', 16:54:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:54:51 INFO - 'SHELL': '/bin/bash', 16:54:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.H9ogqVjJnt/Listeners', 16:54:51 INFO - 'TMPDIR': '/var/folders/tm/bb1xmxh10h32jsf94bs0tnvh00000w/T/', 16:54:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:54:51 INFO - 'USER': 'cltbld', 16:54:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:54:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:54:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:54:51 INFO - 'XPC_FLAGS': '0x0', 16:54:51 INFO - 'XPC_SERVICE_NAME': '0', 16:54:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:54:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:54:51 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:54:51 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 16:54:51 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 16:54:51 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 16:54:51 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 16:54:51 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 16:54:51 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 16:54:53 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:54:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:54:53 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:54:53 INFO - Installing collected packages: mozsystemmonitor 16:54:53 INFO - Running setup.py install for mozsystemmonitor 16:54:54 INFO - Successfully installed mozsystemmonitor 16:54:54 INFO - Cleaning up... 16:54:54 INFO - Return code: 0 16:54:54 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:54:54 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')]} 16:54:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:54:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:54:54 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')]} 16:54:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:54:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:54:54 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 0x102162a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1021f7618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f867bc979d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1020c6d30>, '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 0x101e2bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1020beb20>, '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.f0HgucWfr7/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.H9ogqVjJnt/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tm/bb1xmxh10h32jsf94bs0tnvh00000w/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 16:54:54 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 16:54:54 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 16:54:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.f0HgucWfr7/Render', 16:54:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:54:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:54:54 INFO - 'HOME': '/Users/cltbld', 16:54:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:54:54 INFO - 'LOGNAME': 'cltbld', 16:54:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:54:54 INFO - 'MOZ_NO_REMOTE': '1', 16:54:54 INFO - 'NO_EM_RESTART': '1', 16:54:54 INFO - 'PAGER': '/bin/cat', 16:54:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:54:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:54:54 INFO - 'PWD': '/builds/slave/test', 16:54:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:54:54 INFO - 'SHELL': '/bin/bash', 16:54:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.H9ogqVjJnt/Listeners', 16:54:54 INFO - 'TMPDIR': '/var/folders/tm/bb1xmxh10h32jsf94bs0tnvh00000w/T/', 16:54:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:54:54 INFO - 'USER': 'cltbld', 16:54:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:54:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:54:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:54:54 INFO - 'XPC_FLAGS': '0x0', 16:54:54 INFO - 'XPC_SERVICE_NAME': '0', 16:54:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:54:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:54:54 INFO - Downloading/unpacking jsonschema==2.5.1 16:54:54 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 16:54:54 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 16:54:54 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 16:54:54 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 16:54:54 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 16:54:54 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 16:54:56 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:54:56 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:54:56 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 16:54:56 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 16:54:56 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 16:54:56 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 16:54:56 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 16:54:56 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 16:54:57 INFO - Downloading functools32-3.2.3-2.tar.gz 16:54:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:54:57 INFO - warning: no files found matching '*.txt' 16:54:57 INFO - no previously-included directories found matching 'build' 16:54:57 INFO - no previously-included directories found matching 'dist' 16:54:57 INFO - no previously-included directories found matching '.git*' 16:54:57 INFO - Installing collected packages: jsonschema, functools32 16:54:57 INFO - Running setup.py install for functools32 16:54:57 INFO - warning: no files found matching '*.txt' 16:54:57 INFO - no previously-included directories found matching 'build' 16:54:57 INFO - no previously-included directories found matching 'dist' 16:54:57 INFO - no previously-included directories found matching '.git*' 16:54:57 INFO - Successfully installed jsonschema functools32 16:54:57 INFO - Cleaning up... 16:54:57 INFO - Return code: 0 16:54:57 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 16:54:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:54:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:54:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:54:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:54:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:54:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:54:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x102162a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1021f7618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f867bc979d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1020c6d30>, '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 0x101e2bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1020beb20>, '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.f0HgucWfr7/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.H9ogqVjJnt/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tm/bb1xmxh10h32jsf94bs0tnvh00000w/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 16:54:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 16:54:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 16:54:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.f0HgucWfr7/Render', 16:54:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:54:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:54:57 INFO - 'HOME': '/Users/cltbld', 16:54:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:54:57 INFO - 'LOGNAME': 'cltbld', 16:54:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:54:57 INFO - 'MOZ_NO_REMOTE': '1', 16:54:57 INFO - 'NO_EM_RESTART': '1', 16:54:57 INFO - 'PAGER': '/bin/cat', 16:54:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:54:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:54:57 INFO - 'PWD': '/builds/slave/test', 16:54:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:54:57 INFO - 'SHELL': '/bin/bash', 16:54:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.H9ogqVjJnt/Listeners', 16:54:57 INFO - 'TMPDIR': '/var/folders/tm/bb1xmxh10h32jsf94bs0tnvh00000w/T/', 16:54:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:54:57 INFO - 'USER': 'cltbld', 16:54:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:54:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:54:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:54:57 INFO - 'XPC_FLAGS': '0x0', 16:54:57 INFO - 'XPC_SERVICE_NAME': '0', 16:54:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:54:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:54:57 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 16:54:57 INFO - Cleaning up... 16:54:57 INFO - Return code: 0 16:54:57 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:54:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:54:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:54:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:54:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:54:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:54:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:54:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x102162a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1021f7618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f867bc979d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1020c6d30>, '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 0x101e2bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1020beb20>, '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.f0HgucWfr7/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.H9ogqVjJnt/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tm/bb1xmxh10h32jsf94bs0tnvh00000w/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 16:54:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 16:54:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 16:54:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.f0HgucWfr7/Render', 16:54:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:54:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:54:57 INFO - 'HOME': '/Users/cltbld', 16:54:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:54:57 INFO - 'LOGNAME': 'cltbld', 16:54:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:54:57 INFO - 'MOZ_NO_REMOTE': '1', 16:54:57 INFO - 'NO_EM_RESTART': '1', 16:54:57 INFO - 'PAGER': '/bin/cat', 16:54:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:54:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:54:57 INFO - 'PWD': '/builds/slave/test', 16:54:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:54:57 INFO - 'SHELL': '/bin/bash', 16:54:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.H9ogqVjJnt/Listeners', 16:54:57 INFO - 'TMPDIR': '/var/folders/tm/bb1xmxh10h32jsf94bs0tnvh00000w/T/', 16:54:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:54:57 INFO - 'USER': 'cltbld', 16:54:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:54:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:54:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:54:57 INFO - 'XPC_FLAGS': '0x0', 16:54:57 INFO - 'XPC_SERVICE_NAME': '0', 16:54:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:54:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:54:58 INFO - Downloading/unpacking blobuploader==1.2.4 16:54:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:54:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:54:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:54:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:54:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:54:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:55:00 INFO - Downloading blobuploader-1.2.4.tar.gz 16:55:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:55:00 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:55:00 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 16:55:00 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 16:55:00 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 16:55:00 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 16:55:00 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 16:55:00 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 16:55:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:55:01 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:55:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:55:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:55:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:55:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:55:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:55:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:55:01 INFO - Downloading docopt-0.6.1.tar.gz 16:55:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:55:01 INFO - Installing collected packages: blobuploader, requests, docopt 16:55:01 INFO - Running setup.py install for blobuploader 16:55:02 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:55:02 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:55:02 INFO - Running setup.py install for requests 16:55:02 INFO - Running setup.py install for docopt 16:55:02 INFO - Successfully installed blobuploader requests docopt 16:55:02 INFO - Cleaning up... 16:55:02 INFO - Return code: 0 16:55:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:55:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:55:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:55:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:55:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:55:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:55:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:55:02 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 0x102162a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1021f7618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f867bc979d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1020c6d30>, '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 0x101e2bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1020beb20>, '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.f0HgucWfr7/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.H9ogqVjJnt/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tm/bb1xmxh10h32jsf94bs0tnvh00000w/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 16:55:02 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 16:55:02 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 16:55:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.f0HgucWfr7/Render', 16:55:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:55:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:55:02 INFO - 'HOME': '/Users/cltbld', 16:55:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:55:02 INFO - 'LOGNAME': 'cltbld', 16:55:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:55:02 INFO - 'MOZ_NO_REMOTE': '1', 16:55:02 INFO - 'NO_EM_RESTART': '1', 16:55:02 INFO - 'PAGER': '/bin/cat', 16:55:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:55:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:55:02 INFO - 'PWD': '/builds/slave/test', 16:55:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:55:02 INFO - 'SHELL': '/bin/bash', 16:55:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.H9ogqVjJnt/Listeners', 16:55:02 INFO - 'TMPDIR': '/var/folders/tm/bb1xmxh10h32jsf94bs0tnvh00000w/T/', 16:55:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:55:02 INFO - 'USER': 'cltbld', 16:55:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:55:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:55:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:55:02 INFO - 'XPC_FLAGS': '0x0', 16:55:02 INFO - 'XPC_SERVICE_NAME': '0', 16:55:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:55:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:55:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:55:03 INFO - Running setup.py (path:/var/folders/tm/bb1xmxh10h32jsf94bs0tnvh00000w/T/pip-83_sxR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:55:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:55:03 INFO - Running setup.py (path:/var/folders/tm/bb1xmxh10h32jsf94bs0tnvh00000w/T/pip-8x5eJa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:55:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:55:03 INFO - Running setup.py (path:/var/folders/tm/bb1xmxh10h32jsf94bs0tnvh00000w/T/pip-Mm0W6q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:55:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:55:03 INFO - Running setup.py (path:/var/folders/tm/bb1xmxh10h32jsf94bs0tnvh00000w/T/pip-_sgZSH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:55:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:55:03 INFO - Running setup.py (path:/var/folders/tm/bb1xmxh10h32jsf94bs0tnvh00000w/T/pip-R5uzx6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:55:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:55:03 INFO - Running setup.py (path:/var/folders/tm/bb1xmxh10h32jsf94bs0tnvh00000w/T/pip-PsJg1d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:55:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:55:03 INFO - Running setup.py (path:/var/folders/tm/bb1xmxh10h32jsf94bs0tnvh00000w/T/pip-n3TvKc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:55:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:55:03 INFO - Running setup.py (path:/var/folders/tm/bb1xmxh10h32jsf94bs0tnvh00000w/T/pip-rC5jDG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:55:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:55:03 INFO - Running setup.py (path:/var/folders/tm/bb1xmxh10h32jsf94bs0tnvh00000w/T/pip-Hxj_c7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:55:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:55:04 INFO - Running setup.py (path:/var/folders/tm/bb1xmxh10h32jsf94bs0tnvh00000w/T/pip-dIf0d8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:55:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:55:04 INFO - Running setup.py (path:/var/folders/tm/bb1xmxh10h32jsf94bs0tnvh00000w/T/pip-8RjDqY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:55:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:55:04 INFO - Running setup.py (path:/var/folders/tm/bb1xmxh10h32jsf94bs0tnvh00000w/T/pip-Q2kbkF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:55:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:55:04 INFO - Running setup.py (path:/var/folders/tm/bb1xmxh10h32jsf94bs0tnvh00000w/T/pip-RfWsTj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:55:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:55:04 INFO - Running setup.py (path:/var/folders/tm/bb1xmxh10h32jsf94bs0tnvh00000w/T/pip-khMIZL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:55:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:55:04 INFO - Running setup.py (path:/var/folders/tm/bb1xmxh10h32jsf94bs0tnvh00000w/T/pip-gntJjf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:55:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:55:04 INFO - Running setup.py (path:/var/folders/tm/bb1xmxh10h32jsf94bs0tnvh00000w/T/pip-wL_6Nb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:55:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:55:04 INFO - Running setup.py (path:/var/folders/tm/bb1xmxh10h32jsf94bs0tnvh00000w/T/pip-2t76n_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:55:04 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:55:04 INFO - Running setup.py install for manifestparser 16:55:05 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:55:05 INFO - Running setup.py install for mozcrash 16:55:05 INFO - Running setup.py install for mozdebug 16:55:05 INFO - Running setup.py install for mozdevice 16:55:05 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:55:05 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:55:05 INFO - Running setup.py install for mozfile 16:55:05 INFO - Running setup.py install for mozhttpd 16:55:05 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:55:05 INFO - Running setup.py install for mozinfo 16:55:05 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:55:05 INFO - Running setup.py install for mozInstall 16:55:06 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:55:06 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:55:06 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:55:06 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:55:06 INFO - Running setup.py install for mozleak 16:55:06 INFO - Running setup.py install for mozlog 16:55:06 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:55:06 INFO - Running setup.py install for moznetwork 16:55:06 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:55:06 INFO - Running setup.py install for mozprocess 16:55:06 INFO - Running setup.py install for mozprofile 16:55:06 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:55:06 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:55:06 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:55:06 INFO - Running setup.py install for mozrunner 16:55:07 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:55:07 INFO - Running setup.py install for mozscreenshot 16:55:07 INFO - Running setup.py install for moztest 16:55:07 INFO - Running setup.py install for mozversion 16:55:07 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:55:07 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:55:07 INFO - Cleaning up... 16:55:07 INFO - Return code: 0 16:55:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:55:07 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')]} 16:55:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:55:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:55:07 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')]} 16:55:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:55:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:55:07 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 0x102162a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1021f7618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f867bc979d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1020c6d30>, '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 0x101e2bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1020beb20>, '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.f0HgucWfr7/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.H9ogqVjJnt/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tm/bb1xmxh10h32jsf94bs0tnvh00000w/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 16:55:07 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 16:55:07 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 16:55:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.f0HgucWfr7/Render', 16:55:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:55:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:55:07 INFO - 'HOME': '/Users/cltbld', 16:55:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:55:07 INFO - 'LOGNAME': 'cltbld', 16:55:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:55:07 INFO - 'MOZ_NO_REMOTE': '1', 16:55:07 INFO - 'NO_EM_RESTART': '1', 16:55:07 INFO - 'PAGER': '/bin/cat', 16:55:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:55:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:55:07 INFO - 'PWD': '/builds/slave/test', 16:55:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:55:07 INFO - 'SHELL': '/bin/bash', 16:55:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.H9ogqVjJnt/Listeners', 16:55:07 INFO - 'TMPDIR': '/var/folders/tm/bb1xmxh10h32jsf94bs0tnvh00000w/T/', 16:55:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:55:07 INFO - 'USER': 'cltbld', 16:55:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:55:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:55:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:55:07 INFO - 'XPC_FLAGS': '0x0', 16:55:07 INFO - 'XPC_SERVICE_NAME': '0', 16:55:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:55:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:55:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:55:07 INFO - Running setup.py (path:/var/folders/tm/bb1xmxh10h32jsf94bs0tnvh00000w/T/pip-k9r43T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:55:07 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)) 16:55:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:55:07 INFO - Running setup.py (path:/var/folders/tm/bb1xmxh10h32jsf94bs0tnvh00000w/T/pip-EBo4Vm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:55:08 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)) 16:55:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:55:08 INFO - Running setup.py (path:/var/folders/tm/bb1xmxh10h32jsf94bs0tnvh00000w/T/pip-nTs8op-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:55:08 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)) 16:55:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:55:08 INFO - Running setup.py (path:/var/folders/tm/bb1xmxh10h32jsf94bs0tnvh00000w/T/pip-AxIuc8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:55:08 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)) 16:55:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:55:08 INFO - Running setup.py (path:/var/folders/tm/bb1xmxh10h32jsf94bs0tnvh00000w/T/pip-T97uiK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:55:08 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)) 16:55:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:55:08 INFO - Running setup.py (path:/var/folders/tm/bb1xmxh10h32jsf94bs0tnvh00000w/T/pip-_M783l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:55:08 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)) 16:55:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:55:08 INFO - Running setup.py (path:/var/folders/tm/bb1xmxh10h32jsf94bs0tnvh00000w/T/pip-Y10fOE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:55:08 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)) 16:55:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:55:08 INFO - Running setup.py (path:/var/folders/tm/bb1xmxh10h32jsf94bs0tnvh00000w/T/pip-A435XF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:55:08 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)) 16:55:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:55:08 INFO - Running setup.py (path:/var/folders/tm/bb1xmxh10h32jsf94bs0tnvh00000w/T/pip-k1jutz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:55:08 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)) 16:55:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:55:08 INFO - Running setup.py (path:/var/folders/tm/bb1xmxh10h32jsf94bs0tnvh00000w/T/pip-7HyVPs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:55:08 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)) 16:55:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:55:08 INFO - Running setup.py (path:/var/folders/tm/bb1xmxh10h32jsf94bs0tnvh00000w/T/pip-yKoM32-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:55:08 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)) 16:55:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:55:08 INFO - Running setup.py (path:/var/folders/tm/bb1xmxh10h32jsf94bs0tnvh00000w/T/pip-qtd9IP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:55:09 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)) 16:55:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:55:09 INFO - Running setup.py (path:/var/folders/tm/bb1xmxh10h32jsf94bs0tnvh00000w/T/pip-imO41Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:55:09 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)) 16:55:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:55:09 INFO - Running setup.py (path:/var/folders/tm/bb1xmxh10h32jsf94bs0tnvh00000w/T/pip-2icl4S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:55:09 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)) 16:55:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:55:09 INFO - Running setup.py (path:/var/folders/tm/bb1xmxh10h32jsf94bs0tnvh00000w/T/pip-VqIXBK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:55:09 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)) 16:55:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:55:09 INFO - Running setup.py (path:/var/folders/tm/bb1xmxh10h32jsf94bs0tnvh00000w/T/pip-TAgskp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:55:09 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)) 16:55:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:55:09 INFO - Running setup.py (path:/var/folders/tm/bb1xmxh10h32jsf94bs0tnvh00000w/T/pip-wUCMM_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:55:09 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)) 16:55:09 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)) 16:55:09 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)) 16:55:09 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)) 16:55:09 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)) 16:55:09 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)) 16:55:09 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:55:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:55:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:55:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:55:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:55:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:55:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:55:12 INFO - Downloading blessings-1.6.tar.gz 16:55:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:55:12 INFO - Installing collected packages: blessings 16:55:12 INFO - Running setup.py install for blessings 16:55:12 INFO - Successfully installed blessings 16:55:12 INFO - Cleaning up... 16:55:12 INFO - Return code: 0 16:55:12 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:55:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:55:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:55:12 INFO - Reading from file tmpfile_stdout 16:55:12 INFO - Current package versions: 16:55:12 INFO - blessings == 1.6 16:55:12 INFO - blobuploader == 1.2.4 16:55:12 INFO - docopt == 0.6.1 16:55:12 INFO - functools32 == 3.2.3-2 16:55:12 INFO - jsonschema == 2.5.1 16:55:12 INFO - manifestparser == 1.1 16:55:12 INFO - mozInstall == 1.12 16:55:12 INFO - mozcrash == 0.17 16:55:12 INFO - mozdebug == 0.1 16:55:12 INFO - mozdevice == 0.48 16:55:12 INFO - mozfile == 1.2 16:55:12 INFO - mozhttpd == 0.7 16:55:12 INFO - mozinfo == 0.9 16:55:12 INFO - mozleak == 0.1 16:55:12 INFO - mozlog == 3.3 16:55:12 INFO - moznetwork == 0.27 16:55:12 INFO - mozprocess == 0.23 16:55:12 INFO - mozprofile == 0.28 16:55:12 INFO - mozrunner == 6.12 16:55:12 INFO - mozscreenshot == 0.1 16:55:12 INFO - mozsystemmonitor == 0.3 16:55:12 INFO - moztest == 0.7 16:55:12 INFO - mozversion == 1.4 16:55:12 INFO - psutil == 3.1.1 16:55:12 INFO - requests == 1.2.3 16:55:12 INFO - wsgiref == 0.1.2 16:55:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:55:12 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')]} 16:55:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:55:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:55:12 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')]} 16:55:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:55:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:55:12 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 0x102162a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1021f7618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f867bc979d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1020c6d30>, '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 0x101e2bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1020beb20>, '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.f0HgucWfr7/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.H9ogqVjJnt/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tm/bb1xmxh10h32jsf94bs0tnvh00000w/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 16:55:12 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 16:55:12 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 16:55:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.f0HgucWfr7/Render', 16:55:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:55:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:55:12 INFO - 'HOME': '/Users/cltbld', 16:55:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:55:12 INFO - 'LOGNAME': 'cltbld', 16:55:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:55:12 INFO - 'MOZ_NO_REMOTE': '1', 16:55:12 INFO - 'NO_EM_RESTART': '1', 16:55:12 INFO - 'PAGER': '/bin/cat', 16:55:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:55:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:55:12 INFO - 'PWD': '/builds/slave/test', 16:55:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:55:12 INFO - 'SHELL': '/bin/bash', 16:55:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.H9ogqVjJnt/Listeners', 16:55:12 INFO - 'TMPDIR': '/var/folders/tm/bb1xmxh10h32jsf94bs0tnvh00000w/T/', 16:55:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:55:12 INFO - 'USER': 'cltbld', 16:55:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:55:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:55:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:55:12 INFO - 'XPC_FLAGS': '0x0', 16:55:12 INFO - 'XPC_SERVICE_NAME': '0', 16:55:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:55:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:55:12 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)) 16:55:12 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)) 16:55:12 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)) 16:55:12 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)) 16:55:12 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)) 16:55:12 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)) 16:55:12 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)) 16:55:12 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)) 16:55:12 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)) 16:55:12 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)) 16:55:12 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)) 16:55:12 INFO - Cleaning up... 16:55:12 INFO - Return code: 0 16:55:12 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:55:12 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')]} 16:55:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:55:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:55:12 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')]} 16:55:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:55:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:55:12 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 0x102162a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1021f7618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f867bc979d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1020c6d30>, '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 0x101e2bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1020beb20>, '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.f0HgucWfr7/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.H9ogqVjJnt/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tm/bb1xmxh10h32jsf94bs0tnvh00000w/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 16:55:12 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 16:55:12 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 16:55:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.f0HgucWfr7/Render', 16:55:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:55:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:55:12 INFO - 'HOME': '/Users/cltbld', 16:55:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:55:12 INFO - 'LOGNAME': 'cltbld', 16:55:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:55:12 INFO - 'MOZ_NO_REMOTE': '1', 16:55:12 INFO - 'NO_EM_RESTART': '1', 16:55:12 INFO - 'PAGER': '/bin/cat', 16:55:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:55:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:55:12 INFO - 'PWD': '/builds/slave/test', 16:55:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:55:12 INFO - 'SHELL': '/bin/bash', 16:55:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.H9ogqVjJnt/Listeners', 16:55:12 INFO - 'TMPDIR': '/var/folders/tm/bb1xmxh10h32jsf94bs0tnvh00000w/T/', 16:55:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:55:12 INFO - 'USER': 'cltbld', 16:55:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:55:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:55:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:55:12 INFO - 'XPC_FLAGS': '0x0', 16:55:12 INFO - 'XPC_SERVICE_NAME': '0', 16:55:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:55:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:55:13 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:55:13 INFO - Cleaning up... 16:55:13 INFO - Return code: 0 16:55:13 INFO - Running post-action listener: _resource_record_post_action 16:55:13 INFO - Running post-action listener: _start_resource_monitoring 16:55:13 INFO - Starting resource monitoring. 16:55:13 INFO - [mozharness: 2016-08-09 23:55:13.256535Z] Finished create-virtualenv step (success) 16:55:13 INFO - [mozharness: 2016-08-09 23:55:13.257615Z] Running install step. 16:55:13 INFO - Running pre-action listener: _resource_record_pre_action 16:55:13 INFO - Running main action method: install 16:55:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:55:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:55:13 INFO - Reading from file tmpfile_stdout 16:55:13 INFO - Detecting whether we're running mozinstall >=1.0... 16:55:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:55:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:55:13 INFO - Reading from file tmpfile_stdout 16:55:13 INFO - Output received: 16:55:13 INFO - Usage: mozinstall [options] installer 16:55:13 INFO - Options: 16:55:13 INFO - -h, --help show this help message and exit 16:55:13 INFO - -d DEST, --destination=DEST 16:55:13 INFO - Directory to install application into. [default: 16:55:13 INFO - "/builds/slave/test"] 16:55:13 INFO - --app=APP Application being installed. [default: firefox] 16:55:13 INFO - mkdir: /builds/slave/test/build/application 16:55:13 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'] 16:55:13 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 16:55:47 INFO - Reading from file tmpfile_stdout 16:55:47 INFO - Output received: 16:55:47 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 16:55:47 INFO - Running post-action listener: _resource_record_post_action 16:55:47 INFO - [mozharness: 2016-08-09 23:55:47.503427Z] Finished install step (success) 16:55:47 INFO - [mozharness: 2016-08-09 23:55:47.503574Z] Running run-tests step. 16:55:47 INFO - Running pre-action listener: _resource_record_pre_action 16:55:47 INFO - Running main action method: run_tests 16:55:47 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 16:55:47 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 16:55:47 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 16:55:47 INFO - 2016-08-09 16:55:47.518 screenresolution[11919:234434] starting screenresolution argv=screenresolution get 16:55:47 INFO - 2016-08-09 16:55:47.521 screenresolution[11919:234434] Display 0: 1600x1200x32@60 16:55:47 INFO - 2016-08-09 16:55:47.527 screenresolution[11920:234436] starting screenresolution argv=screenresolution list 16:55:47 INFO - Available Modes on Display 0 16:55:47 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 16:55:47 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 16:55:47 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 16:55:47 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 16:55:47 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 16:55:47 INFO - Intel Iris: 16:55:47 INFO - Chipset Model: Intel Iris 16:55:47 INFO - Type: GPU 16:55:47 INFO - Bus: Built-In 16:55:47 INFO - VRAM (Dynamic, Max): 1536 MB 16:55:47 INFO - Vendor: Intel (0x8086) 16:55:47 INFO - Device ID: 0x0a2e 16:55:47 INFO - Revision ID: 0x0009 16:55:47 INFO - Displays: 16:55:47 INFO - Display: 16:55:47 INFO - Resolution: 1600 x 1200 @ 60 Hz 16:55:47 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 16:55:47 INFO - Display Serial Number: 1600x1200 60 16:55:47 INFO - Main Display: Yes 16:55:47 INFO - Mirror: Off 16:55:47 INFO - Online: Yes 16:55:47 INFO - Rotation: Supported 16:55:47 INFO - Return code: 0 16:55:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:55:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:55:47 INFO - Python 2.7.3 16:55:47 INFO - Return code: 0 16:55:47 INFO - grabbing minidump binary from tooltool 16:55:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:55:47 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 0x1020c6d30>, '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 0x101e2bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1020beb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:55:47 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 16:55:47 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 16:55:47 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 16:55:47 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:55:47 INFO - Return code: 0 16:55:47 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 16:55:47 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:55:47 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:55:47 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 16:55:47 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:55:47 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/OgXNqcGaSB-gL9abrbxfbA/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0350', '--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 16:55:47 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/OgXNqcGaSB-gL9abrbxfbA/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0350 --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 16:55:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.f0HgucWfr7/Render', 16:55:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:55:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:55:47 INFO - 'HOME': '/Users/cltbld', 16:55:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:55:47 INFO - 'LOGNAME': 'cltbld', 16:55:47 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:55:47 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 16:55:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:55:47 INFO - 'MOZ_NO_REMOTE': '1', 16:55:47 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:55:47 INFO - 'NO_EM_RESTART': '1', 16:55:47 INFO - 'PAGER': '/bin/cat', 16:55:47 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:55:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:55:47 INFO - 'PWD': '/builds/slave/test', 16:55:47 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:55:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:55:47 INFO - 'SHELL': '/bin/bash', 16:55:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.H9ogqVjJnt/Listeners', 16:55:47 INFO - 'TMPDIR': '/var/folders/tm/bb1xmxh10h32jsf94bs0tnvh00000w/T/', 16:55:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:55:47 INFO - 'USER': 'cltbld', 16:55:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:55:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:55:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:55:47 INFO - 'XPC_FLAGS': '0x0', 16:55:47 INFO - 'XPC_SERVICE_NAME': '0', 16:55:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:55:47 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/OgXNqcGaSB-gL9abrbxfbA/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0350', '--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 16:55:48 INFO - mozversion application_buildid: 20160809142816 16:55:48 INFO - mozversion application_changeset: 0b1fc540eace69753abe0f344e061dba3e9df6fc 16:55:48 INFO - mozversion application_display_name: Nightly 16:55:48 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:55:48 INFO - mozversion application_name: Firefox 16:55:48 INFO - mozversion application_remotingname: firefox 16:55:48 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 16:55:48 INFO - mozversion application_vendor: Mozilla 16:55:48 INFO - mozversion application_version: 51.0a1 16:55:48 INFO - mozversion platform_buildid: 20160809142816 16:55:48 INFO - mozversion platform_changeset: 0b1fc540eace69753abe0f344e061dba3e9df6fc 16:55:48 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 16:55:48 INFO - mozversion platform_version: 51.0a1 16:55:48 INFO - using testdate: 1470786948 16:55:48 INFO - actual date: 1470786948 16:55:48 INFO - starting webserver on 'localhost:62071' 16:55:48 INFO - SUITE-START | Running 2 tests 16:55:48 INFO - TEST-START | dromaeo_css 16:55:48 INFO - operating with platform_type : mac_ 16:55:48 INFO - Initialising browser for dromaeo_css test... 16:55:48 INFO - TEST-INFO | started process 11930 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/tm/bb1xmxh10h32jsf94bs0tnvh00000w/T/tmpFAcibL/profile http://localhost:62071/getInfo.html) 16:55:51 INFO - PROCESS | 11930 | __metrics Screen width/height:1600/1200 16:55:51 INFO - PROCESS | 11930 | colorDepth:24 16:55:51 INFO - PROCESS | 11930 | Browser inner width/height: 1024/663 16:55:51 INFO - PROCESS | 11930 | __metrics 16:55:51 ERROR - PROCESS | 11930 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2983: TypeError: this.tabs is undefined 16:55:52 INFO - TEST-INFO | 11930: exit 0 16:55:52 INFO - Browser initialized. 16:55:52 INFO - Running cycle 1/1 for dromaeo_css test... 16:55:52 INFO - TEST-INFO | started process 11933 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/tm/bb1xmxh10h32jsf94bs0tnvh00000w/T/tmpFAcibL/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:56:04 INFO - PROCESS | 11933 | RSS: Main: 261029888 16:56:04 INFO - PROCESS | 11933 | 16:56:53 INFO - PROCESS | 11933 | 1470787013762 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] 16:59:06 INFO - PROCESS | 11933 | Cycle 1(1): loaded http://localhost:62071/tests/dromaeo/cssquery-dojo.html (next: http://localhost:62071/tests/dromaeo/cssquery-ext.html) 16:59:07 INFO - PROCESS | 11933 | RSS: Main: 273338368 16:59:07 INFO - PROCESS | 11933 | 17:02:09 INFO - PROCESS | 11933 | Cycle 1(1): loaded http://localhost:62071/tests/dromaeo/cssquery-ext.html (next: http://localhost:62071/tests/dromaeo/cssquery-jquery.html) 17:02:10 INFO - PROCESS | 11933 | RSS: Main: 285827072 17:02:10 INFO - PROCESS | 11933 | 17:05:12 INFO - PROCESS | 11933 | Cycle 1(1): loaded http://localhost:62071/tests/dromaeo/cssquery-jquery.html (next: http://localhost:62071/tests/dromaeo/cssquery-mootools.html) 17:05:13 INFO - PROCESS | 11933 | RSS: Main: 291594240 17:05:13 INFO - PROCESS | 11933 | 17:08:14 INFO - PROCESS | 11933 | Cycle 1(1): loaded http://localhost:62071/tests/dromaeo/cssquery-mootools.html (next: http://localhost:62071/tests/dromaeo/cssquery-prototype.html) 17:08:15 INFO - PROCESS | 11933 | RSS: Main: 290025472 17:08:15 INFO - PROCESS | 11933 | 17:11:18 INFO - PROCESS | 11933 | Cycle 1(1): loaded http://localhost:62071/tests/dromaeo/cssquery-prototype.html (next: http://localhost:62071/tests/dromaeo/cssquery-yui.html) 17:11:19 INFO - PROCESS | 11933 | RSS: Main: 294289408 17:11:19 INFO - PROCESS | 11933 | 17:14:22 INFO - PROCESS | 11933 | Cycle 1(1): loaded http://localhost:62071/tests/dromaeo/cssquery-yui.html (next: http://localhost:62071/tests/dromaeo/cssquery-dojo.html) 17:14:22 INFO - PROCESS | 11933 | RSS: Main: 294404096 17:14:22 INFO - PROCESS | 11933 | 17:14:22 INFO - PROCESS | 11933 | __start_tp_report 17:14:22 INFO - PROCESS | 11933 | _x_x_mozilla_page_load 17:14:22 INFO - PROCESS | 11933 | _x_x_mozilla_page_load_details 17:14:22 INFO - PROCESS | 11933 | |i|pagename|runs| 17:14:22 INFO - PROCESS | 11933 | |0;dojo.html;2844.360018995725;3362.9663703362958;3407.1652445150944;3436.7250619950405;3443.879464218752;5678.318601767794;5681.8579535511635;5771.942280577198;5774.335951365589;5810.535157187425;4410.3825464435;5714.285714285715;5756.280464941882;5821.621594596349;5889.146073819305;5161.845144645667;5262.8684282892855;5282.418933917266;5340.973295133519;5375.865603359928;5396.379416367129;5411.83764487066;5427.782888684467;5452.04589196889;5468.671879687232;5175.715335656538;5214.8174813881715;5287.894242115136;5303.946960530384;5345.358556973169;5219.42586315505;5224.190250511177;5229.424763276036;5245.606579506552;5291.656042357273;5167.844964651029;5223.242629818655;5251.08106081438;5314.282571852789;5326.76029578666;5575.581831362664;5708.286464191976;5792.536597072224;5832.737526811304;5865.178874957509;6254.781082662085;6261.217347831521;6290.87418251637;6298.244210694746;6312.400321969406;6296.307406185316;6301.08634248036;6307.905381419282;6311.431971122575;6326.810195694136;5787.797427090031;5900.970495147497;5930.911036334458;5931.169636250928;5980.581359304851;6393.424591786761;6403.295637479873;6411.0383442484;6413.102165696806;6429.807105786834;6245.156903818017;6263.154474146023;6270.372962703693;6275.497960163176;6277.5605707600025;6148.415900489446;6190.473809726133;6218.595791273553;6219.564630475914;6313.305536390993;6242.875142497124;6274.215723034621;6281.214848143982;6295.559310848196;6297.590656607397;5165.509276618715;6275.215598050244;6280.466160376328;6285.465735412449;6319.842003949938;4925.064237794808;4926.8768280793265;4977.601791856643;5012.674176178537;5015.4733752956145;3650.3976843821;4324.070324880103;4485.282354823213;4493.910121797546;4531.501534831166;5831.300243970666;5909.6158749681135;5945.256842894638;5954.434328738849;5992.610480318765;6201.627902325785;6206.844828879224;6221.875562488724;6254.655993920378;6279.152314437584;5981.132735753292;5986.5809393342915;5995.820125396245;6005.399460054047;6022.427869352405;5505.366882808528;5522.144067669517;5556.222128901957;5577.60559860035;5579.0515612346;5263.868403289872;6335.968320158369;6363.904541431974;6495.935040649533;6501.837454063686;6263.6241825490615;6285.43431091204;6290.842728931813;6295;6304.211973503312;6413.647249401328;6416.262129854939;6464.256610489854;6505.381988711065;6514.381133792472;6123.160610921377;6164.753409863555;6210.4100110489435;6227.719752611053;6276.811695649138;6285.057241413641;6285.748570057147;6290.559660823881;6298.02380631003;6301.684915754286;6234.3453937337745;6239.844003899939;6248.4376406123665;6250.343713910156;6268.059791031382;5415.241866138823;6082.3613520581475;6117.388261174025;6145.66198859067;6228.03465462854;4944.777485013111;6107.3331742623295;6117.979653188475;6136.8772624548155;6144.293406258337;6092.75628974836;6220.968895155495;6239.001759718423;6245.406686364788;6291.402316779899;5964.433378829004;6058.242719660043;6095.299040610209;6135.631862088289;6141.969290153521 17:14:22 INFO - PROCESS | 11933 | |1;ext.html;459.5886681420131;517.5135372749615;536.9677819330841;548.2105767694522;556.212958663491;29722.554161687563;40291.59708402915;40390.79804600977;40508.797456012755;40707.18585628286;41395.96510087249;41790.37314440278;41803.79098104513;41979.790101049526;42003.94990125248;7479.102507699084;7934.008248968893;8026.317762990153;8038.839223215532;8039.598020098972;9659.71020869375;9748.073932976356;9748.463834489101;9758.853617195748;9769.218462522982;9727.416355018686;9742.707718768448;9773.315867889216;9775.022497750204;9783.168430683401;9682.806343873153;9699.709008729715;9713.562889669947;9742.976987416361;9753.21974242066;9636.180924621416;9672.226221902301;9719.708408747749;9746.561404736804;9747.90252097477;39491;39694.20611587781;39739.60260397388;39912.401313980314;39925.80037099825;3075.507918732992;3244.124086496656;3278.7540934429776;3281.96718032819;3508.7894676336623;29353.266168345963;29682;30237.244068898235;30401.543976840367;31030.453697949037;3090.7836451448406;3110.1758034120976;3124.234562532194;3137.576427182347;3232.3050544133125;434783;447143;447273;448631;452858.9999999967;32557.837210813796;32783.83608081944;32859.17852053718;32896;33077.66922330794;33564.16089597731;33724.32551349008;34051;35049.64950350515;35127;16348.182590870409;16389.34442622282;16456.917715411346;16561.66876662484;16566.92314999521;10503.474826258656;12761.744765104831;12765.680857978625;12790.68023299425;12806.61580152597;15105.924470377578;18479.353222637143;18725.531861703566;18791.81208187928;18819.529511762317;6573.3426657333885;7169;8035.196480352035;8060.596970151469;8076.515409075357;904.7150147703452;923.8959443464995;997.2769741937037;1018.8777346718293;1067.1356201476829;22726.545469090855;30349.089527314216;30712.692873070984;30743;31157.8442107788;978.1538968791943;1014.0265345268477;1093.327603523843;1116.6147679050714;1173.2901594535354;15626.76559851603;15846.841531584767;15976.600584985468;16073;16137.273822678007;701796;706980;709201;709671;710780;49669;58747.70626146842;58866.11700824491;58935;59640;1346.8181795457683;1396.4693416501868;1408.704172123845;1414.6463384153963;1415.0589857744485;29282;29813;29854.552181717725;30522.84738576293;30694.079177624706;49146.26280605865;49301.2604810921;49340;49361.753191233816;49374.753126234136;567293;569905;570222;570303;571217;26093.347666308495;26613.600795988463;26930.192094237205;26978.46043079088;27053.72946270512;46399.07201856012;46487.76756116198;47316.52683473259;47553.04893902172;47676;38839.8348049559;39206.215875682894;39208.80395598004;39777.54369499073;40229.19541609093;38557.614423856525;39137.80431097826;39342.2131557373;39635.009124772114;39923;38011.42982855204;38852.80573597114;39679.2064158721;39884;40125.197496050496;30733.69266307308;33922.3215535683;34541.30917381689;35153;36079.27841443209;23268.650970235798;26001.73998259993;26557.07050253232;26662.46675066449;26912.596311055742 17:14:22 INFO - PROCESS | 11933 | |2;jquery.html;362.7370156636437;372.1774877520678;375.45746396457116;387.4943199125141;398.63524874739613;19296.51758706033;20658.690119648218;21153.788462115375;21179.68230476542;21275.36173914785;17621.11894405281;17880.46358609244;18264.543386415313;21089.47276318089;21182.25862094827;4868.440129385131;4961.925571116436;5083.110455670261;5821.912671309934;5870.589058765888;3797.2025874566234;5454.263674403965;5922.97038514809;5923.911141332884;5925.111233314994;6232.345603711613;6507.51193660475;6558.1474408327085;6620.470362370998;6631.801045968628;5945.702714864283;5952.9107063394085;6007.639541627516;6235.968820155893;6596.208454985408;5628.493435590816;5678.346990096109;5765.740541675635;5770.2210201622665;5782.306123265193;9873.950630246803;11958.701032474171;12577.496900123984;13209.273489958048;13322.666933326647;2170.511634882155;2171.739391273057;2339.4619237575284;2419.552382809186;2543.2497413262945;7078.610676412795;7492.1384040835455;9647.421154730739;9957.203423726085;10027.74930626733;1516.9469068582546;1860.692985657365;1894.7157926311027;1894.9052547372714;1924.191839427444;119063.40468297689;119348;123465.38267308696;124890;125160;8801.25189358899;9757.414555126716;11051.557937682403;11060.612878549213;11097.722556936142;13893.235872026933;13929.58211253664;13949.930250348887;13989.440422382992;14129;6431.324710905287;8025.598720063974;8111.75664730059;8150.7147249845975;8463.15368463161;7726.884096738553;7861.449698521163;8286.088530261666;8472;8478.957605211934;4369.3227549729845;4377.518472967971;4398.362237475548;4407.823687052482;4488.102379524043;1258.811178323259;1895.4787433455633;1914.2343062774723;1933.178399180371;1940.8835469871854;875.7810547363159;915.7317115794539;930.5533343994921;937.7561833923093;984.9556769945369;19822.439539318577;20650.483737906674;20953.476163096046;20961.37115886526;21037.68443473349;745.5005146551823;939.7086903060073;949.8337790886567;1003.7390278527636;1033.94313312767;10674.14606831467;11001.834972475419;11129.387883666313;11156.721081973015;11181.720456988478;460036;564994;575187;576191;584468;120045;122520;124117.37941310236;124739;130604.69395306116;959.2661613865398;995.328153496387;1000.5841733946385;1000.7748256642197;1010.4543546484963;14441.566752997427;18334.174962127003;18554.721679174552;18595.81404185941;18986.43040708781;53226.73386633197;53244;54972;55327.89344213174;56483.71758141183;82258;82277.58861205656;83023;83678.74481882656;84107.06485048328;7700.8844867325915;7785.532868027936;7839.09850367215;7876.3305119063225;7885.763427096967;8825.735227943173;8916.598753055998;9836.819581650248;11386.975172234539;12245.571405000783;6092.5682464619895;9877.703668889944;10978.560857565928;11181.664550063511;11204.831927521256;10234.437105959243;10714.89285107139;10827;11051.447427628425;11067.557297708001;10031.749206269902;10242.975702429698;10301.330413523097;11152.16358773079;11498;6474.514411419068;6710.463162946855;6894.207166175754;7830.256125668053;8035.718749843727;8827.69103081389;10798.67603971882;11136.053435457752;11155.832662509907;11181.888181118411 17:14:22 INFO - PROCESS | 11933 | |3;mootools.html;1302.394386610226;1522.9314680839361;1690.5689049292437;1855.85153187745;1870.6819840627093;7865.331446827012;7989.840203195932;8349.123342049088;8903.421277616959;8908.10918908109;8446.197611226939;8671.523066231355;8697.913020869806;8712.564371781402;8725.432846864966;2314.4098254944965;2344.753800850912;2359.95280094398;2364.6216605343147;2373.2761507740133;2329.5923213437663;2331.720193576773;2377.476955069882;2377.524495100978;2388.9761102389016;2333.4516388648653;2346.120204923154;2353.752855950126;2358.1392791631015;2363.314638754759;1916.8562357823218;2321.802646775026;2349.330440824374;2352.1649814315842;2357.0807385119815;2337.906483740648;2338.1232037985756;2344.2146880794953;2344.6717459555675;2347.835651504395;7445.367143792784;8761.474311541328;8778.341624378198;8827.955860220658;8840.778980525474;5131.512506311894;5236.450172731847;5314.654547454403;5316.627836051478;5351.09031464652;3356.1441832332844;3439.8992322456825;3541.451075083366;3584.2473080653094;3586.193106551031;1046.440154517337;1078.4553800330782;1087.4617064553017;1089.9182561307855;1102.8841971592947;10527.210459215514;11437.313761174357;11515.481803318871;11516.481758320895;11549;4319.222539942841;4482.9775851121185;4721.386219791474;4745.2882067690125;4759.048190361941;8328.500289982621;9765.414075155371;9862.556184971694;9870.25973052024;9880.95059524712;5311.575073994071;5315.149576067888;5316.0962636351915;5316.787328506816;5345.9732701337025;4356.28121359972;4696.694714843524;4815.590674792612;4840.419149701988;4904.092742842586;3846.8845934622004;3935.7835319057726;3952.130531283113;3953.6046395360236;4031.717779755389;1253.2355263289387;1260.571405722059;1262.2615769774602;1271.213944408108;1278.514164617458;913.9908600913906;927.1146055516965;937.3672770879629;949.6752030916832;997.6657819630506;5146.974265128725;5765.971170144123;5911.674857882857;5959.433853783884;6176.505879529627;332.9217633856042;382.15734305856074;427.74335398760496;428.50507663648534;441.5474139007543;3692.538432695913;3786.9621303786607;4045.1707399982934;4050.6632811172244;4137.77242251673;8800.38397312182;10215.131713804261;10647.414392208348;10714.946425267979;10781.407022613676;10306.278560500843;10432.269741118049;10668.679939601825;10692.89307106919;10722;7914.485558438683;8180.263776260046;8265.669373225124;8281.627326770309;8289.378296627656;5019.7239151847;5392;6131.141640170469;6137.478314343331;6149.354317796567;9917.504124793588;9993.250506211918;10012.64955726546;10059.29584929048;10071.043250891154;9668;10111.292209545261;10113.544890480092;10139.442330671589;10168.745781355525;6842.178938527409;7239.203687594466;7373.18894921569;7463.477556571205;7634.6946122154495;8405.07544170153;8470.788230294293;8497.702580409656;8499;8507.574621268788;7485.251474852689;7633.580153091411;7642.465027448247;7731.381489480716;7736.613169341623;6275.309715931336;7335.1197856257595;7416.629168541659;7528.397728181622;7591.3547348475995;6999.300069993164;7015.894761578683;7084.716611335489;7103.076600041962;7109.28907109285;4912.975435122801;4999.500049994971;5027;5116.155834287301;5163.509466600667;5080.644354895122;5107.719075450886;5138.511841375063;5201.141811601195;5251.186066159751 17:14:22 INFO - PROCESS | 11933 | |4;prototype.html;298.49852248222993;306.2832970848215;311.1769370016307;315.4212020941572;318.6876860676537;4607.834317870604;5250.737463126848;5584.301962254718;5655.604107712456;5656.943430565693;5357.812476563311;5468.72656367181;5510.9448905510935;5532.225488431623;5540.473655002778;3612.674859262666;4079.775612341335;4160.812763425645;4234.661227101825;4292.840932948102;4134.490910817545;4177.871974566865;4211.705180637341;4290.785460726951;4297.247981603223;3407.318536292739;4155.854545090922;4184.581541845821;4208.4318616986775;4224.753697659183;3408.812515311657;3629.800360980145;4169.541350451463;4191.392248124005;4216;3248.3016151527536;3660.707143428546;3671.4125739881492;3675.558932928039;3681.355762741536;4304.352823013824;5053.292539044537;5224.895502089975;5242.973785131088;5260.894782104375;4770.187328815028;4786.1863483207935;4821.275979071813;4823.614110871122;4857.587105096071;5830.30036395631;5844.1818145459665;5850.473457388813;5922.792702255443;5940.702964851784;3276.6559511251453;3510.069831494656;3807.5430948286107;3861.7296789224765;3894.4227587826977;4873;5606.747696353633;5717.2281741965135;6084;6092.238470191226;3015.9246018849703;3760.9657344230554;3942.9605703943166;3986.80065996699;4007.937896457441;3759.2293579816073;3875.903102422462;3975.34406822871;4026.375911733686;4035.6973227008093;4114.300568903293;4522.615577675869;4605.868009753332;4715;4760.7619619018915;5861.267341582302;5879.706014699248;5905;5944.940550594439;6012.7895523657335;1189.714468527547;1263.9557615483598;1414.6604814844363;1438.4605772835187;1439.9496017639333;898.6989358564823;900.5366279795333;954.4702690006974;983.7491439682835;991.6033586565432;3907.902302442462;3998.4801975742967;4299.1831552005015;4450.310201918708;4493.393391892118;4580.725156490621;4977.701337919736;5024.809246128734;5039.874003149877;5082.186850103965;4464.566811087965;4524.796384162721;4537.164272329794;4583.564561366665;4599.954000460019;2444.278937713379;2468.4445999649934;2573.597389422769;2650.4169082801754;2653.841928105548;4640.076751646441;4766.928496072562;4823.5658790709;5188.558972487305;5209.843704688866;4359.215341238608;4442.68901176921;4782.378290822171;5184.429712731597;5226.529612334832;5599.916001259984;5708.286464191976;5729.5702822288495;6332.100369888923;6384.648844313608;6105.358937311518;6115.330801519053;6122.94881214798;6140.846478838065;6142.6314421134875;3952.6837852971116;5790.539020916178;5890.705464726832;5955.6724380157775;6060.212172417558;5992.250968628921;6133.202683651097;6216.658083805434;6230.314665386713;6256.968715156395;3146.9370612588077;3353.782004169721;3963.781991990468;3965.900852478711;3985.202959408072;5604.523615492729;5718.370979192368;5937.435943585352;6004.759809607567;6052.969735151472;5795.565332599987;5813.244278243801;6007.996001999;6017.759289628366;6038.215032045981;4911.4106307243355;4993.600511958962;5784.929787989236;5874.706264686834;5916.940830591639;5533.529649979797;5713.657180569179;5728.770849166153;5747.48272655463;5832.383921968407;4885.853424397274;5574.526165275997;5914.083317085859;5954.9578823704815;5972.850678733066;5515.972420137874;5759;5777;5789.234283543559;5868.559858010581 17:14:22 INFO - PROCESS | 11933 | |5;yui.html;612.1124369663988;646.382704517186;696.088124556831;774.1561697749455;831.0567505880825;15008.02447840891;15110.093394396345;15432.30554625043;15558.06651600902;15606.219689015546;12129.696757581065;14494.492692755755;14587.12477251363;14675;14757.557273281818;709.2588245283665;869.6695255802817;874.470945078228;875.8248350329959;879.5250564695057;689.6999805084779;856.297835774665;870.9433886797337;880.0759202837028;883.6862913665652;901.8602116671926;903.8373092843285;906.714384968736;909.2135302962955;910.5856835140029;844.7170197983683;868.68727258187;886.0297973718767;898.3127907151035;903.8373092843285;659.6404959297195;664.7872680742164;670.2158474584747;670.7585269303047;672.6166085331363;15309.157996310198;15359.769603455845;15395.61510962235;15443.227838608136;15491.302891369915;14909.701805963929;14911.478098266618;14983.02610330336;15278.38886444552;15292.464763733327;12029.51881924722;12299.385030748515;12454.065945054066;12567;12596.748065038739;3853.9614603853884;3865.246276975991;4078.6940979426663;4107.958920410788;4112.074783173792;114183;117970;119260.21109683362;119272.40363798212;120917;11438.828417573743;11512.079033677286;11582.6525204244;11591.130665200144;12161.635150945485;24302.39244018878;24305.756942430704;24309.39226519351;24329.27012189637;24424.75575244225;8321.750347489586;8346.290565301895;8372.079071302152;8491;8605.827883442296;4537.705049171794;4625.167469855458;4635.791389387486;4662.53374662531;4681.157391669532;3572.6070132285427;3713.2759111972905;3719.4048952167523;3722.3299806035175;3730.5896351401325;645.1612903225788;654.4404534123352;674.7874419557824;680.5100327764002;682.4063065133266;578.0866231354449;608.8295277322356;656.6815094679076;665.364576829127;672.0960308385214;8955.776105597412;9454.871309802305;9557.808843823084;9649.758756031015;9687.70936871895;609.9664518451527;628.5694299404922;660.0758937487556;665.3246954341347;674.3369599221427;4521.547845215518;4763.214069678534;4792.305115758265;4844.709317440965;4921.26181072842;132109;139395;141096;141179;143713;114858.4257078726;115948.8405115955;117180.41409792897;118129.4093529544;119445;80787.59606201931;105420.47289763502;105918;106103.93896061095;107819;8993.775155621162;9175.702285700256;9214.401063930824;9282.489463079595;9412.105849944244;45687;58152.70923645355;58331.4166858326;59952.70023649854;60484.092738609834;78338;82005;86523;87210.5639471824;89926.55036724775;12147.574834880737;12494.312812795384;13512.932435338154;13563;13754.174749515061;12204.75590488203;13204;15769.842301576837;15972.68054638924;16119.032858028555;12766.17019893704;13839.515616953358;14277.643058923195;14799.556013319618;14957.027793193407;11689.941550292195;14171.64570885736;14478.27608619586;14844.7773283403;14961.102333860003;13467.797983030458;13995.16029038261;13995.51015714445;14499.420023198954;14672.633184170481;10907.29102608328;11394;11550.88449115498;11839.230450021065;12131.940756476337;10268.435236062089;10524;11275.36507206467;11326.546938122712;11832.408379580815 17:14:22 INFO - PROCESS | 11933 | __end_tp_report 17:14:22 INFO - PROCESS | 11933 | __start_cc_report 17:14:22 INFO - PROCESS | 11933 | _x_x_mozilla_cycle_collect,417 17:14:22 INFO - PROCESS | 11933 | __end_cc_report 17:14:22 INFO - PROCESS | 11933 | __startTimestamp1470788062356__endTimestamp 17:14:22 INFO - PROCESS | 11933 | 17:14:22 INFO - PROCESS | 11933 | ------- Summary: start ------- 17:14:22 INFO - PROCESS | 11933 | Number of tests: 6 17:14:22 INFO - PROCESS | 11933 | 17:14:22 INFO - PROCESS | 11933 | [#0] dojo.html Cycles:165 Average:5799.27 Median:6092.76 stddev:686.29 (11.3%) stddev-sans-first:648.07 17:14:22 INFO - PROCESS | 11933 | Values: 2844.4 3363.0 3407.2 3436.7 3443.9 5678.3 5681.9 5771.9 5774.3 5810.5 4410.4 5714.3 5756.3 5821.6 5889.1 5161.8 5262.9 5282.4 5341.0 5375.9 5396.4 5411.8 5427.8 5452.0 5468.7 5175.7 5214.8 5287.9 5303.9 5345.4 5219.4 5224.2 5229.4 5245.6 5291.7 5167.8 5223.2 5251.1 5314.3 5326.8 5575.6 5708.3 5792.5 5832.7 5865.2 6254.8 6261.2 6290.9 6298.2 6312.4 6296.3 6301.1 6307.9 6311.4 6326.8 5787.8 5901.0 5930.9 5931.2 5980.6 6393.4 6403.3 6411.0 6413.1 6429.8 6245.2 6263.2 6270.4 6275.5 6277.6 6148.4 6190.5 6218.6 6219.6 6313.3 6242.9 6274.2 6281.2 6295.6 6297.6 5165.5 6275.2 6280.5 6285.5 6319.8 4925.1 4926.9 4977.6 5012.7 5015.5 3650.4 4324.1 4485.3 4493.9 4531.5 5831.3 5909.6 5945.3 5954.4 5992.6 6201.6 6206.8 6221.9 6254.7 6279.2 5981.1 5986.6 5995.8 6005.4 6022.4 5505.4 5522.1 5556.2 5577.6 5579.1 5263.9 6336.0 6363.9 6495.9 6501.8 6263.6 6285.4 6290.8 6295.0 6304.2 6413.6 6416.3 6464.3 6505.4 6514.4 6123.2 6164.8 6210.4 6227.7 6276.8 6285.1 6285.7 6290.6 6298.0 6301.7 6234.3 6239.8 6248.4 6250.3 6268.1 5415.2 6082.4 6117.4 6145.7 6228.0 4944.8 6107.3 6118.0 6136.9 6144.3 6092.8 6221.0 6239.0 6245.4 6291.4 5964.4 6058.2 6095.3 6135.6 6142.0 17:14:22 INFO - PROCESS | 11933 | 17:14:22 INFO - PROCESS | 11933 | [#1] ext.html Cycles:180 Average:69049.61 Median:39563.00 stddev:156722.82 (396.1%) stddev-sans-first:157077.86 17:14:22 INFO - PROCESS | 11933 | Values: 459.6 517.5 537.0 548.2 556.2 29722.6 40291.6 40390.8 40508.8 40707.2 41396.0 41790.4 41803.8 41979.8 42003.9 7479.1 7934.0 8026.3 8038.8 8039.6 9659.7 9748.1 9748.5 9758.9 9769.2 9727.4 9742.7 9773.3 9775.0 9783.2 9682.8 9699.7 9713.6 9743.0 9753.2 9636.2 9672.2 9719.7 9746.6 9747.9 39491.0 39694.2 39739.6 39912.4 39925.8 3075.5 3244.1 3278.8 3282.0 3508.8 29353.3 29682.0 30237.2 30401.5 31030.5 3090.8 3110.2 3124.2 3137.6 3232.3 434783.0 447143.0 447273.0 448631.0 452859.0 32557.8 32783.8 32859.2 32896.0 33077.7 33564.2 33724.3 34051.0 35049.6 35127.0 16348.2 16389.3 16456.9 16561.7 16566.9 10503.5 12761.7 12765.7 12790.7 12806.6 15105.9 18479.4 18725.5 18791.8 18819.5 6573.3 7169.0 8035.2 8060.6 8076.5 904.7 923.9 997.3 1018.9 1067.1 22726.5 30349.1 30712.7 30743.0 31157.8 978.2 1014.0 1093.3 1116.6 1173.3 15626.8 15846.8 15976.6 16073.0 16137.3 701796.0 706980.0 709201.0 709671.0 710780.0 49669.0 58747.7 58866.1 58935.0 59640.0 1346.8 1396.5 1408.7 1414.6 1415.1 29282.0 29813.0 29854.6 30522.8 30694.1 49146.3 49301.3 49340.0 49361.8 49374.8 567293.0 569905.0 570222.0 570303.0 571217.0 26093.3 26613.6 26930.2 26978.5 27053.7 46399.1 46487.8 47316.5 47553.0 47676.0 38839.8 39206.2 39208.8 39777.5 40229.2 38557.6 39137.8 39342.2 39635.0 39923.0 38011.4 38852.8 39679.2 39884.0 40125.2 30733.7 33922.3 34541.3 35153.0 36079.3 23268.7 26001.7 26557.1 26662.5 26912.6 17:14:22 INFO - PROCESS | 11933 | 17:14:22 INFO - PROCESS | 11933 | [#2] jquery.html Cycles:180 Average:33258.72 Median:2092.35 stddev:93175.32 (4453.1%) stddev-sans-first:93403.96 17:14:22 INFO - PROCESS | 11933 | Values: 362.7 372.2 375.5 387.5 398.6 19296.5 20658.7 21153.8 21179.7 21275.4 17621.1 17880.5 18264.5 21089.5 21182.3 4868.4 4961.9 5083.1 5821.9 5870.6 3797.2 5454.3 5923.0 5923.9 5925.1 6232.3 6507.5 6558.1 6620.5 6631.8 5945.7 5952.9 6007.6 6236.0 6596.2 5628.5 5678.3 5765.7 5770.2 5782.3 9874.0 11958.7 12577.5 13209.3 13322.7 2170.5 2171.7 2339.5 2419.6 2543.2 7078.6 7492.1 9647.4 9957.2 10027.7 1516.9 1860.7 1894.7 1894.9 1924.2 119063.4 119348.0 123465.4 124890.0 125160.0 8801.3 9757.4 11051.6 11060.6 11097.7 13893.2 13929.6 13949.9 13989.4 14129.0 6431.3 8025.6 8111.8 8150.7 8463.2 7726.9 7861.4 8286.1 8472.0 8479.0 4369.3 4377.5 4398.4 4407.8 4488.1 1258.8 1895.5 1914.2 1933.2 1940.9 875.8 915.7 930.6 937.8 985.0 19822.4 20650.5 20953.5 20961.4 21037.7 745.5 939.7 949.8 1003.7 1033.9 10674.1 11001.8 11129.4 11156.7 11181.7 460036.0 564994.0 575187.0 576191.0 584468.0 120045.0 122520.0 124117.4 124739.0 130604.7 959.3 995.3 1000.6 1000.8 1010.5 14441.6 18334.2 18554.7 18595.8 18986.4 53226.7 53244.0 54972.0 55327.9 56483.7 82258.0 82277.6 83023.0 83678.7 84107.1 7700.9 7785.5 7839.1 7876.3 7885.8 8825.7 8916.6 9836.8 11387.0 12245.6 6092.6 9877.7 10978.6 11181.7 11204.8 10234.4 10714.9 10827.0 11051.4 11067.6 10031.7 10243.0 10301.3 11152.2 11498.0 6474.5 6710.5 6894.2 7830.3 8035.7 8827.7 10798.7 11136.1 11155.8 11181.9 17:14:22 INFO - PROCESS | 11933 | 17:14:22 INFO - PROCESS | 11933 | [#3] mootools.html Cycles:180 Average:5646.28 Median:4908.53 stddev:3161.21 (64.4%) stddev-sans-first:3153.22 17:14:22 INFO - PROCESS | 11933 | Values: 1302.4 1522.9 1690.6 1855.9 1870.7 7865.3 7989.8 8349.1 8903.4 8908.1 8446.2 8671.5 8697.9 8712.6 8725.4 2314.4 2344.8 2360.0 2364.6 2373.3 2329.6 2331.7 2377.5 2377.5 2389.0 2333.5 2346.1 2353.8 2358.1 2363.3 1916.9 2321.8 2349.3 2352.2 2357.1 2337.9 2338.1 2344.2 2344.7 2347.8 7445.4 8761.5 8778.3 8828.0 8840.8 5131.5 5236.5 5314.7 5316.6 5351.1 3356.1 3439.9 3541.5 3584.2 3586.2 1046.4 1078.5 1087.5 1089.9 1102.9 10527.2 11437.3 11515.5 11516.5 11549.0 4319.2 4483.0 4721.4 4745.3 4759.0 8328.5 9765.4 9862.6 9870.3 9881.0 5311.6 5315.1 5316.1 5316.8 5346.0 4356.3 4696.7 4815.6 4840.4 4904.1 3846.9 3935.8 3952.1 3953.6 4031.7 1253.2 1260.6 1262.3 1271.2 1278.5 914.0 927.1 937.4 949.7 997.7 5147.0 5766.0 5911.7 5959.4 6176.5 332.9 382.2 427.7 428.5 441.5 3692.5 3787.0 4045.2 4050.7 4137.8 8800.4 10215.1 10647.4 10714.9 10781.4 10306.3 10432.3 10668.7 10692.9 10722.0 7914.5 8180.3 8265.7 8281.6 8289.4 5019.7 5392.0 6131.1 6137.5 6149.4 9917.5 9993.3 10012.6 10059.3 10071.0 9668.0 10111.3 10113.5 10139.4 10168.7 6842.2 7239.2 7373.2 7463.5 7634.7 8405.1 8470.8 8497.7 8499.0 8507.6 7485.3 7633.6 7642.5 7731.4 7736.6 6275.3 7335.1 7416.6 7528.4 7591.4 6999.3 7015.9 7084.7 7103.1 7109.3 4913.0 4999.5 5027.0 5116.2 5163.5 5080.6 5107.7 5138.5 5201.1 5251.2 17:14:22 INFO - PROCESS | 11933 | 17:14:22 INFO - PROCESS | 11933 | [#4] prototype.html Cycles:180 Average:4564.89 Median:4879.43 stddev:1457.42 (29.9%) stddev-sans-first:1425.89 17:14:22 INFO - PROCESS | 11933 | Values: 298.5 306.3 311.2 315.4 318.7 4607.8 5250.7 5584.3 5655.6 5656.9 5357.8 5468.7 5510.9 5532.2 5540.5 3612.7 4079.8 4160.8 4234.7 4292.8 4134.5 4177.9 4211.7 4290.8 4297.2 3407.3 4155.9 4184.6 4208.4 4224.8 3408.8 3629.8 4169.5 4191.4 4216.0 3248.3 3660.7 3671.4 3675.6 3681.4 4304.4 5053.3 5224.9 5243.0 5260.9 4770.2 4786.2 4821.3 4823.6 4857.6 5830.3 5844.2 5850.5 5922.8 5940.7 3276.7 3510.1 3807.5 3861.7 3894.4 4873.0 5606.7 5717.2 6084.0 6092.2 3015.9 3761.0 3943.0 3986.8 4007.9 3759.2 3875.9 3975.3 4026.4 4035.7 4114.3 4522.6 4605.9 4715.0 4760.8 5861.3 5879.7 5905.0 5944.9 6012.8 1189.7 1264.0 1414.7 1438.5 1439.9 898.7 900.5 954.5 983.7 991.6 3907.9 3998.5 4299.2 4450.3 4493.4 4580.7 4977.7 5024.8 5039.9 5082.2 4464.6 4524.8 4537.2 4583.6 4600.0 2444.3 2468.4 2573.6 2650.4 2653.8 4640.1 4766.9 4823.6 5188.6 5209.8 4359.2 4442.7 4782.4 5184.4 5226.5 5599.9 5708.3 5729.6 6332.1 6384.6 6105.4 6115.3 6122.9 6140.8 6142.6 3952.7 5790.5 5890.7 5955.7 6060.2 5992.3 6133.2 6216.7 6230.3 6257.0 3146.9 3353.8 3963.8 3965.9 3985.2 5604.5 5718.4 5937.4 6004.8 6053.0 5795.6 5813.2 6008.0 6017.8 6038.2 4911.4 4993.6 5784.9 5874.7 5916.9 5533.5 5713.7 5728.8 5747.5 5832.4 4885.9 5574.5 5914.1 5955.0 5972.9 5516.0 5759.0 5777.0 5789.2 5868.6 17:14:22 INFO - PROCESS | 11933 | 17:14:22 INFO - PROCESS | 11933 | [#5] yui.html Cycles:180 Average:24150.68 Median:3716.34 stddev:37495.92 (1008.9%) stddev-sans-first:37559.45 17:14:22 INFO - PROCESS | 11933 | Values: 612.1 646.4 696.1 774.2 831.1 15008.0 15110.1 15432.3 15558.1 15606.2 12129.7 14494.5 14587.1 14675.0 14757.6 709.3 869.7 874.5 875.8 879.5 689.7 856.3 870.9 880.1 883.7 901.9 903.8 906.7 909.2 910.6 844.7 868.7 886.0 898.3 903.8 659.6 664.8 670.2 670.8 672.6 15309.2 15359.8 15395.6 15443.2 15491.3 14909.7 14911.5 14983.0 15278.4 15292.5 12029.5 12299.4 12454.1 12567.0 12596.7 3854.0 3865.2 4078.7 4108.0 4112.1 114183.0 117970.0 119260.2 119272.4 120917.0 11438.8 11512.1 11582.7 11591.1 12161.6 24302.4 24305.8 24309.4 24329.3 24424.8 8321.8 8346.3 8372.1 8491.0 8605.8 4537.7 4625.2 4635.8 4662.5 4681.2 3572.6 3713.3 3719.4 3722.3 3730.6 645.2 654.4 674.8 680.5 682.4 578.1 608.8 656.7 665.4 672.1 8955.8 9454.9 9557.8 9649.8 9687.7 610.0 628.6 660.1 665.3 674.3 4521.5 4763.2 4792.3 4844.7 4921.3 132109.0 139395.0 141096.0 141179.0 143713.0 114858.4 115948.8 117180.4 118129.4 119445.0 80787.6 105420.5 105918.0 106103.9 107819.0 8993.8 9175.7 9214.4 9282.5 9412.1 45687.0 58152.7 58331.4 59952.7 60484.1 78338.0 82005.0 86523.0 87210.6 89926.6 12147.6 12494.3 13512.9 13563.0 13754.2 12204.8 13204.0 15769.8 15972.7 16119.0 12766.2 13839.5 14277.6 14799.6 14957.0 11689.9 14171.6 14478.3 14844.8 14961.1 13467.8 13995.2 13995.5 14499.4 14672.6 10907.3 11394.0 11550.9 11839.2 12131.9 10268.4 10524.0 11275.4 11326.5 11832.4 17:14:22 INFO - PROCESS | 11933 | -------- Summary: end -------- 17:14:22 INFO - PROCESS | 11933 | 17:14:22 INFO - TEST-INFO | 11933: exit 0 17:14:22 INFO - TEST-OK | dromaeo_css | took 1114855ms 17:14:22 INFO - TEST-START | kraken 17:14:22 INFO - operating with platform_type : mac_ 17:14:22 INFO - Initialising browser for kraken test... 17:14:22 INFO - TEST-INFO | started process 11937 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/tm/bb1xmxh10h32jsf94bs0tnvh00000w/T/tmpUU639u/profile http://localhost:62071/getInfo.html) 17:14:25 INFO - PROCESS | 11937 | __metrics Screen width/height:1600/1200 17:14:25 INFO - PROCESS | 11937 | colorDepth:24 17:14:25 INFO - PROCESS | 11937 | Browser inner width/height: 1024/663 17:14:25 INFO - PROCESS | 11937 | __metrics 17:14:25 ERROR - PROCESS | 11937 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2983: TypeError: this.tabs is undefined 17:14:26 INFO - TEST-INFO | 11937: exit 0 17:14:26 INFO - Browser initialized. 17:14:26 INFO - Running cycle 1/1 for kraken test... 17:14:26 INFO - TEST-INFO | started process 11939 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/tm/bb1xmxh10h32jsf94bs0tnvh00000w/T/tmpUU639u/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:14:38 INFO - PROCESS | 11939 | RSS: Main: 264482816 17:14:38 INFO - PROCESS | 11939 | 17:14:41 INFO - PROCESS | 11939 | Cycle 1(1): loaded http://localhost:62071/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:62071/tests/kraken/driver.html?testName=audio-beat-detection) 17:14:42 INFO - PROCESS | 11939 | RSS: Main: 274714624 17:14:42 INFO - PROCESS | 11939 | 17:14:44 INFO - PROCESS | 11939 | Cycle 1(1): loaded http://localhost:62071/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:62071/tests/kraken/driver.html?testName=audio-dft) 17:14:45 INFO - PROCESS | 11939 | RSS: Main: 283439104 17:14:45 INFO - PROCESS | 11939 | 17:14:49 INFO - PROCESS | 11939 | Cycle 1(1): loaded http://localhost:62071/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:62071/tests/kraken/driver.html?testName=audio-fft) 17:14:49 INFO - PROCESS | 11939 | RSS: Main: 284839936 17:14:49 INFO - PROCESS | 11939 | 17:14:51 INFO - PROCESS | 11939 | Cycle 1(1): loaded http://localhost:62071/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:62071/tests/kraken/driver.html?testName=audio-oscillator) 17:14:52 INFO - PROCESS | 11939 | RSS: Main: 285274112 17:14:52 INFO - PROCESS | 11939 | 17:14:54 INFO - PROCESS | 11939 | Cycle 1(1): loaded http://localhost:62071/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:62071/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:14:55 INFO - PROCESS | 11939 | RSS: Main: 285552640 17:14:55 INFO - PROCESS | 11939 | 17:14:58 INFO - PROCESS | 11939 | Cycle 1(1): loaded http://localhost:62071/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:62071/tests/kraken/driver.html?testName=imaging-darkroom) 17:14:58 INFO - PROCESS | 11939 | RSS: Main: 285540352 17:14:58 INFO - PROCESS | 11939 | 17:15:01 INFO - PROCESS | 11939 | Cycle 1(1): loaded http://localhost:62071/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:62071/tests/kraken/driver.html?testName=imaging-desaturate) 17:15:02 INFO - PROCESS | 11939 | RSS: Main: 285900800 17:15:02 INFO - PROCESS | 11939 | 17:15:05 INFO - PROCESS | 11939 | Cycle 1(1): loaded http://localhost:62071/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:62071/tests/kraken/driver.html?testName=json-parse-financial) 17:15:06 INFO - PROCESS | 11939 | RSS: Main: 285958144 17:15:06 INFO - PROCESS | 11939 | 17:15:07 INFO - PROCESS | 11939 | Cycle 1(1): loaded http://localhost:62071/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:62071/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:15:08 INFO - PROCESS | 11939 | RSS: Main: 285622272 17:15:08 INFO - PROCESS | 11939 | 17:15:10 INFO - PROCESS | 11939 | Cycle 1(1): loaded http://localhost:62071/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:62071/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:15:10 INFO - PROCESS | 11939 | RSS: Main: 285638656 17:15:10 INFO - PROCESS | 11939 | 17:15:13 INFO - PROCESS | 11939 | Cycle 1(1): loaded http://localhost:62071/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:62071/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:15:13 INFO - PROCESS | 11939 | RSS: Main: 285638656 17:15:13 INFO - PROCESS | 11939 | 17:15:16 INFO - PROCESS | 11939 | Cycle 1(1): loaded http://localhost:62071/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:62071/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:15:17 INFO - PROCESS | 11939 | RSS: Main: 285425664 17:15:17 INFO - PROCESS | 11939 | 17:15:20 INFO - PROCESS | 11939 | Cycle 1(1): loaded http://localhost:62071/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:62071/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:15:21 INFO - PROCESS | 11939 | RSS: Main: 286048256 17:15:21 INFO - PROCESS | 11939 | 17:15:22 INFO - PROCESS | 11939 | Cycle 1(1): loaded http://localhost:62071/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:62071/tests/kraken/driver.html?testName=ai-astar) 17:15:23 INFO - PROCESS | 11939 | RSS: Main: 287375360 17:15:23 INFO - PROCESS | 11939 | 17:15:23 INFO - PROCESS | 11939 | __start_tp_report 17:15:23 INFO - PROCESS | 11939 | _x_x_mozilla_page_load 17:15:23 INFO - PROCESS | 11939 | _x_x_mozilla_page_load_details 17:15:23 INFO - PROCESS | 11939 | |i|pagename|runs| 17:15:23 INFO - PROCESS | 11939 | |0;ai-astar;105;117;106;117;123;172;163;135;115;115 17:15:23 INFO - PROCESS | 11939 | |1;audio-beat-detection;146;110;126;163;110;128;126;137;203;112 17:15:23 INFO - PROCESS | 11939 | |2;audio-dft;198;203;211;252;285;212;279;286;234;194 17:15:23 INFO - PROCESS | 11939 | |3;audio-fft;72;84;92;154;63;60;60;67;137;59 17:15:23 INFO - PROCESS | 11939 | |4;audio-oscillator;70;100;162;104;75;95;125;73;94;102 17:15:23 INFO - PROCESS | 11939 | |5;imaging-gaussian-blur;88;87;89;75;78;74;77;116;134;107 17:15:23 INFO - PROCESS | 11939 | |6;imaging-darkroom;95;96;105;96;96;100;96;111;155;132 17:15:23 INFO - PROCESS | 11939 | |7;imaging-desaturate;91;108;90;90;92;89;92;91;91;91 17:15:23 INFO - PROCESS | 11939 | |8;json-parse-financial;58;58;56;56;60;79;88;48;46;76 17:15:23 INFO - PROCESS | 11939 | |9;json-stringify-tinderbox;68;71;71;77;79;74;69;66;72;74 17:15:23 INFO - PROCESS | 11939 | |10;stanford-crypto-aes;89;86;84;87;84;84;100;109;75;76 17:15:23 INFO - PROCESS | 11939 | |11;stanford-crypto-ccm;139;139;141;148;126;148;136;146;171;164 17:15:23 INFO - PROCESS | 11939 | |12;stanford-crypto-pbkdf2;171;170;169;168;167;169;233;184;168;168 17:15:23 INFO - PROCESS | 11939 | |13;stanford-crypto-sha256-iterative;67;68;67;68;71;67;74;79;67;60 17:15:23 INFO - PROCESS | 11939 | __end_tp_report 17:15:23 INFO - PROCESS | 11939 | __start_cc_report 17:15:23 INFO - PROCESS | 11939 | _x_x_mozilla_cycle_collect,1047 17:15:23 INFO - PROCESS | 11939 | __end_cc_report 17:15:23 INFO - PROCESS | 11939 | __startTimestamp1470788123023__endTimestamp 17:15:23 INFO - PROCESS | 11939 | 17:15:23 INFO - PROCESS | 11939 | ------- Summary: start ------- 17:15:23 INFO - PROCESS | 11939 | Number of tests: 14 17:15:23 INFO - PROCESS | 11939 | 17:15:23 INFO - PROCESS | 11939 | [#0] ai-astar Cycles:10 Average:126.80 Median:120.00 stddev:23.13 (19.3%) stddev-sans-first:23.15 17:15:23 INFO - PROCESS | 11939 | Values: 105.0 117.0 106.0 117.0 123.0 172.0 163.0 135.0 115.0 115.0 17:15:23 INFO - PROCESS | 11939 | 17:15:23 INFO - PROCESS | 11939 | [#1] audio-beat-detection Cycles:10 Average:136.10 Median:132.50 stddev:28.89 (21.8%) stddev-sans-first:30.42 17:15:23 INFO - PROCESS | 11939 | Values: 146.0 110.0 126.0 163.0 110.0 128.0 126.0 137.0 203.0 112.0 17:15:23 INFO - PROCESS | 11939 | 17:15:23 INFO - PROCESS | 11939 | [#2] audio-dft Cycles:10 Average:235.40 Median:243.00 stddev:37.27 (15.3%) stddev-sans-first:37.00 17:15:23 INFO - PROCESS | 11939 | Values: 198.0 203.0 211.0 252.0 285.0 212.0 279.0 286.0 234.0 194.0 17:15:23 INFO - PROCESS | 11939 | 17:15:23 INFO - PROCESS | 11939 | [#3] audio-fft Cycles:10 Average:84.80 Median:65.00 stddev:34.02 (52.3%) stddev-sans-first:35.77 17:15:23 INFO - PROCESS | 11939 | Values: 72.0 84.0 92.0 154.0 63.0 60.0 60.0 67.0 137.0 59.0 17:15:23 INFO - PROCESS | 11939 | 17:15:23 INFO - PROCESS | 11939 | [#4] audio-oscillator Cycles:10 Average:100.00 Median:71.50 stddev:27.50 (38.5%) stddev-sans-first:26.94 17:15:23 INFO - PROCESS | 11939 | Values: 70.0 100.0 162.0 104.0 75.0 95.0 125.0 73.0 94.0 102.0 17:15:23 INFO - PROCESS | 11939 | 17:15:23 INFO - PROCESS | 11939 | [#5] imaging-gaussian-blur Cycles:10 Average:92.50 Median:77.50 stddev:20.13 (26.0%) stddev-sans-first:21.28 17:15:23 INFO - PROCESS | 11939 | Values: 88.0 87.0 89.0 75.0 78.0 74.0 77.0 116.0 134.0 107.0 17:15:23 INFO - PROCESS | 11939 | 17:15:23 INFO - PROCESS | 11939 | [#6] imaging-darkroom Cycles:10 Average:108.20 Median:95.50 stddev:20.03 (21.0%) stddev-sans-first:20.67 17:15:23 INFO - PROCESS | 11939 | Values: 95.0 96.0 105.0 96.0 96.0 100.0 96.0 111.0 155.0 132.0 17:15:23 INFO - PROCESS | 11939 | 17:15:23 INFO - PROCESS | 11939 | [#7] imaging-desaturate Cycles:10 Average:92.50 Median:91.00 stddev:5.52 (6.1%) stddev-sans-first:5.83 17:15:23 INFO - PROCESS | 11939 | Values: 91.0 108.0 90.0 90.0 92.0 89.0 92.0 91.0 91.0 91.0 17:15:23 INFO - PROCESS | 11939 | 17:15:23 INFO - PROCESS | 11939 | [#8] json-parse-financial Cycles:10 Average:62.50 Median:59.00 stddev:13.82 (23.4%) stddev-sans-first:14.56 17:15:23 INFO - PROCESS | 11939 | Values: 58.0 58.0 56.0 56.0 60.0 79.0 88.0 48.0 46.0 76.0 17:15:23 INFO - PROCESS | 11939 | 17:15:23 INFO - PROCESS | 11939 | [#9] json-stringify-tinderbox Cycles:10 Average:72.10 Median:73.00 stddev:4.01 (5.5%) stddev-sans-first:3.97 17:15:23 INFO - PROCESS | 11939 | Values: 68.0 71.0 71.0 77.0 79.0 74.0 69.0 66.0 72.0 74.0 17:15:23 INFO - PROCESS | 11939 | 17:15:23 INFO - PROCESS | 11939 | [#10] stanford-crypto-aes Cycles:10 Average:87.40 Median:84.00 stddev:10.27 (12.2%) stddev-sans-first:10.87 17:15:23 INFO - PROCESS | 11939 | Values: 89.0 86.0 84.0 87.0 84.0 84.0 100.0 109.0 75.0 76.0 17:15:23 INFO - PROCESS | 11939 | 17:15:23 INFO - PROCESS | 11939 | [#11] stanford-crypto-ccm Cycles:10 Average:145.80 Median:147.00 stddev:13.25 (9.0%) stddev-sans-first:13.82 17:15:23 INFO - PROCESS | 11939 | Values: 139.0 139.0 141.0 148.0 126.0 148.0 136.0 146.0 171.0 164.0 17:15:23 INFO - PROCESS | 11939 | 17:15:23 INFO - PROCESS | 11939 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:176.70 Median:169.50 stddev:20.39 (12.0%) stddev-sans-first:21.52 17:15:23 INFO - PROCESS | 11939 | Values: 171.0 170.0 169.0 168.0 167.0 169.0 233.0 184.0 168.0 168.0 17:15:23 INFO - PROCESS | 11939 | 17:15:23 INFO - PROCESS | 11939 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.80 Median:68.00 stddev:5.03 (7.4%) stddev-sans-first:5.29 17:15:23 INFO - PROCESS | 11939 | Values: 67.0 68.0 67.0 68.0 71.0 67.0 74.0 79.0 67.0 60.0 17:15:23 INFO - PROCESS | 11939 | -------- Summary: end -------- 17:15:23 INFO - PROCESS | 11939 | 17:15:23 INFO - TEST-INFO | 11939: exit 0 17:15:23 INFO - TEST-OK | kraken | took 60906ms 17:15:23 INFO - SUITE-END | took 1175s 17:15:24 INFO - Completed test suite (00:19:36) 17:15:24 INFO - javascript benchmark 17:15:24 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7251.50377841166, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2844.360018995725, 3362.9663703362958, 3407.1652445150944, 3436.7250619950405, 3443.879464218752, 5678.318601767794, 5681.8579535511635, 5771.942280577198, 5774.335951365589, 5810.535157187425, 4410.3825464435, 5714.285714285715, 5756.280464941882, 5821.621594596349, 5889.146073819305, 5161.845144645667, 5262.8684282892855, 5282.418933917266, 5340.973295133519, 5375.865603359928, 5396.379416367129, 5411.83764487066, 5427.782888684467, 5452.04589196889, 5468.671879687232, 5175.715335656538, 5214.8174813881715, 5287.894242115136, 5303.946960530384, 5345.358556973169, 5219.42586315505, 5224.190250511177, 5229.424763276036, 5245.606579506552, 5291.656042357273, 5167.844964651029, 5223.242629818655, 5251.08106081438, 5314.282571852789, 5326.76029578666, 5575.581831362664, 5708.286464191976, 5792.536597072224, 5832.737526811304, 5865.178874957509, 6254.781082662085, 6261.217347831521, 6290.87418251637, 6298.244210694746, 6312.400321969406, 6296.307406185316, 6301.08634248036, 6307.905381419282, 6311.431971122575, 6326.810195694136, 5787.797427090031, 5900.970495147497, 5930.911036334458, 5931.169636250928, 5980.581359304851, 6393.424591786761, 6403.295637479873, 6411.0383442484, 6413.102165696806, 6429.807105786834, 6245.156903818017, 6263.154474146023, 6270.372962703693, 6275.497960163176, 6277.5605707600025, 6148.415900489446, 6190.473809726133, 6218.595791273553, 6219.564630475914, 6313.305536390993, 6242.875142497124, 6274.215723034621, 6281.214848143982, 6295.559310848196, 6297.590656607397, 5165.509276618715, 6275.215598050244, 6280.466160376328, 6285.465735412449, 6319.842003949938, 4925.064237794808, 4926.8768280793265, 4977.601791856643, 5012.674176178537, 5015.4733752956145, 3650.3976843821, 4324.070324880103, 4485.282354823213, 4493.910121797546, 4531.501534831166, 5831.300243970666, 5909.6158749681135, 5945.256842894638, 5954.434328738849, 5992.610480318765, 6201.627902325785, 6206.844828879224, 6221.875562488724, 6254.655993920378, 6279.152314437584, 5981.132735753292, 5986.5809393342915, 5995.820125396245, 6005.399460054047, 6022.427869352405, 5505.366882808528, 5522.144067669517, 5556.222128901957, 5577.60559860035, 5579.0515612346, 5263.868403289872, 6335.968320158369, 6363.904541431974, 6495.935040649533, 6501.837454063686, 6263.6241825490615, 6285.43431091204, 6290.842728931813, 6295.0, 6304.211973503312, 6413.647249401328, 6416.262129854939, 6464.256610489854, 6505.381988711065, 6514.381133792472, 6123.160610921377, 6164.753409863555, 6210.4100110489435, 6227.719752611053, 6276.811695649138, 6285.057241413641, 6285.748570057147, 6290.559660823881, 6298.02380631003, 6301.684915754286, 6234.3453937337745, 6239.844003899939, 6248.4376406123665, 6250.343713910156, 6268.059791031382, 5415.241866138823, 6082.3613520581475, 6117.388261174025, 6145.66198859067, 6228.03465462854, 4944.777485013111, 6107.3331742623295, 6117.979653188475, 6136.8772624548155, 6144.293406258337, 6092.75628974836, 6220.968895155495, 6239.001759718423, 6245.406686364788, 6291.402316779899, 5964.433378829004, 6058.242719660043, 6095.299040610209, 6135.631862088289, 6141.969290153521], "value": 5754.1545324052595, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [459.5886681420131, 517.5135372749615, 536.9677819330841, 548.2105767694522, 556.212958663491, 29722.554161687563, 40291.59708402915, 40390.79804600977, 40508.797456012755, 40707.18585628286, 41395.96510087249, 41790.37314440278, 41803.79098104513, 41979.790101049526, 42003.94990125248, 7479.102507699084, 7934.008248968893, 8026.317762990153, 8038.839223215532, 8039.598020098972, 9659.71020869375, 9748.073932976356, 9748.463834489101, 9758.853617195748, 9769.218462522982, 9727.416355018686, 9742.707718768448, 9773.315867889216, 9775.022497750204, 9783.168430683401, 9682.806343873153, 9699.709008729715, 9713.562889669947, 9742.976987416361, 9753.21974242066, 9636.180924621416, 9672.226221902301, 9719.708408747749, 9746.561404736804, 9747.90252097477, 39491.0, 39694.20611587781, 39739.60260397388, 39912.401313980314, 39925.80037099825, 3075.507918732992, 3244.124086496656, 3278.7540934429776, 3281.96718032819, 3508.7894676336623, 29353.266168345963, 29682.0, 30237.244068898235, 30401.543976840367, 31030.453697949037, 3090.7836451448406, 3110.1758034120976, 3124.234562532194, 3137.576427182347, 3232.3050544133125, 434783.0, 447143.0, 447273.0, 448631.0, 452858.9999999967, 32557.837210813796, 32783.83608081944, 32859.17852053718, 32896.0, 33077.66922330794, 33564.16089597731, 33724.32551349008, 34051.0, 35049.64950350515, 35127.0, 16348.182590870409, 16389.34442622282, 16456.917715411346, 16561.66876662484, 16566.92314999521, 10503.474826258656, 12761.744765104831, 12765.680857978625, 12790.68023299425, 12806.61580152597, 15105.924470377578, 18479.353222637143, 18725.531861703566, 18791.81208187928, 18819.529511762317, 6573.3426657333885, 7169.0, 8035.196480352035, 8060.596970151469, 8076.515409075357, 904.7150147703452, 923.8959443464995, 997.2769741937037, 1018.8777346718293, 1067.1356201476829, 22726.545469090855, 30349.089527314216, 30712.692873070984, 30743.0, 31157.8442107788, 978.1538968791943, 1014.0265345268477, 1093.327603523843, 1116.6147679050714, 1173.2901594535354, 15626.76559851603, 15846.841531584767, 15976.600584985468, 16073.0, 16137.273822678007, 701796.0, 706980.0, 709201.0, 709671.0, 710780.0, 49669.0, 58747.70626146842, 58866.11700824491, 58935.0, 59640.0, 1346.8181795457683, 1396.4693416501868, 1408.704172123845, 1414.6463384153963, 1415.0589857744485, 29282.0, 29813.0, 29854.552181717725, 30522.84738576293, 30694.079177624706, 49146.26280605865, 49301.2604810921, 49340.0, 49361.753191233816, 49374.753126234136, 567293.0, 569905.0, 570222.0, 570303.0, 571217.0, 26093.347666308495, 26613.600795988463, 26930.192094237205, 26978.46043079088, 27053.72946270512, 46399.07201856012, 46487.76756116198, 47316.52683473259, 47553.04893902172, 47676.0, 38839.8348049559, 39206.215875682894, 39208.80395598004, 39777.54369499073, 40229.19541609093, 38557.614423856525, 39137.80431097826, 39342.2131557373, 39635.009124772114, 39923.0, 38011.42982855204, 38852.80573597114, 39679.2064158721, 39884.0, 40125.197496050496, 30733.69266307308, 33922.3215535683, 34541.30917381689, 35153.0, 36079.27841443209, 23268.650970235798, 26001.73998259993, 26557.07050253232, 26662.46675066449, 26912.596311055742], "value": 19213.096310419656, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [362.7370156636437, 372.1774877520678, 375.45746396457116, 387.4943199125141, 398.63524874739613, 19296.51758706033, 20658.690119648218, 21153.788462115375, 21179.68230476542, 21275.36173914785, 17621.11894405281, 17880.46358609244, 18264.543386415313, 21089.47276318089, 21182.25862094827, 4868.440129385131, 4961.925571116436, 5083.110455670261, 5821.912671309934, 5870.589058765888, 3797.2025874566234, 5454.263674403965, 5922.97038514809, 5923.911141332884, 5925.111233314994, 6232.345603711613, 6507.51193660475, 6558.1474408327085, 6620.470362370998, 6631.801045968628, 5945.702714864283, 5952.9107063394085, 6007.639541627516, 6235.968820155893, 6596.208454985408, 5628.493435590816, 5678.346990096109, 5765.740541675635, 5770.2210201622665, 5782.306123265193, 9873.950630246803, 11958.701032474171, 12577.496900123984, 13209.273489958048, 13322.666933326647, 2170.511634882155, 2171.739391273057, 2339.4619237575284, 2419.552382809186, 2543.2497413262945, 7078.610676412795, 7492.1384040835455, 9647.421154730739, 9957.203423726085, 10027.74930626733, 1516.9469068582546, 1860.692985657365, 1894.7157926311027, 1894.9052547372714, 1924.191839427444, 119063.40468297689, 119348.0, 123465.38267308696, 124890.0, 125160.0, 8801.25189358899, 9757.414555126716, 11051.557937682403, 11060.612878549213, 11097.722556936142, 13893.235872026933, 13929.58211253664, 13949.930250348887, 13989.440422382992, 14129.0, 6431.324710905287, 8025.598720063974, 8111.75664730059, 8150.7147249845975, 8463.15368463161, 7726.884096738553, 7861.449698521163, 8286.088530261666, 8472.0, 8478.957605211934, 4369.3227549729845, 4377.518472967971, 4398.362237475548, 4407.823687052482, 4488.102379524043, 1258.811178323259, 1895.4787433455633, 1914.2343062774723, 1933.178399180371, 1940.8835469871854, 875.7810547363159, 915.7317115794539, 930.5533343994921, 937.7561833923093, 984.9556769945369, 19822.439539318577, 20650.483737906674, 20953.476163096046, 20961.37115886526, 21037.68443473349, 745.5005146551823, 939.7086903060073, 949.8337790886567, 1003.7390278527636, 1033.94313312767, 10674.14606831467, 11001.834972475419, 11129.387883666313, 11156.721081973015, 11181.720456988478, 460036.0, 564994.0, 575187.0, 576191.0, 584468.0, 120045.0, 122520.0, 124117.37941310236, 124739.0, 130604.69395306116, 959.2661613865398, 995.328153496387, 1000.5841733946385, 1000.7748256642197, 1010.4543546484963, 14441.566752997427, 18334.174962127003, 18554.721679174552, 18595.81404185941, 18986.43040708781, 53226.73386633197, 53244.0, 54972.0, 55327.89344213174, 56483.71758141183, 82258.0, 82277.58861205656, 83023.0, 83678.74481882656, 84107.06485048328, 7700.8844867325915, 7785.532868027936, 7839.09850367215, 7876.3305119063225, 7885.763427096967, 8825.735227943173, 8916.598753055998, 9836.819581650248, 11386.975172234539, 12245.571405000783, 6092.5682464619895, 9877.703668889944, 10978.560857565928, 11181.664550063511, 11204.831927521256, 10234.437105959243, 10714.89285107139, 10827.0, 11051.447427628425, 11067.557297708001, 10031.749206269902, 10242.975702429698, 10301.330413523097, 11152.16358773079, 11498.0, 6474.514411419068, 6710.463162946855, 6894.207166175754, 7830.256125668053, 8035.718749843727, 8827.69103081389, 10798.67603971882, 11136.053435457752, 11155.832662509907, 11181.888181118411], "value": 9078.535491102539, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1302.394386610226, 1522.9314680839361, 1690.5689049292437, 1855.85153187745, 1870.6819840627093, 7865.331446827012, 7989.840203195932, 8349.123342049088, 8903.421277616959, 8908.10918908109, 8446.197611226939, 8671.523066231355, 8697.913020869806, 8712.564371781402, 8725.432846864966, 2314.4098254944965, 2344.753800850912, 2359.95280094398, 2364.6216605343147, 2373.2761507740133, 2329.5923213437663, 2331.720193576773, 2377.476955069882, 2377.524495100978, 2388.9761102389016, 2333.4516388648653, 2346.120204923154, 2353.752855950126, 2358.1392791631015, 2363.314638754759, 1916.8562357823218, 2321.802646775026, 2349.330440824374, 2352.1649814315842, 2357.0807385119815, 2337.906483740648, 2338.1232037985756, 2344.2146880794953, 2344.6717459555675, 2347.835651504395, 7445.367143792784, 8761.474311541328, 8778.341624378198, 8827.955860220658, 8840.778980525474, 5131.512506311894, 5236.450172731847, 5314.654547454403, 5316.627836051478, 5351.09031464652, 3356.1441832332844, 3439.8992322456825, 3541.451075083366, 3584.2473080653094, 3586.193106551031, 1046.440154517337, 1078.4553800330782, 1087.4617064553017, 1089.9182561307855, 1102.8841971592947, 10527.210459215514, 11437.313761174357, 11515.481803318871, 11516.481758320895, 11549.0, 4319.222539942841, 4482.9775851121185, 4721.386219791474, 4745.2882067690125, 4759.048190361941, 8328.500289982621, 9765.414075155371, 9862.556184971694, 9870.25973052024, 9880.95059524712, 5311.575073994071, 5315.149576067888, 5316.0962636351915, 5316.787328506816, 5345.9732701337025, 4356.28121359972, 4696.694714843524, 4815.590674792612, 4840.419149701988, 4904.092742842586, 3846.8845934622004, 3935.7835319057726, 3952.130531283113, 3953.6046395360236, 4031.717779755389, 1253.2355263289387, 1260.571405722059, 1262.2615769774602, 1271.213944408108, 1278.514164617458, 913.9908600913906, 927.1146055516965, 937.3672770879629, 949.6752030916832, 997.6657819630506, 5146.974265128725, 5765.971170144123, 5911.674857882857, 5959.433853783884, 6176.505879529627, 332.9217633856042, 382.15734305856074, 427.74335398760496, 428.50507663648534, 441.5474139007543, 3692.538432695913, 3786.9621303786607, 4045.1707399982934, 4050.6632811172244, 4137.77242251673, 8800.38397312182, 10215.131713804261, 10647.414392208348, 10714.946425267979, 10781.407022613676, 10306.278560500843, 10432.269741118049, 10668.679939601825, 10692.89307106919, 10722.0, 7914.485558438683, 8180.263776260046, 8265.669373225124, 8281.627326770309, 8289.378296627656, 5019.7239151847, 5392.0, 6131.141640170469, 6137.478314343331, 6149.354317796567, 9917.504124793588, 9993.250506211918, 10012.64955726546, 10059.29584929048, 10071.043250891154, 9668.0, 10111.292209545261, 10113.544890480092, 10139.442330671589, 10168.745781355525, 6842.178938527409, 7239.203687594466, 7373.18894921569, 7463.477556571205, 7634.6946122154495, 8405.07544170153, 8470.788230294293, 8497.702580409656, 8499.0, 8507.574621268788, 7485.251474852689, 7633.580153091411, 7642.465027448247, 7731.381489480716, 7736.613169341623, 6275.309715931336, 7335.1197856257595, 7416.629168541659, 7528.397728181622, 7591.3547348475995, 6999.300069993164, 7015.894761578683, 7084.716611335489, 7103.076600041962, 7109.28907109285, 4912.975435122801, 4999.500049994971, 5027.0, 5116.155834287301, 5163.509466600667, 5080.644354895122, 5107.719075450886, 5138.511841375063, 5201.141811601195, 5251.186066159751], "value": 4464.786086902246, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [298.49852248222993, 306.2832970848215, 311.1769370016307, 315.4212020941572, 318.6876860676537, 4607.834317870604, 5250.737463126848, 5584.301962254718, 5655.604107712456, 5656.943430565693, 5357.812476563311, 5468.72656367181, 5510.9448905510935, 5532.225488431623, 5540.473655002778, 3612.674859262666, 4079.775612341335, 4160.812763425645, 4234.661227101825, 4292.840932948102, 4134.490910817545, 4177.871974566865, 4211.705180637341, 4290.785460726951, 4297.247981603223, 3407.318536292739, 4155.854545090922, 4184.581541845821, 4208.4318616986775, 4224.753697659183, 3408.812515311657, 3629.800360980145, 4169.541350451463, 4191.392248124005, 4216.0, 3248.3016151527536, 3660.707143428546, 3671.4125739881492, 3675.558932928039, 3681.355762741536, 4304.352823013824, 5053.292539044537, 5224.895502089975, 5242.973785131088, 5260.894782104375, 4770.187328815028, 4786.1863483207935, 4821.275979071813, 4823.614110871122, 4857.587105096071, 5830.30036395631, 5844.1818145459665, 5850.473457388813, 5922.792702255443, 5940.702964851784, 3276.6559511251453, 3510.069831494656, 3807.5430948286107, 3861.7296789224765, 3894.4227587826977, 4873.0, 5606.747696353633, 5717.2281741965135, 6084.0, 6092.238470191226, 3015.9246018849703, 3760.9657344230554, 3942.9605703943166, 3986.80065996699, 4007.937896457441, 3759.2293579816073, 3875.903102422462, 3975.34406822871, 4026.375911733686, 4035.6973227008093, 4114.300568903293, 4522.615577675869, 4605.868009753332, 4715.0, 4760.7619619018915, 5861.267341582302, 5879.706014699248, 5905.0, 5944.940550594439, 6012.7895523657335, 1189.714468527547, 1263.9557615483598, 1414.6604814844363, 1438.4605772835187, 1439.9496017639333, 898.6989358564823, 900.5366279795333, 954.4702690006974, 983.7491439682835, 991.6033586565432, 3907.902302442462, 3998.4801975742967, 4299.1831552005015, 4450.310201918708, 4493.393391892118, 4580.725156490621, 4977.701337919736, 5024.809246128734, 5039.874003149877, 5082.186850103965, 4464.566811087965, 4524.796384162721, 4537.164272329794, 4583.564561366665, 4599.954000460019, 2444.278937713379, 2468.4445999649934, 2573.597389422769, 2650.4169082801754, 2653.841928105548, 4640.076751646441, 4766.928496072562, 4823.5658790709, 5188.558972487305, 5209.843704688866, 4359.215341238608, 4442.68901176921, 4782.378290822171, 5184.429712731597, 5226.529612334832, 5599.916001259984, 5708.286464191976, 5729.5702822288495, 6332.100369888923, 6384.648844313608, 6105.358937311518, 6115.330801519053, 6122.94881214798, 6140.846478838065, 6142.6314421134875, 3952.6837852971116, 5790.539020916178, 5890.705464726832, 5955.6724380157775, 6060.212172417558, 5992.250968628921, 6133.202683651097, 6216.658083805434, 6230.314665386713, 6256.968715156395, 3146.9370612588077, 3353.782004169721, 3963.781991990468, 3965.900852478711, 3985.202959408072, 5604.523615492729, 5718.370979192368, 5937.435943585352, 6004.759809607567, 6052.969735151472, 5795.565332599987, 5813.244278243801, 6007.996001999, 6017.759289628366, 6038.215032045981, 4911.4106307243355, 4993.600511958962, 5784.929787989236, 5874.706264686834, 5916.940830591639, 5533.529649979797, 5713.657180569179, 5728.770849166153, 5747.48272655463, 5832.383921968407, 4885.853424397274, 5574.526165275997, 5914.083317085859, 5954.9578823704815, 5972.850678733066, 5515.972420137874, 5759.0, 5777.0, 5789.234283543559, 5868.559858010581], "value": 4109.041712394833, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [612.1124369663988, 646.382704517186, 696.088124556831, 774.1561697749455, 831.0567505880825, 15008.02447840891, 15110.093394396345, 15432.30554625043, 15558.06651600902, 15606.219689015546, 12129.696757581065, 14494.492692755755, 14587.12477251363, 14675.0, 14757.557273281818, 709.2588245283665, 869.6695255802817, 874.470945078228, 875.8248350329959, 879.5250564695057, 689.6999805084779, 856.297835774665, 870.9433886797337, 880.0759202837028, 883.6862913665652, 901.8602116671926, 903.8373092843285, 906.714384968736, 909.2135302962955, 910.5856835140029, 844.7170197983683, 868.68727258187, 886.0297973718767, 898.3127907151035, 903.8373092843285, 659.6404959297195, 664.7872680742164, 670.2158474584747, 670.7585269303047, 672.6166085331363, 15309.157996310198, 15359.769603455845, 15395.61510962235, 15443.227838608136, 15491.302891369915, 14909.701805963929, 14911.478098266618, 14983.02610330336, 15278.38886444552, 15292.464763733327, 12029.51881924722, 12299.385030748515, 12454.065945054066, 12567.0, 12596.748065038739, 3853.9614603853884, 3865.246276975991, 4078.6940979426663, 4107.958920410788, 4112.074783173792, 114183.0, 117970.0, 119260.21109683362, 119272.40363798212, 120917.0, 11438.828417573743, 11512.079033677286, 11582.6525204244, 11591.130665200144, 12161.635150945485, 24302.39244018878, 24305.756942430704, 24309.39226519351, 24329.27012189637, 24424.75575244225, 8321.750347489586, 8346.290565301895, 8372.079071302152, 8491.0, 8605.827883442296, 4537.705049171794, 4625.167469855458, 4635.791389387486, 4662.53374662531, 4681.157391669532, 3572.6070132285427, 3713.2759111972905, 3719.4048952167523, 3722.3299806035175, 3730.5896351401325, 645.1612903225788, 654.4404534123352, 674.7874419557824, 680.5100327764002, 682.4063065133266, 578.0866231354449, 608.8295277322356, 656.6815094679076, 665.364576829127, 672.0960308385214, 8955.776105597412, 9454.871309802305, 9557.808843823084, 9649.758756031015, 9687.70936871895, 609.9664518451527, 628.5694299404922, 660.0758937487556, 665.3246954341347, 674.3369599221427, 4521.547845215518, 4763.214069678534, 4792.305115758265, 4844.709317440965, 4921.26181072842, 132109.0, 139395.0, 141096.0, 141179.0, 143713.0, 114858.4257078726, 115948.8405115955, 117180.41409792897, 118129.4093529544, 119445.0, 80787.59606201931, 105420.47289763502, 105918.0, 106103.93896061095, 107819.0, 8993.775155621162, 9175.702285700256, 9214.401063930824, 9282.489463079595, 9412.105849944244, 45687.0, 58152.70923645355, 58331.4166858326, 59952.70023649854, 60484.092738609834, 78338.0, 82005.0, 86523.0, 87210.5639471824, 89926.55036724775, 12147.574834880737, 12494.312812795384, 13512.932435338154, 13563.0, 13754.174749515061, 12204.75590488203, 13204.0, 15769.842301576837, 15972.68054638924, 16119.032858028555, 12766.17019893704, 13839.515616953358, 14277.643058923195, 14799.556013319618, 14957.027793193407, 11689.941550292195, 14171.64570885736, 14478.27608619586, 14844.7773283403, 14961.102333860003, 13467.797983030458, 13995.16029038261, 13995.51015714445, 14499.420023198954, 14672.633184170481, 10907.29102608328, 11394.0, 11550.88449115498, 11839.230450021065, 12131.940756476337, 10268.435236062089, 10524.0, 11275.36507206467, 11326.546938122712, 11832.408379580815], "value": 7895.652980044765, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1589.6, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 117.0, 106.0, 117.0, 123.0, 172.0, 163.0, 135.0, 115.0, 115.0], "value": 126.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 110.0, 126.0, 163.0, 110.0, 128.0, 126.0, 137.0, 203.0, 112.0], "value": 136.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [198.0, 203.0, 211.0, 252.0, 285.0, 212.0, 279.0, 286.0, 234.0, 194.0], "value": 235.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 84.0, 92.0, 154.0, 63.0, 60.0, 60.0, 67.0, 137.0, 59.0], "value": 84.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 100.0, 162.0, 104.0, 75.0, 95.0, 125.0, 73.0, 94.0, 102.0], "value": 100.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 87.0, 89.0, 75.0, 78.0, 74.0, 77.0, 116.0, 134.0, 107.0], "value": 92.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 105.0, 96.0, 96.0, 100.0, 96.0, 111.0, 155.0, 132.0], "value": 108.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 108.0, 90.0, 90.0, 92.0, 89.0, 92.0, 91.0, 91.0, 91.0], "value": 92.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 58.0, 56.0, 56.0, 60.0, 79.0, 88.0, 48.0, 46.0, 76.0], "value": 62.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 71.0, 71.0, 77.0, 79.0, 74.0, 69.0, 66.0, 72.0, 74.0], "value": 72.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 86.0, 84.0, 87.0, 84.0, 84.0, 100.0, 109.0, 75.0, 76.0], "value": 87.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 139.0, 141.0, 148.0, 126.0, 148.0, 136.0, 146.0, 171.0, 164.0], "value": 145.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 170.0, 169.0, 168.0, 167.0, 169.0, 233.0, 184.0, 168.0, 168.0], "value": 176.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 67.0, 68.0, 71.0, 67.0, 74.0, 79.0, 67.0, 60.0], "value": 68.8, "unit": "score"}]}]} 17:15:24 INFO - Return code: 0 17:15:24 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 17:15:24 ERROR - # TBPL SUCCESS # 17:15:24 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 17:15:24 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 17:15:24 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 17:15:24 INFO - 2016-08-09 17:15:24.347 screenresolution[11944:236980] starting screenresolution argv=screenresolution get 17:15:24 INFO - 2016-08-09 17:15:24.350 screenresolution[11944:236980] Display 0: 1600x1200x32@60 17:15:24 INFO - 2016-08-09 17:15:24.356 screenresolution[11945:236983] starting screenresolution argv=screenresolution list 17:15:24 INFO - Available Modes on Display 0 17:15:24 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 17:15:24 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 17:15:24 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 17:15:24 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 17:15:24 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 17:15:24 INFO - Intel Iris: 17:15:24 INFO - Chipset Model: Intel Iris 17:15:24 INFO - Type: GPU 17:15:24 INFO - Bus: Built-In 17:15:24 INFO - VRAM (Dynamic, Max): 1536 MB 17:15:24 INFO - Vendor: Intel (0x8086) 17:15:24 INFO - Device ID: 0x0a2e 17:15:24 INFO - Revision ID: 0x0009 17:15:24 INFO - Displays: 17:15:24 INFO - Display: 17:15:24 INFO - Resolution: 1600 x 1200 @ 60 Hz 17:15:24 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 17:15:24 INFO - Display Serial Number: 1600x1200 60 17:15:24 INFO - Main Display: Yes 17:15:24 INFO - Mirror: Off 17:15:24 INFO - Online: Yes 17:15:24 INFO - Rotation: Supported 17:15:24 INFO - Return code: 0 17:15:24 INFO - Running post-action listener: _resource_record_post_action 17:15:24 INFO - [mozharness: 2016-08-10 00:15:24.592222Z] Finished run-tests step (success) 17:15:24 INFO - Running post-run listener: _resource_record_post_run 17:15:24 INFO - Total resource usage - Wall time: 1210s; CPU: 54.0%; Read bytes: 569344; Write bytes: 699345920; Read time: 14; Write time: 1973 17:15:24 INFO - TinderboxPrint: CPU usage
54.3% 17:15:24 INFO - TinderboxPrint: I/O read bytes / time
569,344 / 14 17:15:24 INFO - TinderboxPrint: I/O write bytes / time
699,345,920 / 1,973 17:15:24 INFO - TinderboxPrint: CPU idle
2,213.8 (45.7%) 17:15:24 INFO - TinderboxPrint: CPU system
983.6 (20.3%) 17:15:24 INFO - TinderboxPrint: CPU user
1,644.3 (34.0%) 17:15:24 INFO - TinderboxPrint: Swap in / out
402,780,160 / 0 17:15:24 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 400849408; Write bytes: 394843648; Read time: 29701; Write time: 823 17:15:24 INFO - run-tests - Wall time: 1177s; CPU: 54.0%; Read bytes: 458752; Write bytes: 292603392; Read time: 12; Write time: 1112 17:15:25 INFO - Running post-run listener: _upload_blobber_files 17:15:25 INFO - Blob upload gear active. 17:15:25 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:15:25 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 17:15:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 17:15:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 17:15:25 INFO - (blobuploader) - INFO - Open directory for files ... 17:15:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 17:15:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:15:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:15:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 17:15:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:15:26 INFO - (blobuploader) - INFO - Done attempting. 17:15:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 17:15:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:15:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:15:27 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 17:15:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:15:27 INFO - (blobuploader) - INFO - Done attempting. 17:15:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:15:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:15:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:15:29 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:15:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:15:29 INFO - (blobuploader) - INFO - Done attempting. 17:15:29 INFO - (blobuploader) - INFO - Iteration through files over. 17:15:29 INFO - Return code: 0 17:15:29 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:15:29 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:15:29 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/14546bc6cbc9dfbe0c5735500fca8c02c57471205bf54b99ecc8f5ae94e8005a9214ca272a20d722bbf60b494113b5b0f7efd7b2c9eabca2a2db019850e7dd80", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/38ea99c740fdfdf031e22ed76a94d8ec7b863cb3954451991afedd789bb67f17e8a094940c407af4ae9f189ba100a79885b158a1cd1ee9090c1d18144f18e85c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9986b828f87ed9be8fc4f5e7db03682593892955f984124f504a63ee621107caed2596730d8e208b91155fcbb9ceb70ff716a8f5404de704d1b8aeafd6f86ace"} 17:15:29 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:15:29 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:15:29 INFO - Contents: 17:15:29 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/14546bc6cbc9dfbe0c5735500fca8c02c57471205bf54b99ecc8f5ae94e8005a9214ca272a20d722bbf60b494113b5b0f7efd7b2c9eabca2a2db019850e7dd80", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/38ea99c740fdfdf031e22ed76a94d8ec7b863cb3954451991afedd789bb67f17e8a094940c407af4ae9f189ba100a79885b158a1cd1ee9090c1d18144f18e85c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9986b828f87ed9be8fc4f5e7db03682593892955f984124f504a63ee621107caed2596730d8e208b91155fcbb9ceb70ff716a8f5404de704d1b8aeafd6f86ace"} 17:15:29 INFO - Running post-run listener: copy_logs_to_upload_dir 17:15:29 INFO - Copying logs to upload dir... 17:15:29 INFO - mkdir: /builds/slave/test/build/upload/logs 17:15:29 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1262.090864 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2016-08-09 17:15:29.444452) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-09 17:15:29.448008) ========= 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.f0HgucWfr7/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.H9ogqVjJnt/Listeners TMPDIR=/var/folders/tm/bb1xmxh10h32jsf94bs0tnvh00000w/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/14546bc6cbc9dfbe0c5735500fca8c02c57471205bf54b99ecc8f5ae94e8005a9214ca272a20d722bbf60b494113b5b0f7efd7b2c9eabca2a2db019850e7dd80", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/38ea99c740fdfdf031e22ed76a94d8ec7b863cb3954451991afedd789bb67f17e8a094940c407af4ae9f189ba100a79885b158a1cd1ee9090c1d18144f18e85c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9986b828f87ed9be8fc4f5e7db03682593892955f984124f504a63ee621107caed2596730d8e208b91155fcbb9ceb70ff716a8f5404de704d1b8aeafd6f86ace"} build_url:https://queue.taskcluster.net/v1/task/OgXNqcGaSB-gL9abrbxfbA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011618 build_url: 'https://queue.taskcluster.net/v1/task/OgXNqcGaSB-gL9abrbxfbA/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/14546bc6cbc9dfbe0c5735500fca8c02c57471205bf54b99ecc8f5ae94e8005a9214ca272a20d722bbf60b494113b5b0f7efd7b2c9eabca2a2db019850e7dd80", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/38ea99c740fdfdf031e22ed76a94d8ec7b863cb3954451991afedd789bb67f17e8a094940c407af4ae9f189ba100a79885b158a1cd1ee9090c1d18144f18e85c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9986b828f87ed9be8fc4f5e7db03682593892955f984124f504a63ee621107caed2596730d8e208b91155fcbb9ceb70ff716a8f5404de704d1b8aeafd6f86ace"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-09 17:15:29.481498) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-09 17:15:29.481842) ========= 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.f0HgucWfr7/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.H9ogqVjJnt/Listeners TMPDIR=/var/folders/tm/bb1xmxh10h32jsf94bs0tnvh00000w/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.005486 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-09 17:15:29.530553) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-09 17:15:29.530995) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-09 17:15:29.531348) ========= ========= Total master_lag: 0.17 =========