builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0120 starttime: 1470326156.51 results: success (0) buildid: 20160804065923 builduid: 88bb4be7621a41e1bb45628f7ce111c3 revision: 0ba72e8027cfcbcbf3426770ac264a7ade2af090 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-04 08:55:56.515286) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-04 08:55:56.515832) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-04 08:55:56.516158) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-04 08:55:56.543130) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-04 08:55:56.543823) ========= 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.LtgpIoBLRg/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.Iknv6o9QUC/Listeners TMPDIR=/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/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-04 08:55:56-- 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% 55.7M=0s 2016-08-04 08:55:56 (55.7 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.365010 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-04 08:55:56.936732) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-04 08:55:56.937454) ========= 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.LtgpIoBLRg/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.Iknv6o9QUC/Listeners TMPDIR=/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/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.028075 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-04 08:55:56.992228) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-08-04 08:55:56.992707) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 0ba72e8027cfcbcbf3426770ac264a7ade2af090 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 0ba72e8027cfcbcbf3426770ac264a7ade2af090 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.LtgpIoBLRg/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.Iknv6o9QUC/Listeners TMPDIR=/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/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-04 08:55:57,065 truncating revision to first 12 chars 2016-08-04 08:55:57,065 Setting DEBUG logging. 2016-08-04 08:55:57,065 attempt 1/10 2016-08-04 08:55:57,065 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/0ba72e8027cf?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-04 08:55:58,840 unpacking tar archive at: mozilla-central-0ba72e8027cf/testing/mozharness/ program finished with exit code 0 elapsedTime=2.031347 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-08-04 08:55:59.046691) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-04 08:55:59.047059) ========= script_repo_revision: 0ba72e8027cfcbcbf3426770ac264a7ade2af090 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-04 08:55:59.047522) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-04 08:55:59.047836) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-04 08:55:59.066231) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2016-08-04 08:55:59.066556) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.LtgpIoBLRg/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.Iknv6o9QUC/Listeners TMPDIR=/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/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 08:55:59 INFO - MultiFileLogger online at 20160804 08:55:59 in /builds/slave/test 08:55:59 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 08:55:59 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:55:59 INFO - {'append_to_log': False, 08:55:59 INFO - 'base_work_dir': '/builds/slave/test', 08:55:59 INFO - 'blob_upload_branch': 'Firefox', 08:55:59 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:55:59 INFO - 'branch': 'Firefox', 08:55:59 INFO - 'buildbot_json_path': 'buildprops.json', 08:55:59 INFO - 'config_files': ('talos/mac_config.py',), 08:55:59 INFO - 'default_actions': ('clobber', 08:55:59 INFO - 'read-buildbot-config', 08:55:59 INFO - 'download-and-extract', 08:55:59 INFO - 'populate-webroot', 08:55:59 INFO - 'create-virtualenv', 08:55:59 INFO - 'install', 08:55:59 INFO - 'run-tests'), 08:55:59 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:55:59 INFO - 'download_minidump_stackwalk': True, 08:55:59 INFO - 'download_symbols': 'ondemand', 08:55:59 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:55:59 INFO - 'tooltool.py': '/tools/tooltool.py', 08:55:59 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:55:59 INFO - '/tools/misc-python/virtualenv.py')}, 08:55:59 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:55:59 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:55:59 INFO - 'installer_path': 'installer.exe', 08:55:59 INFO - 'log_level': 'info', 08:55:59 INFO - 'log_name': 'talos', 08:55:59 INFO - 'log_to_console': True, 08:55:59 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 08:55:59 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 08:55:59 INFO - 'opt_config_files': (), 08:55:59 INFO - 'pip_index': False, 08:55:59 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:55:59 INFO - 'cmd': ('bash', 08:55:59 INFO - '-c', 08:55:59 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:55:59 INFO - 'enabled': True, 08:55:59 INFO - 'halt_on_failure': False, 08:55:59 INFO - 'name': 'check_screen_resolution'},), 08:55:59 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:55:59 INFO - 'cmd': ('bash', 08:55:59 INFO - '-c', 08:55:59 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:55:59 INFO - 'enabled': True, 08:55:59 INFO - 'halt_on_failure': False, 08:55:59 INFO - 'name': 'check_screen_resolution'},), 08:55:59 INFO - 'run_cmd_checks_enabled': True, 08:55:59 INFO - 'sps_profile': False, 08:55:59 INFO - 'sps_profile_interval': 0, 08:55:59 INFO - 'suite': 'dromaeojs-e10s', 08:55:59 INFO - 'system_bits': '32', 08:55:59 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:55:59 INFO - 'title': 't-yosemite-r7-0120', 08:55:59 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:55:59 INFO - 'use_talos_json': True, 08:55:59 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:55:59 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:55:59 INFO - 'work_dir': 'build'} 08:55:59 INFO - [mozharness: 2016-08-04 15:55:59.259784Z] Running clobber step. 08:55:59 INFO - Running pre-action listener: _resource_record_pre_action 08:55:59 INFO - Running main action method: clobber 08:55:59 INFO - rmtree: /builds/slave/test/build 08:55:59 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:56:01 INFO - Running post-action listener: _resource_record_post_action 08:56:01 INFO - [mozharness: 2016-08-04 15:56:01.484330Z] Finished clobber step (success) 08:56:01 INFO - [mozharness: 2016-08-04 15:56:01.484490Z] Running read-buildbot-config step. 08:56:01 INFO - Running pre-action listener: _resource_record_pre_action 08:56:01 INFO - Running main action method: read_buildbot_config 08:56:01 INFO - Using buildbot properties: 08:56:01 INFO - { 08:56:01 INFO - "project": "", 08:56:01 INFO - "product": "firefox", 08:56:01 INFO - "script_repo_revision": "production", 08:56:01 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 08:56:01 INFO - "repository": "", 08:56:01 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 08:56:01 INFO - "buildid": "20160804065923", 08:56:01 INFO - "pgo_build": "False", 08:56:01 INFO - "basedir": "/builds/slave/test", 08:56:01 INFO - "buildnumber": 84, 08:56:01 INFO - "slavename": "t-yosemite-r7-0120", 08:56:01 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 08:56:01 INFO - "platform": "yosemite_r7", 08:56:01 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 08:56:01 INFO - "branch": "mozilla-central", 08:56:01 INFO - "repo_path": "mozilla-central", 08:56:01 INFO - "revision": "0ba72e8027cfcbcbf3426770ac264a7ade2af090", 08:56:01 INFO - "stage_platform": "macosx64", 08:56:01 INFO - "builduid": "88bb4be7621a41e1bb45628f7ce111c3", 08:56:01 INFO - "slavebuilddir": "test" 08:56:01 INFO - } 08:56:01 INFO - Found installer url https://queue.taskcluster.net/v1/task/fbjJOKZMRIOpvfQ_91p8-g/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg. 08:56:01 INFO - Running post-action listener: _resource_record_post_action 08:56:01 INFO - [mozharness: 2016-08-04 15:56:01.490220Z] Finished read-buildbot-config step (success) 08:56:01 INFO - [mozharness: 2016-08-04 15:56:01.490400Z] Running download-and-extract step. 08:56:01 INFO - Running pre-action listener: _resource_record_pre_action 08:56:01 INFO - Running main action method: download_and_extract 08:56:01 INFO - mkdir: /builds/slave/test/build/tests 08:56:01 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')]} 08:56:01 INFO - trying https://queue.taskcluster.net/v1/task/fbjJOKZMRIOpvfQ_91p8-g/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json 08:56:01 INFO - Downloading https://queue.taskcluster.net/v1/task/fbjJOKZMRIOpvfQ_91p8-g/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 08:56:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fbjJOKZMRIOpvfQ_91p8-g/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 08:56:02 INFO - Downloaded 1199 bytes. 08:56:02 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 08:56:02 INFO - Using the following test package requirements: 08:56:02 INFO - {u'common': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 08:56:02 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 08:56:02 INFO - u'firefox-51.0a1.en-US.mac.cppunittest.tests.zip'], 08:56:02 INFO - u'gtest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 08:56:02 INFO - u'firefox-51.0a1.en-US.mac.gtest.tests.zip'], 08:56:02 INFO - u'jittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 08:56:02 INFO - u'jsshell-mac.zip'], 08:56:02 INFO - u'mochitest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 08:56:02 INFO - u'firefox-51.0a1.en-US.mac.mochitest.tests.zip'], 08:56:02 INFO - u'mozbase': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 08:56:02 INFO - u'reftest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 08:56:02 INFO - u'firefox-51.0a1.en-US.mac.reftest.tests.zip'], 08:56:02 INFO - u'talos': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 08:56:02 INFO - u'firefox-51.0a1.en-US.mac.talos.tests.zip'], 08:56:02 INFO - u'web-platform': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 08:56:02 INFO - u'firefox-51.0a1.en-US.mac.web-platform.tests.zip'], 08:56:02 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 08:56:02 INFO - u'firefox-51.0a1.en-US.mac.xpcshell.tests.zip']} 08:56:02 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip'] for test suite category: common 08:56: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')]} 08:56:02 INFO - trying https://queue.taskcluster.net/v1/task/fbjJOKZMRIOpvfQ_91p8-g/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 08:56:02 INFO - Downloading https://queue.taskcluster.net/v1/task/fbjJOKZMRIOpvfQ_91p8-g/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 08:56:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fbjJOKZMRIOpvfQ_91p8-g/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 08:56:03 INFO - Downloaded 16315507 bytes. 08:56:03 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:56:03 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 08:56:06 INFO - Return code: 0 08:56:06 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 08:56:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:56:06 INFO - trying https://queue.taskcluster.net/v1/task/fbjJOKZMRIOpvfQ_91p8-g/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 08:56:06 INFO - Downloading https://queue.taskcluster.net/v1/task/fbjJOKZMRIOpvfQ_91p8-g/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 08:56:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fbjJOKZMRIOpvfQ_91p8-g/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 08:56:07 INFO - Downloaded 16315507 bytes. 08:56:07 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'] 08:56:07 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 08:56:11 INFO - Return code: 0 08:56:11 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')]} 08:56:11 INFO - trying https://queue.taskcluster.net/v1/task/fbjJOKZMRIOpvfQ_91p8-g/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip 08:56:11 INFO - Downloading https://queue.taskcluster.net/v1/task/fbjJOKZMRIOpvfQ_91p8-g/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 08:56:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fbjJOKZMRIOpvfQ_91p8-g/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 08:56:12 INFO - Downloaded 14413723 bytes. 08:56:12 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'] 08:56:12 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 08:56:12 INFO - Return code: 0 08:56: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')]} 08:56:12 INFO - trying https://queue.taskcluster.net/v1/task/fbjJOKZMRIOpvfQ_91p8-g/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 08:56:12 INFO - Downloading https://queue.taskcluster.net/v1/task/fbjJOKZMRIOpvfQ_91p8-g/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg 08:56:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fbjJOKZMRIOpvfQ_91p8-g/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 08:56:16 INFO - Downloaded 111173357 bytes. 08:56:16 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/fbjJOKZMRIOpvfQ_91p8-g/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 08:56:16 INFO - mkdir: /builds/slave/test/properties 08:56:16 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:56:16 INFO - Writing to file /builds/slave/test/properties/build_url 08:56:16 INFO - Contents: 08:56:16 INFO - build_url:https://queue.taskcluster.net/v1/task/fbjJOKZMRIOpvfQ_91p8-g/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 08:56:17 INFO - Running post-action listener: _resource_record_post_action 08:56:17 INFO - Running post-action listener: set_extra_try_arguments 08:56:17 INFO - [mozharness: 2016-08-04 15:56:17.295267Z] Finished download-and-extract step (success) 08:56:17 INFO - [mozharness: 2016-08-04 15:56:17.295418Z] Running populate-webroot step. 08:56:17 INFO - Running pre-action listener: _resource_record_pre_action 08:56:17 INFO - Running main action method: populate_webroot 08:56:17 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:56:17 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:56:17 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:56:17 INFO - '--tppagecycles', 08:56:17 INFO - '7'], 08:56:17 INFO - 'tests': ['tsvgm']}}, 08:56:17 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:56:17 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:56:17 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:56:17 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:56:17 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:56:17 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:56:17 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:56:17 INFO - 'talos_options': ['--disable-e10s'], 08:56:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:56:17 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:56:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:56:17 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:56:17 INFO - 'talos_options': ['--disable-e10s'], 08:56:17 INFO - 'tests': ['damp', 'tps']}, 08:56:17 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:56:17 INFO - 'tests': ['damp', 'tps']}, 08:56:17 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:56:17 INFO - 'tests': ['dromaeo_dom']}, 08:56:17 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:56:17 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:56:17 INFO - 'tests': ['basic_compositor_video']}, 08:56:17 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:56:17 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:56:17 INFO - 'tests': ['a11yr', 08:56:17 INFO - 'ts_paint', 08:56:17 INFO - 'tpaint', 08:56:17 INFO - 'sessionrestore', 08:56:17 INFO - 'sessionrestore_no_auto_restore', 08:56:17 INFO - 'tabpaint']}, 08:56:17 INFO - 'other-e10s': {'tests': ['a11yr', 08:56:17 INFO - 'ts_paint', 08:56:17 INFO - 'tpaint', 08:56:17 INFO - 'sessionrestore', 08:56:17 INFO - 'sessionrestore_no_auto_restore', 08:56:17 INFO - 'tabpaint']}, 08:56:17 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:56:17 INFO - 'ts_paint', 08:56:17 INFO - 'tpaint', 08:56:17 INFO - 'sessionrestore', 08:56:17 INFO - 'sessionrestore_no_auto_restore', 08:56:17 INFO - 'tabpaint']}, 08:56:17 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:56:17 INFO - 'ts_paint', 08:56:17 INFO - 'tpaint', 08:56:17 INFO - 'sessionrestore', 08:56:17 INFO - 'sessionrestore_no_auto_restore', 08:56:17 INFO - 'tabpaint']}, 08:56:17 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:56:17 INFO - 'tests': ['a11yr', 08:56:17 INFO - 'ts_paint', 08:56:17 INFO - 'tpaint', 08:56:17 INFO - 'sessionrestore', 08:56:17 INFO - 'sessionrestore_no_auto_restore', 08:56:17 INFO - 'tabpaint']}, 08:56:17 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:56:17 INFO - 'tests': ['a11yr', 08:56:17 INFO - 'ts_paint', 08:56:17 INFO - 'tpaint', 08:56:17 INFO - 'sessionrestore', 08:56:17 INFO - 'sessionrestore_no_auto_restore', 08:56:17 INFO - 'tabpaint']}, 08:56:17 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:56:17 INFO - 'tests': ['tsvgx', 08:56:17 INFO - 'tsvgr_opacity', 08:56:17 INFO - 'tart', 08:56:17 INFO - 'tscrollx', 08:56:17 INFO - 'cart']}, 08:56:17 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:56:17 INFO - 'tsvgr_opacity', 08:56:17 INFO - 'tart', 08:56:17 INFO - 'tscrollx', 08:56:17 INFO - 'cart']}, 08:56:17 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:56:17 INFO - 'talos_options': ['--disable-e10s'], 08:56:17 INFO - 'tests': ['tp5o']}, 08:56:17 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:56:17 INFO - 'tests': ['tp5o']}, 08:56:17 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:56:17 INFO - 'talos_options': ['--disable-e10s', 08:56:17 INFO - '--xperf_path', 08:56:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:56:17 INFO - 'tests': ['tp5n']}, 08:56:17 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:56:17 INFO - 'talos_options': ['--xperf_path', 08:56:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:56:17 INFO - 'tests': ['tp5n']}}, 08:56:17 INFO - 'talos.zip': {'path': '', 08:56:17 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:56:17 INFO - Running post-action listener: _resource_record_post_action 08:56:17 INFO - [mozharness: 2016-08-04 15:56:17.314765Z] Finished populate-webroot step (success) 08:56:17 INFO - [mozharness: 2016-08-04 15:56:17.314904Z] Running create-virtualenv step. 08:56:17 INFO - Running pre-action listener: _resource_record_pre_action 08:56:17 INFO - Running main action method: create_virtualenv 08:56:17 INFO - Creating virtualenv /builds/slave/test/build/venv 08:56:17 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 08:56:17 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:56:17 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:56:17 INFO - Using real prefix '/tools/python27' 08:56:17 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:56:18 INFO - Installing distribute.............................................................................................................................................................................................done. 08:56:21 INFO - Installing pip.................done. 08:56:21 INFO - Return code: 0 08:56:21 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:56:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:56:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:56:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:56:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:56:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:56:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:56:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x103bcca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103c61618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc302d4eab0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103b30d30>, '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 0x103895db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103b28b20>, '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.LtgpIoBLRg/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.Iknv6o9QUC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/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 08:56:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 08:56:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:56:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LtgpIoBLRg/Render', 08:56:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:56:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:56:21 INFO - 'HOME': '/Users/cltbld', 08:56:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:56:21 INFO - 'LOGNAME': 'cltbld', 08:56:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:56:21 INFO - 'MOZ_NO_REMOTE': '1', 08:56:21 INFO - 'NO_EM_RESTART': '1', 08:56:21 INFO - 'PAGER': '/bin/cat', 08:56:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:56:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:56:21 INFO - 'PWD': '/builds/slave/test', 08:56:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:56:21 INFO - 'SHELL': '/bin/bash', 08:56:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Iknv6o9QUC/Listeners', 08:56:21 INFO - 'TMPDIR': '/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/', 08:56:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:56:21 INFO - 'USER': 'cltbld', 08:56:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:56:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:56:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:56:21 INFO - 'XPC_FLAGS': '0x0', 08:56:21 INFO - 'XPC_SERVICE_NAME': '0', 08:56:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:56:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:56:21 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 08:56:21 INFO - Cleaning up... 08:56:21 INFO - Return code: 0 08:56:21 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:56:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:56:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:56:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:56:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:56:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:56:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:56:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x103bcca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103c61618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc302d4eab0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103b30d30>, '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 0x103895db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103b28b20>, '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.LtgpIoBLRg/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.Iknv6o9QUC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/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 08:56:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 08:56:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 08:56:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LtgpIoBLRg/Render', 08:56:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:56:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:56:21 INFO - 'HOME': '/Users/cltbld', 08:56:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:56:21 INFO - 'LOGNAME': 'cltbld', 08:56:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:56:21 INFO - 'MOZ_NO_REMOTE': '1', 08:56:21 INFO - 'NO_EM_RESTART': '1', 08:56:21 INFO - 'PAGER': '/bin/cat', 08:56:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:56:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:56:21 INFO - 'PWD': '/builds/slave/test', 08:56:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:56:21 INFO - 'SHELL': '/bin/bash', 08:56:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Iknv6o9QUC/Listeners', 08:56:21 INFO - 'TMPDIR': '/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/', 08:56:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:56:21 INFO - 'USER': 'cltbld', 08:56:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:56:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:56:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:56:21 INFO - 'XPC_FLAGS': '0x0', 08:56:21 INFO - 'XPC_SERVICE_NAME': '0', 08:56:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:56:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:56:21 INFO - Downloading/unpacking psutil>=3.1.1 08:56:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:56:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:56:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:56:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:56:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:56:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:56:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:56:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:56:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:56:24 INFO - Installing collected packages: psutil 08:56:24 INFO - Running setup.py install for psutil 08:56:24 INFO - building 'psutil._psutil_osx' extension 08:56:24 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 08:56:25 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 08:56:25 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 08:56:25 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 08:56:25 INFO - building 'psutil._psutil_posix' extension 08:56:25 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 08:56:25 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 08:56:25 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 08:56:25 INFO - ^ 08:56:25 INFO - 1 warning generated. 08:56:25 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 08:56:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:56:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:56:25 INFO - Successfully installed psutil 08:56:25 INFO - Cleaning up... 08:56:25 INFO - Return code: 0 08:56:25 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:56:25 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')]} 08:56:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:56:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:56:25 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')]} 08:56:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:56:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:56:25 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 0x103bcca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103c61618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc302d4eab0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103b30d30>, '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 0x103895db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103b28b20>, '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.LtgpIoBLRg/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.Iknv6o9QUC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/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 08:56:25 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 08:56:25 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 08:56:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LtgpIoBLRg/Render', 08:56:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:56:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:56:25 INFO - 'HOME': '/Users/cltbld', 08:56:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:56:25 INFO - 'LOGNAME': 'cltbld', 08:56:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:56:25 INFO - 'MOZ_NO_REMOTE': '1', 08:56:25 INFO - 'NO_EM_RESTART': '1', 08:56:25 INFO - 'PAGER': '/bin/cat', 08:56:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:56:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:56:25 INFO - 'PWD': '/builds/slave/test', 08:56:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:56:25 INFO - 'SHELL': '/bin/bash', 08:56:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Iknv6o9QUC/Listeners', 08:56:25 INFO - 'TMPDIR': '/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/', 08:56:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:56:25 INFO - 'USER': 'cltbld', 08:56:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:56:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:56:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:56:25 INFO - 'XPC_FLAGS': '0x0', 08:56:25 INFO - 'XPC_SERVICE_NAME': '0', 08:56:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:56:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:56:26 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:56:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:56:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:56:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:56:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:56:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:56:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:56:28 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:56:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:56:28 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:56:28 INFO - Installing collected packages: mozsystemmonitor 08:56:28 INFO - Running setup.py install for mozsystemmonitor 08:56:28 INFO - Successfully installed mozsystemmonitor 08:56:28 INFO - Cleaning up... 08:56:28 INFO - Return code: 0 08:56:28 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:56:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:56:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:56:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:56:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:56:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:56:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:56:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x103bcca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103c61618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc302d4eab0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103b30d30>, '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 0x103895db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103b28b20>, '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.LtgpIoBLRg/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.Iknv6o9QUC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/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 08:56:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 08:56:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 08:56:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LtgpIoBLRg/Render', 08:56:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:56:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:56:28 INFO - 'HOME': '/Users/cltbld', 08:56:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:56:28 INFO - 'LOGNAME': 'cltbld', 08:56:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:56:28 INFO - 'MOZ_NO_REMOTE': '1', 08:56:28 INFO - 'NO_EM_RESTART': '1', 08:56:28 INFO - 'PAGER': '/bin/cat', 08:56:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:56:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:56:28 INFO - 'PWD': '/builds/slave/test', 08:56:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:56:28 INFO - 'SHELL': '/bin/bash', 08:56:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Iknv6o9QUC/Listeners', 08:56:28 INFO - 'TMPDIR': '/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/', 08:56:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:56:28 INFO - 'USER': 'cltbld', 08:56:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:56:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:56:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:56:28 INFO - 'XPC_FLAGS': '0x0', 08:56:28 INFO - 'XPC_SERVICE_NAME': '0', 08:56:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:56:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:56:28 INFO - Downloading/unpacking jsonschema==2.5.1 08:56:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:56:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:56:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:56:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:56:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:56:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:56:31 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:56:31 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:56:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:56:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:56:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:56:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:56:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:56:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:56:31 INFO - Downloading functools32-3.2.3-2.tar.gz 08:56:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:56:31 INFO - warning: no files found matching '*.txt' 08:56:31 INFO - no previously-included directories found matching 'build' 08:56:31 INFO - no previously-included directories found matching 'dist' 08:56:31 INFO - no previously-included directories found matching '.git*' 08:56:31 INFO - Installing collected packages: jsonschema, functools32 08:56:31 INFO - Running setup.py install for functools32 08:56:31 INFO - warning: no files found matching '*.txt' 08:56:31 INFO - no previously-included directories found matching 'build' 08:56:31 INFO - no previously-included directories found matching 'dist' 08:56:31 INFO - no previously-included directories found matching '.git*' 08:56:32 INFO - Successfully installed jsonschema functools32 08:56:32 INFO - Cleaning up... 08:56:32 INFO - Return code: 0 08:56:32 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:56:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:56:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:56:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:56:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:56:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:56:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:56:32 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 0x103bcca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103c61618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc302d4eab0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103b30d30>, '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 0x103895db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103b28b20>, '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.LtgpIoBLRg/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.Iknv6o9QUC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/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 08:56:32 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 08:56:32 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 08:56:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LtgpIoBLRg/Render', 08:56:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:56:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:56:32 INFO - 'HOME': '/Users/cltbld', 08:56:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:56:32 INFO - 'LOGNAME': 'cltbld', 08:56:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:56:32 INFO - 'MOZ_NO_REMOTE': '1', 08:56:32 INFO - 'NO_EM_RESTART': '1', 08:56:32 INFO - 'PAGER': '/bin/cat', 08:56:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:56:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:56:32 INFO - 'PWD': '/builds/slave/test', 08:56:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:56:32 INFO - 'SHELL': '/bin/bash', 08:56:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Iknv6o9QUC/Listeners', 08:56:32 INFO - 'TMPDIR': '/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/', 08:56:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:56:32 INFO - 'USER': 'cltbld', 08:56:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:56:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:56:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:56:32 INFO - 'XPC_FLAGS': '0x0', 08:56:32 INFO - 'XPC_SERVICE_NAME': '0', 08:56:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:56:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:56:32 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:56:32 INFO - Cleaning up... 08:56:32 INFO - Return code: 0 08:56:32 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:56:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:56:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:56:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:56:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:56:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:56:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:56:32 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 0x103bcca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103c61618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc302d4eab0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103b30d30>, '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 0x103895db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103b28b20>, '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.LtgpIoBLRg/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.Iknv6o9QUC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/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 08:56:32 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 08:56:32 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 08:56:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LtgpIoBLRg/Render', 08:56:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:56:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:56:32 INFO - 'HOME': '/Users/cltbld', 08:56:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:56:32 INFO - 'LOGNAME': 'cltbld', 08:56:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:56:32 INFO - 'MOZ_NO_REMOTE': '1', 08:56:32 INFO - 'NO_EM_RESTART': '1', 08:56:32 INFO - 'PAGER': '/bin/cat', 08:56:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:56:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:56:32 INFO - 'PWD': '/builds/slave/test', 08:56:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:56:32 INFO - 'SHELL': '/bin/bash', 08:56:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Iknv6o9QUC/Listeners', 08:56:32 INFO - 'TMPDIR': '/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/', 08:56:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:56:32 INFO - 'USER': 'cltbld', 08:56:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:56:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:56:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:56:32 INFO - 'XPC_FLAGS': '0x0', 08:56:32 INFO - 'XPC_SERVICE_NAME': '0', 08:56:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:56:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:56:32 INFO - Downloading/unpacking blobuploader==1.2.4 08:56:32 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 08:56:32 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 08:56:32 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 08:56:32 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 08:56:32 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 08:56:32 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 08:56:35 INFO - Downloading blobuploader-1.2.4.tar.gz 08:56:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:56:35 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:56:35 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 08:56:35 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 08:56:35 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 08:56:35 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 08:56:35 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 08:56:35 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 08:56:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:56:35 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:56:35 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 08:56:35 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 08:56:35 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 08:56:35 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 08:56:35 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 08:56:35 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 08:56:36 INFO - Downloading docopt-0.6.1.tar.gz 08:56:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:56:36 INFO - Installing collected packages: blobuploader, requests, docopt 08:56:36 INFO - Running setup.py install for blobuploader 08:56:36 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:56:36 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:56:36 INFO - Running setup.py install for requests 08:56:36 INFO - Running setup.py install for docopt 08:56:37 INFO - Successfully installed blobuploader requests docopt 08:56:37 INFO - Cleaning up... 08:56:37 INFO - Return code: 0 08:56:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:56: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')]} 08:56:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:56:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:56: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')]} 08:56:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:56:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:56:37 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 0x103bcca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103c61618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc302d4eab0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103b30d30>, '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 0x103895db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103b28b20>, '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.LtgpIoBLRg/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.Iknv6o9QUC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/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 08:56:37 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 08:56:37 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 08:56:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LtgpIoBLRg/Render', 08:56:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:56:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:56:37 INFO - 'HOME': '/Users/cltbld', 08:56:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:56:37 INFO - 'LOGNAME': 'cltbld', 08:56:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:56:37 INFO - 'MOZ_NO_REMOTE': '1', 08:56:37 INFO - 'NO_EM_RESTART': '1', 08:56:37 INFO - 'PAGER': '/bin/cat', 08:56:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:56:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:56:37 INFO - 'PWD': '/builds/slave/test', 08:56:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:56:37 INFO - 'SHELL': '/bin/bash', 08:56:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Iknv6o9QUC/Listeners', 08:56:37 INFO - 'TMPDIR': '/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/', 08:56:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:56:37 INFO - 'USER': 'cltbld', 08:56:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:56:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:56:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:56:37 INFO - 'XPC_FLAGS': '0x0', 08:56:37 INFO - 'XPC_SERVICE_NAME': '0', 08:56:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:56:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:56:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:56:37 INFO - Running setup.py (path:/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/pip-S3JUvY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:56:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:56:37 INFO - Running setup.py (path:/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/pip-kMyxN9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:56:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:56:37 INFO - Running setup.py (path:/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/pip-qIXFMj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:56:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:56:37 INFO - Running setup.py (path:/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/pip-NUBzNi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:56:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:56:37 INFO - Running setup.py (path:/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/pip-gCHKo1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:56:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:56:37 INFO - Running setup.py (path:/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/pip-_29wix-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:56:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:56:38 INFO - Running setup.py (path:/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/pip-ivQeGg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:56:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:56:38 INFO - Running setup.py (path:/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/pip-hGF39z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:56:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:56:38 INFO - Running setup.py (path:/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/pip-jOdd_y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:56:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:56:38 INFO - Running setup.py (path:/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/pip-pjeKRu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:56:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:56:38 INFO - Running setup.py (path:/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/pip-CAVpeT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:56:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:56:38 INFO - Running setup.py (path:/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/pip-6Z5_B2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:56:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:56:38 INFO - Running setup.py (path:/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/pip-GbF4w4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:56:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:56:38 INFO - Running setup.py (path:/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/pip-mFLheH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:56:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:56:38 INFO - Running setup.py (path:/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/pip-d8d3OI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:56:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:56:39 INFO - Running setup.py (path:/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/pip-UW4uQe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:56:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:56:39 INFO - Running setup.py (path:/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/pip-DuKIkT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:56:39 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:56:39 INFO - Running setup.py install for manifestparser 08:56:39 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:56:39 INFO - Running setup.py install for mozcrash 08:56:39 INFO - Running setup.py install for mozdebug 08:56:39 INFO - Running setup.py install for mozdevice 08:56:39 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:56:39 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:56:39 INFO - Running setup.py install for mozfile 08:56:39 INFO - Running setup.py install for mozhttpd 08:56:40 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:56:40 INFO - Running setup.py install for mozinfo 08:56:40 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:56:40 INFO - Running setup.py install for mozInstall 08:56:40 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:56:40 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:56:40 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:56:40 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:56:40 INFO - Running setup.py install for mozleak 08:56:40 INFO - Running setup.py install for mozlog 08:56:40 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:56:40 INFO - Running setup.py install for moznetwork 08:56:40 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:56:40 INFO - Running setup.py install for mozprocess 08:56:41 INFO - Running setup.py install for mozprofile 08:56:41 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:56:41 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:56:41 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:56:41 INFO - Running setup.py install for mozrunner 08:56:41 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:56:41 INFO - Running setup.py install for mozscreenshot 08:56:41 INFO - Running setup.py install for moztest 08:56:41 INFO - Running setup.py install for mozversion 08:56:41 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:56:41 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:56:41 INFO - Cleaning up... 08:56:41 INFO - Return code: 0 08:56:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:56:41 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')]} 08:56:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:56:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:56:41 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')]} 08:56:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:56:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:56:41 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 0x103bcca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103c61618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc302d4eab0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103b30d30>, '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 0x103895db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103b28b20>, '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.LtgpIoBLRg/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.Iknv6o9QUC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/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 08:56:41 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 08:56:41 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 08:56:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LtgpIoBLRg/Render', 08:56:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:56:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:56:41 INFO - 'HOME': '/Users/cltbld', 08:56:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:56:41 INFO - 'LOGNAME': 'cltbld', 08:56:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:56:41 INFO - 'MOZ_NO_REMOTE': '1', 08:56:41 INFO - 'NO_EM_RESTART': '1', 08:56:41 INFO - 'PAGER': '/bin/cat', 08:56:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:56:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:56:41 INFO - 'PWD': '/builds/slave/test', 08:56:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:56:41 INFO - 'SHELL': '/bin/bash', 08:56:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Iknv6o9QUC/Listeners', 08:56:41 INFO - 'TMPDIR': '/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/', 08:56:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:56:41 INFO - 'USER': 'cltbld', 08:56:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:56:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:56:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:56:41 INFO - 'XPC_FLAGS': '0x0', 08:56:41 INFO - 'XPC_SERVICE_NAME': '0', 08:56:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:56:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:56:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:56:42 INFO - Running setup.py (path:/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/pip-HS4oC5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:56:42 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)) 08:56:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:56:42 INFO - Running setup.py (path:/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/pip-mmG4MB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:56:42 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)) 08:56:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:56:42 INFO - Running setup.py (path:/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/pip-AL6MLj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:56:42 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)) 08:56:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:56:42 INFO - Running setup.py (path:/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/pip-FDXl4w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:56:42 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)) 08:56:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:56:42 INFO - Running setup.py (path:/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/pip-5Yz1AI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:56:42 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)) 08:56:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:56:42 INFO - Running setup.py (path:/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/pip-IRpwb7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:56:42 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)) 08:56:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:56:42 INFO - Running setup.py (path:/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/pip-FbX0Jd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:56:42 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)) 08:56:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:56:42 INFO - Running setup.py (path:/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/pip-GbTjtV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:56:42 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)) 08:56:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:56:42 INFO - Running setup.py (path:/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/pip-0GevKo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:56:43 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)) 08:56:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:56:43 INFO - Running setup.py (path:/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/pip-fRS2gd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:56:43 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)) 08:56:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:56:43 INFO - Running setup.py (path:/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/pip-U7khvm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:56:43 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)) 08:56:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:56:43 INFO - Running setup.py (path:/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/pip-U_OdOy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:56:43 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)) 08:56:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:56:43 INFO - Running setup.py (path:/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/pip-5AHyVI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:56:43 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)) 08:56:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:56:43 INFO - Running setup.py (path:/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/pip-58vsPZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:56:43 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)) 08:56:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:56:43 INFO - Running setup.py (path:/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/pip-H60HO6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:56:43 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)) 08:56:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:56:43 INFO - Running setup.py (path:/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/pip-bNF18A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:56:43 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)) 08:56:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:56:43 INFO - Running setup.py (path:/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/pip-6zKAYw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:56:43 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)) 08:56:43 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)) 08:56:43 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)) 08:56:43 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)) 08:56:43 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)) 08:56:43 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)) 08:56:43 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:56:43 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 08:56:43 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 08:56:43 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 08:56:43 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 08:56:43 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 08:56:43 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 08:56:46 INFO - Downloading blessings-1.6.tar.gz 08:56:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:56:46 INFO - Installing collected packages: blessings 08:56:46 INFO - Running setup.py install for blessings 08:56:46 INFO - Successfully installed blessings 08:56:46 INFO - Cleaning up... 08:56:46 INFO - Return code: 0 08:56:46 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:56:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:56:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:56:46 INFO - Reading from file tmpfile_stdout 08:56:46 INFO - Current package versions: 08:56:46 INFO - blessings == 1.6 08:56:46 INFO - blobuploader == 1.2.4 08:56:46 INFO - docopt == 0.6.1 08:56:46 INFO - functools32 == 3.2.3-2 08:56:46 INFO - jsonschema == 2.5.1 08:56:46 INFO - manifestparser == 1.1 08:56:46 INFO - mozInstall == 1.12 08:56:46 INFO - mozcrash == 0.17 08:56:46 INFO - mozdebug == 0.1 08:56:46 INFO - mozdevice == 0.48 08:56:46 INFO - mozfile == 1.2 08:56:46 INFO - mozhttpd == 0.7 08:56:46 INFO - mozinfo == 0.9 08:56:46 INFO - mozleak == 0.1 08:56:46 INFO - mozlog == 3.3 08:56:46 INFO - moznetwork == 0.27 08:56:46 INFO - mozprocess == 0.23 08:56:46 INFO - mozprofile == 0.28 08:56:46 INFO - mozrunner == 6.12 08:56:46 INFO - mozscreenshot == 0.1 08:56:46 INFO - mozsystemmonitor == 0.3 08:56:46 INFO - moztest == 0.7 08:56:46 INFO - mozversion == 1.4 08:56:46 INFO - psutil == 3.1.1 08:56:46 INFO - requests == 1.2.3 08:56:46 INFO - wsgiref == 0.1.2 08:56:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:56: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')]} 08:56:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:56:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:56: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')]} 08:56:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:56:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:56:46 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 0x103bcca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103c61618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc302d4eab0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103b30d30>, '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 0x103895db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103b28b20>, '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.LtgpIoBLRg/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.Iknv6o9QUC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/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 08:56:46 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 08:56:46 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 08:56:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LtgpIoBLRg/Render', 08:56:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:56:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:56:46 INFO - 'HOME': '/Users/cltbld', 08:56:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:56:46 INFO - 'LOGNAME': 'cltbld', 08:56:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:56:46 INFO - 'MOZ_NO_REMOTE': '1', 08:56:46 INFO - 'NO_EM_RESTART': '1', 08:56:46 INFO - 'PAGER': '/bin/cat', 08:56:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:56:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:56:46 INFO - 'PWD': '/builds/slave/test', 08:56:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:56:46 INFO - 'SHELL': '/bin/bash', 08:56:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Iknv6o9QUC/Listeners', 08:56:46 INFO - 'TMPDIR': '/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/', 08:56:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:56:46 INFO - 'USER': 'cltbld', 08:56:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:56:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:56:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:56:46 INFO - 'XPC_FLAGS': '0x0', 08:56:46 INFO - 'XPC_SERVICE_NAME': '0', 08:56:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:56:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:56:47 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)) 08:56:47 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)) 08:56:47 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)) 08:56:47 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)) 08:56:47 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)) 08:56:47 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)) 08:56:47 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)) 08:56:47 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)) 08:56:47 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)) 08:56:47 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)) 08:56:47 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)) 08:56:47 INFO - Cleaning up... 08:56:47 INFO - Return code: 0 08:56:47 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:56: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')]} 08:56:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:56:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:56: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')]} 08:56:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:56:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:56:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x103bcca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103c61618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc302d4eab0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103b30d30>, '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 0x103895db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103b28b20>, '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.LtgpIoBLRg/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.Iknv6o9QUC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/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 08:56:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 08:56:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 08:56:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LtgpIoBLRg/Render', 08:56:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:56:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:56:47 INFO - 'HOME': '/Users/cltbld', 08:56:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:56:47 INFO - 'LOGNAME': 'cltbld', 08:56:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:56:47 INFO - 'MOZ_NO_REMOTE': '1', 08:56:47 INFO - 'NO_EM_RESTART': '1', 08:56:47 INFO - 'PAGER': '/bin/cat', 08:56:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:56:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:56:47 INFO - 'PWD': '/builds/slave/test', 08:56:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:56:47 INFO - 'SHELL': '/bin/bash', 08:56:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Iknv6o9QUC/Listeners', 08:56:47 INFO - 'TMPDIR': '/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/', 08:56:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:56:47 INFO - 'USER': 'cltbld', 08:56:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:56:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:56:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:56:47 INFO - 'XPC_FLAGS': '0x0', 08:56:47 INFO - 'XPC_SERVICE_NAME': '0', 08:56:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:56:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:56:47 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:56:47 INFO - Cleaning up... 08:56:47 INFO - Return code: 0 08:56:47 INFO - Running post-action listener: _resource_record_post_action 08:56:47 INFO - Running post-action listener: _start_resource_monitoring 08:56:47 INFO - Starting resource monitoring. 08:56:47 INFO - [mozharness: 2016-08-04 15:56:47.540466Z] Finished create-virtualenv step (success) 08:56:47 INFO - [mozharness: 2016-08-04 15:56:47.541396Z] Running install step. 08:56:47 INFO - Running pre-action listener: _resource_record_pre_action 08:56:47 INFO - Running main action method: install 08:56:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:56:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:56:47 INFO - Reading from file tmpfile_stdout 08:56:47 INFO - Detecting whether we're running mozinstall >=1.0... 08:56:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:56:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:56:47 INFO - Reading from file tmpfile_stdout 08:56:47 INFO - Output received: 08:56:47 INFO - Usage: mozinstall [options] installer 08:56:47 INFO - Options: 08:56:47 INFO - -h, --help show this help message and exit 08:56:47 INFO - -d DEST, --destination=DEST 08:56:47 INFO - Directory to install application into. [default: 08:56:47 INFO - "/builds/slave/test"] 08:56:47 INFO - --app=APP Application being installed. [default: firefox] 08:56:47 INFO - mkdir: /builds/slave/test/build/application 08:56:47 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'] 08:56:47 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 08:57:22 INFO - Reading from file tmpfile_stdout 08:57:22 INFO - Output received: 08:57:22 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 08:57:22 INFO - Running post-action listener: _resource_record_post_action 08:57:22 INFO - [mozharness: 2016-08-04 15:57:22.266185Z] Finished install step (success) 08:57:22 INFO - [mozharness: 2016-08-04 15:57:22.266312Z] Running run-tests step. 08:57:22 INFO - Running pre-action listener: _resource_record_pre_action 08:57:22 INFO - Running main action method: run_tests 08:57:22 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:57:22 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:57:22 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:57:22 INFO - 2016-08-04 08:57:22.281 screenresolution[1640:7556] starting screenresolution argv=screenresolution get 08:57:22 INFO - 2016-08-04 08:57:22.283 screenresolution[1640:7556] Display 0: 1600x1200x32@60 08:57:22 INFO - 2016-08-04 08:57:22.289 screenresolution[1641:7558] starting screenresolution argv=screenresolution list 08:57:22 INFO - Available Modes on Display 0 08:57:22 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:57:22 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:57:22 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:57:22 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:57:22 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:57:22 INFO - Intel Iris: 08:57:22 INFO - Chipset Model: Intel Iris 08:57:22 INFO - Type: GPU 08:57:22 INFO - Bus: Built-In 08:57:22 INFO - VRAM (Dynamic, Max): 1536 MB 08:57:22 INFO - Vendor: Intel (0x8086) 08:57:22 INFO - Device ID: 0x0a2e 08:57:22 INFO - Revision ID: 0x0009 08:57:22 INFO - Displays: 08:57:22 INFO - Display: 08:57:22 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:57:22 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:57:22 INFO - Display Serial Number: 1600x1200 60 08:57:22 INFO - Main Display: Yes 08:57:22 INFO - Mirror: Off 08:57:22 INFO - Online: Yes 08:57:22 INFO - Rotation: Supported 08:57:22 INFO - Return code: 0 08:57:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:57:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:57:22 INFO - Python 2.7.3 08:57:22 INFO - Return code: 0 08:57:22 INFO - grabbing minidump binary from tooltool 08:57:22 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')]} 08:57:22 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 0x103b30d30>, '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 0x103895db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103b28b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:57:22 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 08:57:22 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 08:57:22 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 08:57:22 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:57:22 INFO - Return code: 0 08:57:22 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 08:57:22 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:57:22 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:57:22 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 08:57:22 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:57:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fbjJOKZMRIOpvfQ_91p8-g/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0120', '--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 08:57:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/fbjJOKZMRIOpvfQ_91p8-g/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0120 --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 08:57:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LtgpIoBLRg/Render', 08:57:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:57:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:57:22 INFO - 'HOME': '/Users/cltbld', 08:57:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:57:22 INFO - 'LOGNAME': 'cltbld', 08:57:22 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:57:22 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 08:57:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:57:22 INFO - 'MOZ_NO_REMOTE': '1', 08:57:22 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:57:22 INFO - 'NO_EM_RESTART': '1', 08:57:22 INFO - 'PAGER': '/bin/cat', 08:57:22 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:57:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:57:22 INFO - 'PWD': '/builds/slave/test', 08:57:22 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:57:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:57:22 INFO - 'SHELL': '/bin/bash', 08:57:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Iknv6o9QUC/Listeners', 08:57:22 INFO - 'TMPDIR': '/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/', 08:57:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:57:22 INFO - 'USER': 'cltbld', 08:57:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:57:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:57:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:57:22 INFO - 'XPC_FLAGS': '0x0', 08:57:22 INFO - 'XPC_SERVICE_NAME': '0', 08:57:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:57:22 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fbjJOKZMRIOpvfQ_91p8-g/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0120', '--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 08:57:22 INFO - mozversion application_buildid: 20160804065923 08:57:22 INFO - mozversion application_changeset: 0ba72e8027cfcbcbf3426770ac264a7ade2af090 08:57:22 INFO - mozversion application_display_name: Nightly 08:57:22 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:57:22 INFO - mozversion application_name: Firefox 08:57:22 INFO - mozversion application_remotingname: firefox 08:57:22 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 08:57:22 INFO - mozversion application_vendor: Mozilla 08:57:22 INFO - mozversion application_version: 51.0a1 08:57:22 INFO - mozversion platform_buildid: 20160804065923 08:57:22 INFO - mozversion platform_changeset: 0ba72e8027cfcbcbf3426770ac264a7ade2af090 08:57:22 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 08:57:22 INFO - mozversion platform_version: 51.0a1 08:57:22 INFO - using testdate: 1470326242 08:57:22 INFO - actual date: 1470326242 08:57:22 INFO - starting webserver on 'localhost:49271' 08:57:22 INFO - SUITE-START | Running 2 tests 08:57:22 INFO - TEST-START | dromaeo_css 08:57:22 INFO - operating with platform_type : mac_ 08:57:22 INFO - Initialising browser for dromaeo_css test... 08:57:22 INFO - TEST-INFO | started process 1651 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/tmpx0gO1n/profile http://localhost:49271/getInfo.html) 08:57:25 INFO - PROCESS | 1651 | __metrics Screen width/height:1600/1200 08:57:25 INFO - PROCESS | 1651 | colorDepth:24 08:57:25 INFO - PROCESS | 1651 | Browser inner width/height: 1024/689 08:57:25 INFO - PROCESS | 1651 | __metrics 08:57:25 ERROR - PROCESS | 1651 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 08:57:26 INFO - TEST-INFO | 1651: exit 0 08:57:26 INFO - Browser initialized. 08:57:26 INFO - Running cycle 1/1 for dromaeo_css test... 08:57:26 INFO - TEST-INFO | started process 1654 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/tmpx0gO1n/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:57:38 INFO - PROCESS | 1654 | RSS: Main: 254500864 08:57:38 INFO - PROCESS | 1654 | 08:58:28 INFO - PROCESS | 1654 | 1470326308194 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] 09:00:39 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49271/tests/dromaeo/cssquery-ext.html) 09:00:41 INFO - PROCESS | 1654 | RSS: Main: 269639680 09:00:41 INFO - PROCESS | 1654 | 09:03:43 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-ext.html (next: http://localhost:49271/tests/dromaeo/cssquery-jquery.html) 09:03:44 INFO - PROCESS | 1654 | RSS: Main: 279814144 09:03:44 INFO - PROCESS | 1654 | 09:06:46 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49271/tests/dromaeo/cssquery-mootools.html) 09:06:46 INFO - PROCESS | 1654 | RSS: Main: 287051776 09:06:46 INFO - PROCESS | 1654 | 09:09:48 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49271/tests/dromaeo/cssquery-prototype.html) 09:09:49 INFO - PROCESS | 1654 | RSS: Main: 287432704 09:09:49 INFO - PROCESS | 1654 | 09:12:51 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49271/tests/dromaeo/cssquery-yui.html) 09:12:52 INFO - PROCESS | 1654 | RSS: Main: 290971648 09:12:52 INFO - PROCESS | 1654 | 09:15:55 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-yui.html (next: http://localhost:49271/tests/dromaeo/cssquery-dojo.html) 09:15:55 INFO - PROCESS | 1654 | RSS: Main: 291643392 09:15:55 INFO - PROCESS | 1654 | 09:15:55 INFO - PROCESS | 1654 | __start_tp_report 09:15:55 INFO - PROCESS | 1654 | _x_x_mozilla_page_load 09:15:55 INFO - PROCESS | 1654 | _x_x_mozilla_page_load_details 09:15:55 INFO - PROCESS | 1654 | |i|pagename|runs| 09:15:55 INFO - PROCESS | 1654 | |0;dojo.html;3354.614219364774;3361.7814842035264;3385.1367901185195;3401.098708842157;3408.8466019029142;4890.755462226888;4943.382077240345;5595.55235581153;5614.101743721006;5670.754552039368;5496.285482887219;5532.197831314457;5651.8304450866435;5667.716614169296;5696;5023.648344615878;5073.086844368012;5164.6384753067305;5192.402873669538;5218.504242096995;5103.872403189913;5277.551408130314;5298.47015298469;5298.4966428189455;5302.761375738101;5066;5106;5197.818076367309;5220.582353411737;5231.189165679326;5155.742212889378;5178;5180.067587834188;5199.818006369759;5227.451117632631;4153.418521406975;5117.053345131163;5135.255387968761;5153.742312884378;5159.277701121846;5484.451554844523;5500.312460942382;5620.662760234399;5651.321841379061;5678.375378708339;6135.417135372132;6180.721867515973;6207;6210.099535567362;6222.43998040174;6237.688115594247;6262.279837818618;6264.812055638338;6272.6236425814595;6274.686265686697;4811.350467686888;5623.887522249573;5698.202251684767;5747.856303592402;5772.2667412721585;6237.4698150657705;6264.436200741864;6266.060090986297;6273.1844860167885;6274.215723034621;4644.535546445329;5665.838503106853;6056.212692349966;6148.200733904564;6176.104464852661;5215.757224393471;5574;5980.641161530322;6141.700809433414;6200.937990620127;5982.4914882234625;6104.20645316106;6118.619179173164;6138.173828368776;6154.107654390088;6145.508359331243;6202.162708034448;6203.7828675996125;6208.410201030895;6231.626102433868;3857.4406711026745;4797.928031079537;4905.092557876804;4913.091078150554;4921;4332.480102387671;4359.12817436514;4365.410669559569;4395.0111224974125;4412.271975124068;5679.2333035040565;5682.829515114553;5753.683547404849;5761.884762304814;5764.106563482667;6115.816525504242;6243.094751261133;6274.811755647338;6294.244690637152;6295.779647712308;5683.630564013409;5721.227634269404;5763.6541807491685;5795.072788353843;5840.787566838222;5360.678359298455;5412.188171774265;5416.593755468356;5423.972880135574;5436.320459942507;6199.969000154971;6327.746890124436;6350.047492876013;6350.936490635035;6354.809355719428;6174.938250617436;6186.381361863778;6207.689615519115;6237.8752424950335;6264.624122552661;4159.10579225468;6136.7726454708345;6270.686465676789;6283.96858015707;6315.463185629089;5376.978374108907;5402.594805389533;6033.396660333931;6179.62922224668;6194.969025154845;6148.200733904742;6149.41580549847;6206;6257.687115644108;6259.217597800275;6057.4765148655315;6085.665288409003;6089.330173680803;6100.664463454553;6111.388861113853;4930.457649658606;5941.554383421174;6051.12258722474;6072.05883088122;6108.4807791338235;5789.478946894799;5876.294844618673;5877.059670452707;5908.143319218775;5923.614965027259;6085.300190478151;6089;6102.786402476069;6107.144999699956;6123.418275263843;5676.063449530781;5929.822105336847;5948.613340132878;5949;5970.044792833126 09:15:55 INFO - PROCESS | 1654 | |1;ext.html;494.5969035236282;528.8757142071612;538.004691321056;543.782487005198;578.869754305281;39465.4080188797;41022.58977410225;41027.58972410275;41137.382939255935;41178.97052573687;41462.37806432906;41750.37374439386;42142.57857421425;42244.620430365496;42282.788586057104;9512.47681377524;9533.809323813553;9591.904080959172;9696.854547181798;9721.125098741111;9491.335606507548;9607.951960240189;9631.951840240788;9716.174125199366;9716.271279654018;9621.855672164887;9720.125188733013;9750.024997500264;9755.804883902354;9758.902410975907;9700.854487182698;9709.126178643884;9732.610695572168;9754.219662426989;9759.170470510051;9528.380655257386;9541.952290238505;9603.807923841485;9623.90376096237;9694.660686875926;39002.60997390018;39145.21709565793;39322;39334.21331573353;39776.80111599452;2876.755475784561;3119.2201949512623;3162.5414314924437;3331.566896303489;3336.199312165087;23632.763672363228;30728.692713072807;30975;30980.380392392028;31549.8422507886;3161.636411812648;3161.873525058995;3219.7263232625255;3249.756268279865;3259.7392208623255;379851;426654;436647;437783;438785;25440.363990900005;33406.49890251648;33765.662343376745;34034.31931361359;34082;29894;34637;34866.128346791535;35227.64772352244;35868.64131358705;14297.571072867831;14344.56966291013;14454.060486068372;14477.348519316656;14504.564863054125;12079.57721479744;12224.633261002184;12245.959093476977;12266.325352105541;12292.569760058355;7772.106207786064;7794.142644309121;7812.492188007761;7856.057273127261;7862;3117.957737681822;3259.152620318734;3265.379577880195;3271.2312606537444;3284.3431313737346;875.5140896802209;934.7522906429801;969.3747532841419;1048.9003544663244;1054.3515737821338;30426.782928682605;30765.538516922265;30922.690773092432;31176;31383.84308078445;1021.4790456867051;1110.211749657736;1137.9601713939971;1171.2386948483554;1190.3036723516839;15457.458988935557;15569.221538923235;15933.920330398505;15956.920215398848;16044.475774801374;701362;717366;717396;720171.7982820105;720315;59160.11259831106;59236.7038164815;59697;60141.69929150326;60231.69884150639;1328.1499840102342;1345.1525538910619;1365.3105181883284;1368.1380730139947;1370.1915869636762;29514.852425738594;30131.698683013765;30429.222284390482;30458;30496;51909.48090519047;52293.477065230385;52614.473855260956;52801.735991319794;52841.735791320796;611909;611921;611941;614108.9294553677;615895;26451.60322595201;26815.329616759736;27139.185824425298;27351.179464616092;27950.86024569864;46753.53246467628;47373.763131184125;47846;48123.5187648119;48584.757076214395;33723;39804.20391592094;40776.59223407728;40824.38763418492;41053.38419923644;39386.80306598449;39603.60396395999;40612.17245224031;40808.3878741825;40975.1804963905;35957.28085438329;37713.43429848499;38234.42648360221;39114.2177156461;39676;30967.380652387277;33116.1720956978;34147.829260853534;35331.293374131856;35506.467402989496;23769.72238865602;24079.916403762225;25863.353416164748;26405.339866502723;26865.597016045165 09:15:55 INFO - PROCESS | 1654 | |2;jquery.html;370.61456085670886;373.60584583264654;380.11054133328014;390.04633670675213;400.1357068731539;19653.803461965395;21929.12283508662;22081.33755987319;22093.447663808394;22871.771282287173;20906.790932090673;21019;21119.57760844782;21341.893290533524;21368.57262854742;5820.447057529538;7558.508696934709;7821.960890195541;7836.960815195916;7849.136594974549;7520.323170914617;7730.111037230706;7827.295543401093;7877.842443151134;7941.880871786928;7514.624268786566;7878.724244651438;7894.407919406068;7909.090454597708;7920.287174154325;7760.883586746203;7782.571958542278;7794.883076753853;7892.56590887501;7895.684172633145;7336.853262934765;7522.962385188039;7573.734919277799;7624.809379765495;7651.426143039294;29415;29460.55809162864;29540.852295738383;30136.8493157535;30348;2290.6678531612824;2341;2553;3418.1112910643164;3479.165000399911;16791.32834686611;17488.125593720262;17710.470997668195;18163.72754408685;18280.817191828177;2078.6985887046444;2119.491322082689;2144.9892750536146;2208;2378.5718570657273;109945;135880;136080;141544.99999999898;142735;19099.904500477685;20103.994800259927;21981;21987.780122198892;22280.554388912133;35441.936741897785;35528.28943421117;35531.28937421289;35582.75460358875;35818.64181358153;10557.630482933215;10560;10736.838947415796;10864.78270434587;10908.781824363468;8754.168354006359;8782.956085219534;8841.071687472722;8899.377043606886;8912.910870891208;9654.420734755937;9867.555959981819;9919.47053501367;10047.24645651579;10071.69784906454;3262.1945127190597;3779.6787273081545;3858.7298889077497;3878.437626544135;3887.067103895045;853.6116067189414;873.9912600874037;880.7489865388334;894.8568229083315;1054.9894501054891;21568.676469852966;22110.22614208495;22111.778882211293;22118.557628847655;22218.444538886335;921.1111277617132;923.630547780893;935.3312381647019;944.2210176604328;986.7237173591406;9051.59267832949;11650.475728592233;11718.824217636742;11807.17349785524;11815.291082535075;597418;615280;620790;624319;631264;99532.00467995372;102537;130341.34829325792;131314;133945;898.1467605774541;967.4437198610686;972.863799068131;1022.325265324882;1022.5654097008742;19305.51736206606;19499.902500487406;19596.90201548983;19601.80398196057;19625.90187049113;43993.560064398946;56486.43513564812;57340;57498.85002299847;57575.7121214408;78771;81195.18804811877;82028;85808;86526;7097;7822.161791978994;7994.88071669955;8439.409241353047;8572.142785721378;11564.595239166925;13235.735285294433;13237;13464.124831886287;13829.654258643614;11365.48855301497;11366.829497557377;11636.825447618123;11657.417129143678;11851.229670071418;9663.371880827724;11301.830472542753;11435.428228588371;11660.941695291469;11722.648320550397;11238.157138214503;11492.712682183012;11926.940365298118;11994.160408771302;12001.099917506397;6494.577852439576;7252.2747725227055;7616.276453736886;7749.573773442515;8644.005939316807;8697.173768491983;10935.773946685906;11649.650510484698;11891;11927.76144477123 09:15:55 INFO - PROCESS | 1654 | |3;mootools.html;1521.246982743542;1551.8448155184483;1714.3571160814695;1809.095452273863;1843.714224295233;7861.646225919833;8313.334933205337;8705.825883482326;8846.248068914134;8894.555272236386;7134.001239826429;8703.042665306826;8742.475451472916;8750;8760.299176065915;2307.273208939187;2358;2362.244081893795;2365.06579900939;2370.431096536827;2343.5547246023284;2366.7751563601432;2384.1655420602824;2387.6776635154292;2399.460121472672;2354.0348457132577;2360.5160942006846;2368.881555922197;2376.5603363377745;2380.750021247761;2284.2804516577226;2296.5866144094057;2335.1710142899283;2348.295511346589;2363.444590521226;2314.201600447843;2320.042255065126;2340.2394221877958;2343.367290831483;2348.4481146930457;8713.99789024264;8777;8849.867251991225;8862.379633425662;8866.689665861664;5162.328897243335;5339;5343.599230057761;5344.064788661969;5368.892622147574;3541.274038822061;3586.3544561978833;3592.6586974237407;3651.94522082169;3715.294094122108;1065.488565488562;1076.1659713721929;1085.3108276244564;1091.0507858163448;1100.1583788401879;11492.195546311761;11514.999999999916;11522.884771152349;11568.595099171489;11596;4517.977410112929;4625.7687115644085;4763.928541071887;4769.57073863354;4792.832250871273;9776.755581110529;9817.803643927082;9869.407835529892;9870.21038316933;9893.01069893005;5286.180642000496;5297;5334.359876814807;5337.839864804062;5337.946620533745;4372.912541749147;4709.693869898446;4820.71075735457;4858.368412106403;4905.264210368402;3848.2111167210655;3924.9215015700097;3939.995301198176;3989.1822176453757;4007.73949693269;1273.796192609178;1286.5947226623584;1289.7356042011365;1301.8763217494322;1318.4660212613908;904.3985749476525;916.2944532709777;918.4672889724078;942.820864035831;952.3666761603595;5574.693391863405;5785.1322301654245;5954.136650185786;5979.730912108966;6060.151578778975;423.9067405170919;434.2379124636243;440.5660424481883;442.78967490442426;446.2257982400532;3940.9211815764097;3970.5433875104154;4016.365189503504;4025.094353770437;4053.7365071270274;9172.403793753385;10297.53661085253;10753.623623173151;10792.730181745519;10800.135989120852;9015.14356136166;10384.32501887375;10676.145908327315;10688.89311106879;10718.785624287471;7856.489328193649;8072.677092916218;8163.3061189798345;8226;8262.586870656323;5164.535191832753;5182.792688292426;5838.883222335615;5895.498882595028;6128.846778830387;9580.987992521648;9816.85274720894;9882.505874706092;9988.500574971367;10025;8586.398952073296;9772.560234789593;9997.400155990665;10162.187025038127;10169.338992965433;6903.102596662402;7362.7423040193335;7519.248075192437;7533.660985255567;7623.047119110111;8310.750677479686;8347.791305217419;8407.831843362976;8462.407631465738;8511.233988941025;6453.774117905851;7392.371648409945;7510.699572017276;7604.923950760643;7612.619369031416;6389.808305750835;7194.4244460442;7294.854102918018;7347.375473084848;7386.778396648109;6924.896126558005;6952.756653517103;7039.8944015840825;7039.964800175966;7044.436445084279;4848.17581011236;4936.901261974812;4979.850604481871;4999.850004499871;5058.1401161803315;5006.299118123538;5028.270900719448;5093.414257360303;5104.795808167632;5115.769790359517 09:15:55 INFO - PROCESS | 1654 | |4;prototype.html;288.2462360926177;301.5356351219122;306.75304885639883;306.97237248647616;307.45273413324276;5190.818321358754;5329.813456529022;5418.891622167559;5457.045017122003;5487.259220005303;5352.732363381835;5359.839204823852;5371.5165635092835;5412.756425960832;5429.592780541465;3547.840347184383;4077.67378609712;4170.812313445902;4174.624283814456;4186.56041115683;3811.8284677189595;4030.2544029354663;4161.750294982311;4184.476940382452;4198.265303571878;3516.6483351664756;3648.306821703881;3721.776693398391;4016.7790771507557;4050.2102090092444;4025.37606670965;4036.3138266494766;4042.555318914917;4080.6531444827224;4099.467069280974;3343.565336506263;3516.525269088666;3521.7710848794745;3526.994806480141;3527;3774.7735135891658;5209.322788037569;5232.848773269875;5232.8691782705355;5252.8686782830355;4278.593533614302;4644.419447569054;4646.372739680134;4649.442066951953;4661.021185551039;5034.84895453137;5073.695578265316;5249.47505249472;5720.456556627156;5749.022666146765;3221.5650887130173;3547;3805.5243094613174;3846.9230615387537;3859.649122807023;4951.861071953471;4959.70241785494;5902.852428689274;5936.456521304449;5953.910691339634;3734.439834024918;3884.8446062157195;3885.747426417274;3892.5718171001167;3910.393888947218;3673.430618254175;3906.7851268179957;3951.130751234724;3970.2729312749047;3975.2447035063246;3838.852141244153;4591.609713174417;4606.262997920317;4621.353010578522;4634.189016922025;5146.228065790161;5324.334458192726;5750.769969201185;5760.9630266551585;5781.392953739881;1167.3871217610822;1234.925904445736;1268.086977376306;1323.782120449189;1345.6677888889928;843.4559708987669;873.8470767615642;885.9557022148866;909.7680091576606;914.2274777812737;4437.489688685778;4571;4927.620266325434;5077.365329333833;5200.323957885526;4972.602191824718;5764.913526297109;5773.653580785166;5782.739776710058;5811.651300921958;4530.320451932236;4619.722816631013;4845.515448455197;5018.2974383586325;5236.39781425141;2227.4208705736623;2407.65089062085;2563.8077144214258;2606.4265861510817;2629.500394924958;4578.061497393093;5063.468335824759;5080.672159735379;5112.488751124858;5121.948780512222;4323.681277210481;4472.127935052634;4724.574788269072;4955.529224723646;5031;4632.050429661978;5008.923081537414;5032.572231360302;5050.949490505048;5102.489751024942;4752.465360129821;4901.941184702362;4917.459079501324;4918.2376731606655;4929.630277729257;4014.313988125053;4158.234773875339;4288.871333859989;4593.3339665748945;4869.366982292279;4433.958019865265;4864.148773964472;4982.555059032985;5051.823186188466;5091.439941606346;3098.5816914717125;3381.18851475649;3383.4755612880044;3401.4829026520692;3423.3495635829113;4369.962875801288;4773.474917758975;4777.9044419112115;4929.728864912321;5559.666420014651;4759.6668233223345;4940.456549779449;5274.12976858814;5283.973580132075;5631.521320687787;4818.6626936114135;5618.522425593706;5676.233708449472;5676.432356764456;5690.317161940594;4431.601155895984;5520.171974203901;5556.72216389187;5566.775309431919;5599.636023658449;4859.416869975626;5644.238027866186;5644.491995720405;5685.971570142288;5711.914321285267;5534.889302214014;5537.5569954404355;5552.222688823649;5573.581981351496;5612.691301978431 09:15:55 INFO - PROCESS | 1654 | |5;yui.html;708.5925592784149;730.3645828129528;742.1317059040922;785.9371250299977;821.3018933906177;15330.69338613227;15333.386664533433;15423.228838558069;15788.763168552467;15900.966437181589;14258.358373873174;14274.714505709879;14381.065230759994;14402.207878566674;14420.711585768278;565.2199964049606;840.8444437779;841.3521588376962;855.8844555984956;864.7319331007376;851.1190917400492;864.6757465950269;869.5782545465444;873.7990262239689;875.011237301848;821.5686764448652;887.1439061305839;921.4056933278032;928.6239073175341;932.9626814927394;883.6465413834453;886.8758373827637;923.584387025841;924.6347692661428;925.9444433334022;659.152988409891;671.3957438305515;678.5996262205273;684.685044879356;686.6978529447027;14449.133052016912;14481.565553033426;14623.92688036553;14663.926680366636;14825.036372635852;12540.310282934435;12576.37118144089;14366.77882379999;14713.632159195999;14894.329755161043;11890.702732431671;12006.459709313101;12029.639110826689;12193.207441516273;12538.74922501554;3840.827162777654;3904.8047597620007;3911.2959667259884;3925.0776067624083;4075.3886916962692;93718;111067.86451982213;112721.43639281752;114160.85839141585;116944;9537.809243815085;10680.397940309016;10703.25077244601;10755.731106722395;10912.399818009926;21010.579788404146;21067.8946605266;21294;21310.78689213119;21339.35981920545;7426;7595.3164215220895;7604.800214135934;7802.336801371834;7810.6875724971505;4271.572842715704;4309.676774241944;4329.740215587075;4386.7367957922625;4528.954710452853;3400.1499625093725;3430.142464383904;3513.9648603513638;3517.9270322551865;3519.9472007919903;621.3879328861068;623.4856243599049;625.7403177681302;635.0601110356606;643.32129603269;534.5242733966772;589.0134025507258;626.764963138823;657.5035847934874;690.7099018412279;9458.716238512856;9475.668351607661;9529.523523823782;9541.52292385378;9589.90410095904;583.9795607153729;644.6261168522246;682.4915437998723;684.7637565040053;704.7145905908116;3838.769693610973;4416.66874984371;4457.821687132543;4559.224931761609;4666.580007799314;160174.19912900595;165827.1708641473;168670;169250;172923;116038.41980790043;116659.00045997267;142764;146195;149435;121584.99999999822;122526.38736806258;126969;129046.3670296578;129359;8999.280057595508;9027.36808423404;9083.227925626396;9136.63453461854;9157.816843663222;64317.03524447043;64696;65276.34723652893;66256;68337;62533.374666252756;92949.60575591236;99210;99777;102770;11795.823062654239;11826.231294965799;11934.462949167135;11988.820167697317;12263.570775022832;10773.24587278883;13452.192868427926;13454.394552245369;13465;13835.100718453268;12165.75668486643;12263.448144833683;12369.381530923598;12529.93735031319;12801.359932003177;11962.641120766391;12192.695182620506;12543.24740515572;12624;12667.80998285045;12237;12352.444140013542;12438.129330946747;12570.371481426075;12754.298513581842;8892.555372231493;10109.901039335797;10262.589496420358;10638.41488718128;10701.250912436366;9634.9036509634;9961;10063.899361006297;10749.247552671239;10806.945965270123 09:15:55 INFO - PROCESS | 1654 | __end_tp_report 09:15:55 INFO - PROCESS | 1654 | __start_cc_report 09:15:55 INFO - PROCESS | 1654 | _x_x_mozilla_cycle_collect,412 09:15:55 INFO - PROCESS | 1654 | __end_cc_report 09:15:55 INFO - PROCESS | 1654 | __startTimestamp1470327355838__endTimestamp 09:15:55 INFO - PROCESS | 1654 | 09:15:55 INFO - PROCESS | 1654 | ------- Summary: start ------- 09:15:55 INFO - PROCESS | 1654 | Number of tests: 6 09:15:55 INFO - PROCESS | 1654 | 09:15:55 INFO - PROCESS | 1654 | [#0] dojo.html Cycles:165 Average:5639.28 Median:5789.48 stddev:677.33 (11.7%) stddev-sans-first:655.26 09:15:55 INFO - PROCESS | 1654 | Values: 3354.6 3361.8 3385.1 3401.1 3408.8 4890.8 4943.4 5595.6 5614.1 5670.8 5496.3 5532.2 5651.8 5667.7 5696.0 5023.6 5073.1 5164.6 5192.4 5218.5 5103.9 5277.6 5298.5 5298.5 5302.8 5066.0 5106.0 5197.8 5220.6 5231.2 5155.7 5178.0 5180.1 5199.8 5227.5 4153.4 5117.1 5135.3 5153.7 5159.3 5484.5 5500.3 5620.7 5651.3 5678.4 6135.4 6180.7 6207.0 6210.1 6222.4 6237.7 6262.3 6264.8 6272.6 6274.7 4811.4 5623.9 5698.2 5747.9 5772.3 6237.5 6264.4 6266.1 6273.2 6274.2 4644.5 5665.8 6056.2 6148.2 6176.1 5215.8 5574.0 5980.6 6141.7 6200.9 5982.5 6104.2 6118.6 6138.2 6154.1 6145.5 6202.2 6203.8 6208.4 6231.6 3857.4 4797.9 4905.1 4913.1 4921.0 4332.5 4359.1 4365.4 4395.0 4412.3 5679.2 5682.8 5753.7 5761.9 5764.1 6115.8 6243.1 6274.8 6294.2 6295.8 5683.6 5721.2 5763.7 5795.1 5840.8 5360.7 5412.2 5416.6 5424.0 5436.3 6200.0 6327.7 6350.0 6350.9 6354.8 6174.9 6186.4 6207.7 6237.9 6264.6 4159.1 6136.8 6270.7 6284.0 6315.5 5377.0 5402.6 6033.4 6179.6 6195.0 6148.2 6149.4 6206.0 6257.7 6259.2 6057.5 6085.7 6089.3 6100.7 6111.4 4930.5 5941.6 6051.1 6072.1 6108.5 5789.5 5876.3 5877.1 5908.1 5923.6 6085.3 6089.0 6102.8 6107.1 6123.4 5676.1 5929.8 5948.6 5949.0 5970.0 09:15:55 INFO - PROCESS | 1654 | 09:15:55 INFO - PROCESS | 1654 | [#1] ext.html Cycles:180 Average:69653.35 Median:39328.11 stddev:160318.55 (407.6%) stddev-sans-first:160684.19 09:15:55 INFO - PROCESS | 1654 | Values: 494.6 528.9 538.0 543.8 578.9 39465.4 41022.6 41027.6 41137.4 41179.0 41462.4 41750.4 42142.6 42244.6 42282.8 9512.5 9533.8 9591.9 9696.9 9721.1 9491.3 9608.0 9632.0 9716.2 9716.3 9621.9 9720.1 9750.0 9755.8 9758.9 9700.9 9709.1 9732.6 9754.2 9759.2 9528.4 9542.0 9603.8 9623.9 9694.7 39002.6 39145.2 39322.0 39334.2 39776.8 2876.8 3119.2 3162.5 3331.6 3336.2 23632.8 30728.7 30975.0 30980.4 31549.8 3161.6 3161.9 3219.7 3249.8 3259.7 379851.0 426654.0 436647.0 437783.0 438785.0 25440.4 33406.5 33765.7 34034.3 34082.0 29894.0 34637.0 34866.1 35227.6 35868.6 14297.6 14344.6 14454.1 14477.3 14504.6 12079.6 12224.6 12246.0 12266.3 12292.6 7772.1 7794.1 7812.5 7856.1 7862.0 3118.0 3259.2 3265.4 3271.2 3284.3 875.5 934.8 969.4 1048.9 1054.4 30426.8 30765.5 30922.7 31176.0 31383.8 1021.5 1110.2 1138.0 1171.2 1190.3 15457.5 15569.2 15933.9 15956.9 16044.5 701362.0 717366.0 717396.0 720171.8 720315.0 59160.1 59236.7 59697.0 60141.7 60231.7 1328.1 1345.2 1365.3 1368.1 1370.2 29514.9 30131.7 30429.2 30458.0 30496.0 51909.5 52293.5 52614.5 52801.7 52841.7 611909.0 611921.0 611941.0 614108.9 615895.0 26451.6 26815.3 27139.2 27351.2 27950.9 46753.5 47373.8 47846.0 48123.5 48584.8 33723.0 39804.2 40776.6 40824.4 41053.4 39386.8 39603.6 40612.2 40808.4 40975.2 35957.3 37713.4 38234.4 39114.2 39676.0 30967.4 33116.2 34147.8 35331.3 35506.5 23769.7 24079.9 25863.4 26405.3 26865.6 09:15:55 INFO - PROCESS | 1654 | 09:15:55 INFO - PROCESS | 1654 | [#2] jquery.html Cycles:180 Average:37823.99 Median:3448.64 stddev:102873.98 (2983.0%) stddev-sans-first:103124.13 09:15:55 INFO - PROCESS | 1654 | Values: 370.6 373.6 380.1 390.0 400.1 19653.8 21929.1 22081.3 22093.4 22871.8 20906.8 21019.0 21119.6 21341.9 21368.6 5820.4 7558.5 7822.0 7837.0 7849.1 7520.3 7730.1 7827.3 7877.8 7941.9 7514.6 7878.7 7894.4 7909.1 7920.3 7760.9 7782.6 7794.9 7892.6 7895.7 7336.9 7523.0 7573.7 7624.8 7651.4 29415.0 29460.6 29540.9 30136.8 30348.0 2290.7 2341.0 2553.0 3418.1 3479.2 16791.3 17488.1 17710.5 18163.7 18280.8 2078.7 2119.5 2145.0 2208.0 2378.6 109945.0 135880.0 136080.0 141545.0 142735.0 19099.9 20104.0 21981.0 21987.8 22280.6 35441.9 35528.3 35531.3 35582.8 35818.6 10557.6 10560.0 10736.8 10864.8 10908.8 8754.2 8783.0 8841.1 8899.4 8912.9 9654.4 9867.6 9919.5 10047.2 10071.7 3262.2 3779.7 3858.7 3878.4 3887.1 853.6 874.0 880.7 894.9 1055.0 21568.7 22110.2 22111.8 22118.6 22218.4 921.1 923.6 935.3 944.2 986.7 9051.6 11650.5 11718.8 11807.2 11815.3 597418.0 615280.0 620790.0 624319.0 631264.0 99532.0 102537.0 130341.3 131314.0 133945.0 898.1 967.4 972.9 1022.3 1022.6 19305.5 19499.9 19596.9 19601.8 19625.9 43993.6 56486.4 57340.0 57498.9 57575.7 78771.0 81195.2 82028.0 85808.0 86526.0 7097.0 7822.2 7994.9 8439.4 8572.1 11564.6 13235.7 13237.0 13464.1 13829.7 11365.5 11366.8 11636.8 11657.4 11851.2 9663.4 11301.8 11435.4 11660.9 11722.6 11238.2 11492.7 11926.9 11994.2 12001.1 6494.6 7252.3 7616.3 7749.6 8644.0 8697.2 10935.8 11649.7 11891.0 11927.8 09:15:55 INFO - PROCESS | 1654 | 09:15:55 INFO - PROCESS | 1654 | [#3] mootools.html Cycles:180 Average:5641.64 Median:5017.29 stddev:3146.30 (62.7%) stddev-sans-first:3139.89 09:15:55 INFO - PROCESS | 1654 | Values: 1521.2 1551.8 1714.4 1809.1 1843.7 7861.6 8313.3 8705.8 8846.2 8894.6 7134.0 8703.0 8742.5 8750.0 8760.3 2307.3 2358.0 2362.2 2365.1 2370.4 2343.6 2366.8 2384.2 2387.7 2399.5 2354.0 2360.5 2368.9 2376.6 2380.8 2284.3 2296.6 2335.2 2348.3 2363.4 2314.2 2320.0 2340.2 2343.4 2348.4 8714.0 8777.0 8849.9 8862.4 8866.7 5162.3 5339.0 5343.6 5344.1 5368.9 3541.3 3586.4 3592.7 3651.9 3715.3 1065.5 1076.2 1085.3 1091.1 1100.2 11492.2 11515.0 11522.9 11568.6 11596.0 4518.0 4625.8 4763.9 4769.6 4792.8 9776.8 9817.8 9869.4 9870.2 9893.0 5286.2 5297.0 5334.4 5337.8 5337.9 4372.9 4709.7 4820.7 4858.4 4905.3 3848.2 3924.9 3940.0 3989.2 4007.7 1273.8 1286.6 1289.7 1301.9 1318.5 904.4 916.3 918.5 942.8 952.4 5574.7 5785.1 5954.1 5979.7 6060.2 423.9 434.2 440.6 442.8 446.2 3940.9 3970.5 4016.4 4025.1 4053.7 9172.4 10297.5 10753.6 10792.7 10800.1 9015.1 10384.3 10676.1 10688.9 10718.8 7856.5 8072.7 8163.3 8226.0 8262.6 5164.5 5182.8 5838.9 5895.5 6128.8 9581.0 9816.9 9882.5 9988.5 10025.0 8586.4 9772.6 9997.4 10162.2 10169.3 6903.1 7362.7 7519.2 7533.7 7623.0 8310.8 8347.8 8407.8 8462.4 8511.2 6453.8 7392.4 7510.7 7604.9 7612.6 6389.8 7194.4 7294.9 7347.4 7386.8 6924.9 6952.8 7039.9 7040.0 7044.4 4848.2 4936.9 4979.9 4999.9 5058.1 5006.3 5028.3 5093.4 5104.8 5115.8 09:15:55 INFO - PROCESS | 1654 | 09:15:55 INFO - PROCESS | 1654 | [#4] prototype.html Cycles:180 Average:4345.03 Median:4798.28 stddev:1327.24 (27.7%) stddev-sans-first:1295.57 09:15:55 INFO - PROCESS | 1654 | Values: 288.2 301.5 306.8 307.0 307.5 5190.8 5329.8 5418.9 5457.0 5487.3 5352.7 5359.8 5371.5 5412.8 5429.6 3547.8 4077.7 4170.8 4174.6 4186.6 3811.8 4030.3 4161.8 4184.5 4198.3 3516.6 3648.3 3721.8 4016.8 4050.2 4025.4 4036.3 4042.6 4080.7 4099.5 3343.6 3516.5 3521.8 3527.0 3527.0 3774.8 5209.3 5232.8 5232.9 5252.9 4278.6 4644.4 4646.4 4649.4 4661.0 5034.8 5073.7 5249.5 5720.5 5749.0 3221.6 3547.0 3805.5 3846.9 3859.6 4951.9 4959.7 5902.9 5936.5 5953.9 3734.4 3884.8 3885.7 3892.6 3910.4 3673.4 3906.8 3951.1 3970.3 3975.2 3838.9 4591.6 4606.3 4621.4 4634.2 5146.2 5324.3 5750.8 5761.0 5781.4 1167.4 1234.9 1268.1 1323.8 1345.7 843.5 873.8 886.0 909.8 914.2 4437.5 4571.0 4927.6 5077.4 5200.3 4972.6 5764.9 5773.7 5782.7 5811.7 4530.3 4619.7 4845.5 5018.3 5236.4 2227.4 2407.7 2563.8 2606.4 2629.5 4578.1 5063.5 5080.7 5112.5 5121.9 4323.7 4472.1 4724.6 4955.5 5031.0 4632.1 5008.9 5032.6 5050.9 5102.5 4752.5 4901.9 4917.5 4918.2 4929.6 4014.3 4158.2 4288.9 4593.3 4869.4 4434.0 4864.1 4982.6 5051.8 5091.4 3098.6 3381.2 3383.5 3401.5 3423.3 4370.0 4773.5 4777.9 4929.7 5559.7 4759.7 4940.5 5274.1 5284.0 5631.5 4818.7 5618.5 5676.2 5676.4 5690.3 4431.6 5520.2 5556.7 5566.8 5599.6 4859.4 5644.2 5644.5 5686.0 5711.9 5534.9 5537.6 5552.2 5573.6 5612.7 09:15:55 INFO - PROCESS | 1654 | 09:15:55 INFO - PROCESS | 1654 | [#5] yui.html Cycles:180 Average:25790.32 Median:3679.36 stddev:42951.27 (1167.4%) stddev-sans-first:43030.47 09:15:55 INFO - PROCESS | 1654 | Values: 708.6 730.4 742.1 785.9 821.3 15330.7 15333.4 15423.2 15788.8 15901.0 14258.4 14274.7 14381.1 14402.2 14420.7 565.2 840.8 841.4 855.9 864.7 851.1 864.7 869.6 873.8 875.0 821.6 887.1 921.4 928.6 933.0 883.6 886.9 923.6 924.6 925.9 659.2 671.4 678.6 684.7 686.7 14449.1 14481.6 14623.9 14663.9 14825.0 12540.3 12576.4 14366.8 14713.6 14894.3 11890.7 12006.5 12029.6 12193.2 12538.7 3840.8 3904.8 3911.3 3925.1 4075.4 93718.0 111067.9 112721.4 114160.9 116944.0 9537.8 10680.4 10703.3 10755.7 10912.4 21010.6 21067.9 21294.0 21310.8 21339.4 7426.0 7595.3 7604.8 7802.3 7810.7 4271.6 4309.7 4329.7 4386.7 4529.0 3400.1 3430.1 3514.0 3517.9 3519.9 621.4 623.5 625.7 635.1 643.3 534.5 589.0 626.8 657.5 690.7 9458.7 9475.7 9529.5 9541.5 9589.9 584.0 644.6 682.5 684.8 704.7 3838.8 4416.7 4457.8 4559.2 4666.6 160174.2 165827.2 168670.0 169250.0 172923.0 116038.4 116659.0 142764.0 146195.0 149435.0 121585.0 122526.4 126969.0 129046.4 129359.0 8999.3 9027.4 9083.2 9136.6 9157.8 64317.0 64696.0 65276.3 66256.0 68337.0 62533.4 92949.6 99210.0 99777.0 102770.0 11795.8 11826.2 11934.5 11988.8 12263.6 10773.2 13452.2 13454.4 13465.0 13835.1 12165.8 12263.4 12369.4 12529.9 12801.4 11962.6 12192.7 12543.2 12624.0 12667.8 12237.0 12352.4 12438.1 12570.4 12754.3 8892.6 10109.9 10262.6 10638.4 10701.3 9634.9 9961.0 10063.9 10749.2 10806.9 09:15:55 INFO - PROCESS | 1654 | -------- Summary: end -------- 09:15:55 INFO - PROCESS | 1654 | 09:15:56 INFO - TEST-INFO | 1654: exit 0 09:15:56 INFO - TEST-OK | dromaeo_css | took 1113551ms 09:15:56 INFO - TEST-START | kraken 09:15:56 INFO - operating with platform_type : mac_ 09:15:56 INFO - Initialising browser for kraken test... 09:15:56 INFO - TEST-INFO | started process 1665 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/tmpUIpall/profile http://localhost:49271/getInfo.html) 09:15:59 INFO - PROCESS | 1665 | __metrics Screen width/height:1600/1200 09:15:59 INFO - PROCESS | 1665 | colorDepth:24 09:15:59 INFO - PROCESS | 1665 | Browser inner width/height: 1024/689 09:15:59 INFO - PROCESS | 1665 | __metrics 09:15:59 ERROR - PROCESS | 1665 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 09:15:59 INFO - TEST-INFO | 1665: exit 0 09:15:59 INFO - Browser initialized. 09:15:59 INFO - Running cycle 1/1 for kraken test... 09:15:59 INFO - TEST-INFO | started process 1667 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/tmpUIpall/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:16:11 INFO - PROCESS | 1667 | RSS: Main: 254418944 09:16:11 INFO - PROCESS | 1667 | 09:16:14 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-beat-detection) 09:16:15 INFO - PROCESS | 1667 | RSS: Main: 267374592 09:16:15 INFO - PROCESS | 1667 | 09:16:18 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-dft) 09:16:18 INFO - PROCESS | 1667 | RSS: Main: 276045824 09:16:18 INFO - PROCESS | 1667 | 09:16:22 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-fft) 09:16:23 INFO - PROCESS | 1667 | RSS: Main: 278839296 09:16:23 INFO - PROCESS | 1667 | 09:16:25 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-oscillator) 09:16:25 INFO - PROCESS | 1667 | RSS: Main: 280350720 09:16:25 INFO - PROCESS | 1667 | 09:16:27 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:16:28 INFO - PROCESS | 1667 | RSS: Main: 282112000 09:16:28 INFO - PROCESS | 1667 | 09:16:31 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-darkroom) 09:16:31 INFO - PROCESS | 1667 | RSS: Main: 282210304 09:16:31 INFO - PROCESS | 1667 | 09:16:34 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-desaturate) 09:16:35 INFO - PROCESS | 1667 | RSS: Main: 281882624 09:16:35 INFO - PROCESS | 1667 | 09:16:38 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49271/tests/kraken/driver.html?testName=json-parse-financial) 09:16:39 INFO - PROCESS | 1667 | RSS: Main: 282570752 09:16:39 INFO - PROCESS | 1667 | 09:16:40 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49271/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:16:41 INFO - PROCESS | 1667 | RSS: Main: 282144768 09:16:41 INFO - PROCESS | 1667 | 09:16:43 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:16:43 INFO - PROCESS | 1667 | RSS: Main: 282710016 09:16:43 INFO - PROCESS | 1667 | 09:16:46 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:16:46 INFO - PROCESS | 1667 | RSS: Main: 282783744 09:16:46 INFO - PROCESS | 1667 | 09:16:49 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:16:50 INFO - PROCESS | 1667 | RSS: Main: 282750976 09:16:50 INFO - PROCESS | 1667 | 09:16:53 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:16:54 INFO - PROCESS | 1667 | RSS: Main: 283017216 09:16:54 INFO - PROCESS | 1667 | 09:16:55 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49271/tests/kraken/driver.html?testName=ai-astar) 09:16:55 INFO - PROCESS | 1667 | RSS: Main: 284155904 09:16:55 INFO - PROCESS | 1667 | 09:16:55 INFO - PROCESS | 1667 | __start_tp_report 09:16:55 INFO - PROCESS | 1667 | _x_x_mozilla_page_load 09:16:55 INFO - PROCESS | 1667 | _x_x_mozilla_page_load_details 09:16:55 INFO - PROCESS | 1667 | |i|pagename|runs| 09:16:55 INFO - PROCESS | 1667 | |0;ai-astar;103;118;109;118;116;117;115;117;116;117 09:16:55 INFO - PROCESS | 1667 | |1;audio-beat-detection;145;110;133;158;109;130;132;110;158;134 09:16:55 INFO - PROCESS | 1667 | |2;audio-dft;202;202;215;229;200;196;199;227;276;237 09:16:55 INFO - PROCESS | 1667 | |3;audio-fft;72;81;76;145;60;58;60;64;149;87 09:16:55 INFO - PROCESS | 1667 | |4;audio-oscillator;68;70;121;74;72;82;114;68;72;114 09:16:55 INFO - PROCESS | 1667 | |5;imaging-gaussian-blur;90;89;92;89;93;91;92;90;92;90 09:16:55 INFO - PROCESS | 1667 | |6;imaging-darkroom;102;97;144;97;96;97;96;115;131;97 09:16:55 INFO - PROCESS | 1667 | |7;imaging-desaturate;125;140;91;91;90;93;91;75;151;148 09:16:55 INFO - PROCESS | 1667 | |8;json-parse-financial;53;75;58;57;57;58;57;56;56;56 09:16:55 INFO - PROCESS | 1667 | |9;json-stringify-tinderbox;66;72;70;89;70;77;74;72;71;71 09:16:55 INFO - PROCESS | 1667 | |10;stanford-crypto-aes;74;77;76;106;105;73;99;109;104;107 09:16:55 INFO - PROCESS | 1667 | |11;stanford-crypto-ccm;156;129;152;156;154;145;152;140;159;158 09:16:55 INFO - PROCESS | 1667 | |12;stanford-crypto-pbkdf2;169;198;230;185;164;169;171;171;168;170 09:16:55 INFO - PROCESS | 1667 | |13;stanford-crypto-sha256-iterative;71;68;70;70;68;68;68;68;67;67 09:16:55 INFO - PROCESS | 1667 | __end_tp_report 09:16:55 INFO - PROCESS | 1667 | __start_cc_report 09:16:55 INFO - PROCESS | 1667 | _x_x_mozilla_cycle_collect,1070 09:16:55 INFO - PROCESS | 1667 | __end_cc_report 09:16:55 INFO - PROCESS | 1667 | __startTimestamp1470327415947__endTimestamp 09:16:55 INFO - PROCESS | 1667 | 09:16:55 INFO - PROCESS | 1667 | ------- Summary: start ------- 09:16:55 INFO - PROCESS | 1667 | Number of tests: 14 09:16:55 INFO - PROCESS | 1667 | 09:16:55 INFO - PROCESS | 1667 | [#0] ai-astar Cycles:10 Average:114.60 Median:117.00 stddev:4.84 (4.1%) stddev-sans-first:2.76 09:16:55 INFO - PROCESS | 1667 | Values: 103.0 118.0 109.0 118.0 116.0 117.0 115.0 117.0 116.0 117.0 09:16:55 INFO - PROCESS | 1667 | 09:16:55 INFO - PROCESS | 1667 | [#1] audio-beat-detection Cycles:10 Average:131.90 Median:133.50 stddev:18.34 (13.7%) stddev-sans-first:18.83 09:16:55 INFO - PROCESS | 1667 | Values: 145.0 110.0 133.0 158.0 109.0 130.0 132.0 110.0 158.0 134.0 09:16:55 INFO - PROCESS | 1667 | 09:16:55 INFO - PROCESS | 1667 | [#2] audio-dft Cycles:10 Average:218.30 Median:221.00 stddev:24.98 (11.3%) stddev-sans-first:25.79 09:16:55 INFO - PROCESS | 1667 | Values: 202.0 202.0 215.0 229.0 200.0 196.0 199.0 227.0 276.0 237.0 09:16:55 INFO - PROCESS | 1667 | 09:16:55 INFO - PROCESS | 1667 | [#3] audio-fft Cycles:10 Average:85.20 Median:68.00 stddev:33.97 (50.0%) stddev-sans-first:35.69 09:16:55 INFO - PROCESS | 1667 | Values: 72.0 81.0 76.0 145.0 60.0 58.0 60.0 64.0 149.0 87.0 09:16:55 INFO - PROCESS | 1667 | 09:16:55 INFO - PROCESS | 1667 | [#4] audio-oscillator Cycles:10 Average:85.50 Median:71.00 stddev:21.72 (30.6%) stddev-sans-first:22.10 09:16:55 INFO - PROCESS | 1667 | Values: 68.0 70.0 121.0 74.0 72.0 82.0 114.0 68.0 72.0 114.0 09:16:55 INFO - PROCESS | 1667 | 09:16:55 INFO - PROCESS | 1667 | [#5] imaging-gaussian-blur Cycles:10 Average:90.80 Median:91.50 stddev:1.40 (1.5%) stddev-sans-first:1.45 09:16:55 INFO - PROCESS | 1667 | Values: 90.0 89.0 92.0 89.0 93.0 91.0 92.0 90.0 92.0 90.0 09:16:55 INFO - PROCESS | 1667 | 09:16:55 INFO - PROCESS | 1667 | [#6] imaging-darkroom Cycles:10 Average:107.20 Median:96.50 stddev:17.24 (17.9%) stddev-sans-first:18.19 09:16:55 INFO - PROCESS | 1667 | Values: 102.0 97.0 144.0 97.0 96.0 97.0 96.0 115.0 131.0 97.0 09:16:55 INFO - PROCESS | 1667 | 09:16:55 INFO - PROCESS | 1667 | [#7] imaging-desaturate Cycles:10 Average:109.50 Median:90.50 stddev:28.37 (31.3%) stddev-sans-first:29.53 09:16:55 INFO - PROCESS | 1667 | Values: 125.0 140.0 91.0 91.0 90.0 93.0 91.0 75.0 151.0 148.0 09:16:55 INFO - PROCESS | 1667 | 09:16:55 INFO - PROCESS | 1667 | [#8] json-parse-financial Cycles:10 Average:58.30 Median:57.00 stddev:6.04 (10.6%) stddev-sans-first:6.09 09:16:55 INFO - PROCESS | 1667 | Values: 53.0 75.0 58.0 57.0 57.0 58.0 57.0 56.0 56.0 56.0 09:16:55 INFO - PROCESS | 1667 | 09:16:55 INFO - PROCESS | 1667 | [#9] json-stringify-tinderbox Cycles:10 Average:73.20 Median:72.00 stddev:6.23 (8.7%) stddev-sans-first:6.04 09:16:55 INFO - PROCESS | 1667 | Values: 66.0 72.0 70.0 89.0 70.0 77.0 74.0 72.0 71.0 71.0 09:16:55 INFO - PROCESS | 1667 | 09:16:55 INFO - PROCESS | 1667 | [#10] stanford-crypto-aes Cycles:10 Average:93.00 Median:73.50 stddev:15.73 (21.4%) stddev-sans-first:15.11 09:16:55 INFO - PROCESS | 1667 | Values: 74.0 77.0 76.0 106.0 105.0 73.0 99.0 109.0 104.0 107.0 09:16:55 INFO - PROCESS | 1667 | 09:16:55 INFO - PROCESS | 1667 | [#11] stanford-crypto-ccm Cycles:10 Average:150.10 Median:155.00 stddev:9.47 (6.1%) stddev-sans-first:9.80 09:16:55 INFO - PROCESS | 1667 | Values: 156.0 129.0 152.0 156.0 154.0 145.0 152.0 140.0 159.0 158.0 09:16:55 INFO - PROCESS | 1667 | 09:16:55 INFO - PROCESS | 1667 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:179.50 Median:171.00 stddev:20.41 (11.9%) stddev-sans-first:21.30 09:16:55 INFO - PROCESS | 1667 | Values: 169.0 198.0 230.0 185.0 164.0 169.0 171.0 171.0 168.0 170.0 09:16:55 INFO - PROCESS | 1667 | 09:16:55 INFO - PROCESS | 1667 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.50 Median:68.00 stddev:1.35 (2.0%) stddev-sans-first:1.09 09:16:55 INFO - PROCESS | 1667 | Values: 71.0 68.0 70.0 70.0 68.0 68.0 68.0 68.0 67.0 67.0 09:16:55 INFO - PROCESS | 1667 | -------- Summary: end -------- 09:16:55 INFO - PROCESS | 1667 | 09:16:56 INFO - TEST-INFO | 1667: exit 0 09:16:56 INFO - TEST-OK | kraken | took 60342ms 09:16:56 INFO - SUITE-END | took 1173s 09:16:57 INFO - Completed test suite (00:19:34) 09:16:57 INFO - javascript benchmark 09:16:57 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7363.14259962602, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3354.614219364774, 3361.7814842035264, 3385.1367901185195, 3401.098708842157, 3408.8466019029142, 4890.755462226888, 4943.382077240345, 5595.55235581153, 5614.101743721006, 5670.754552039368, 5496.285482887219, 5532.197831314457, 5651.8304450866435, 5667.716614169296, 5696.0, 5023.648344615878, 5073.086844368012, 5164.6384753067305, 5192.402873669538, 5218.504242096995, 5103.872403189913, 5277.551408130314, 5298.47015298469, 5298.4966428189455, 5302.761375738101, 5066.0, 5106.0, 5197.818076367309, 5220.582353411737, 5231.189165679326, 5155.742212889378, 5178.0, 5180.067587834188, 5199.818006369759, 5227.451117632631, 4153.418521406975, 5117.053345131163, 5135.255387968761, 5153.742312884378, 5159.277701121846, 5484.451554844523, 5500.312460942382, 5620.662760234399, 5651.321841379061, 5678.375378708339, 6135.417135372132, 6180.721867515973, 6207.0, 6210.099535567362, 6222.43998040174, 6237.688115594247, 6262.279837818618, 6264.812055638338, 6272.6236425814595, 6274.686265686697, 4811.350467686888, 5623.887522249573, 5698.202251684767, 5747.856303592402, 5772.2667412721585, 6237.4698150657705, 6264.436200741864, 6266.060090986297, 6273.1844860167885, 6274.215723034621, 4644.535546445329, 5665.838503106853, 6056.212692349966, 6148.200733904564, 6176.104464852661, 5215.757224393471, 5574.0, 5980.641161530322, 6141.700809433414, 6200.937990620127, 5982.4914882234625, 6104.20645316106, 6118.619179173164, 6138.173828368776, 6154.107654390088, 6145.508359331243, 6202.162708034448, 6203.7828675996125, 6208.410201030895, 6231.626102433868, 3857.4406711026745, 4797.928031079537, 4905.092557876804, 4913.091078150554, 4921.0, 4332.480102387671, 4359.12817436514, 4365.410669559569, 4395.0111224974125, 4412.271975124068, 5679.2333035040565, 5682.829515114553, 5753.683547404849, 5761.884762304814, 5764.106563482667, 6115.816525504242, 6243.094751261133, 6274.811755647338, 6294.244690637152, 6295.779647712308, 5683.630564013409, 5721.227634269404, 5763.6541807491685, 5795.072788353843, 5840.787566838222, 5360.678359298455, 5412.188171774265, 5416.593755468356, 5423.972880135574, 5436.320459942507, 6199.969000154971, 6327.746890124436, 6350.047492876013, 6350.936490635035, 6354.809355719428, 6174.938250617436, 6186.381361863778, 6207.689615519115, 6237.8752424950335, 6264.624122552661, 4159.10579225468, 6136.7726454708345, 6270.686465676789, 6283.96858015707, 6315.463185629089, 5376.978374108907, 5402.594805389533, 6033.396660333931, 6179.62922224668, 6194.969025154845, 6148.200733904742, 6149.41580549847, 6206.0, 6257.687115644108, 6259.217597800275, 6057.4765148655315, 6085.665288409003, 6089.330173680803, 6100.664463454553, 6111.388861113853, 4930.457649658606, 5941.554383421174, 6051.12258722474, 6072.05883088122, 6108.4807791338235, 5789.478946894799, 5876.294844618673, 5877.059670452707, 5908.143319218775, 5923.614965027259, 6085.300190478151, 6089.0, 6102.786402476069, 6107.144999699956, 6123.418275263843, 5676.063449530781, 5929.822105336847, 5948.613340132878, 5949.0, 5970.044792833126], "value": 5598.791765425829, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [494.5969035236282, 528.8757142071612, 538.004691321056, 543.782487005198, 578.869754305281, 39465.4080188797, 41022.58977410225, 41027.58972410275, 41137.382939255935, 41178.97052573687, 41462.37806432906, 41750.37374439386, 42142.57857421425, 42244.620430365496, 42282.788586057104, 9512.47681377524, 9533.809323813553, 9591.904080959172, 9696.854547181798, 9721.125098741111, 9491.335606507548, 9607.951960240189, 9631.951840240788, 9716.174125199366, 9716.271279654018, 9621.855672164887, 9720.125188733013, 9750.024997500264, 9755.804883902354, 9758.902410975907, 9700.854487182698, 9709.126178643884, 9732.610695572168, 9754.219662426989, 9759.170470510051, 9528.380655257386, 9541.952290238505, 9603.807923841485, 9623.90376096237, 9694.660686875926, 39002.60997390018, 39145.21709565793, 39322.0, 39334.21331573353, 39776.80111599452, 2876.755475784561, 3119.2201949512623, 3162.5414314924437, 3331.566896303489, 3336.199312165087, 23632.763672363228, 30728.692713072807, 30975.0, 30980.380392392028, 31549.8422507886, 3161.636411812648, 3161.873525058995, 3219.7263232625255, 3249.756268279865, 3259.7392208623255, 379851.0, 426654.0, 436647.0, 437783.0, 438785.0, 25440.363990900005, 33406.49890251648, 33765.662343376745, 34034.31931361359, 34082.0, 29894.0, 34637.0, 34866.128346791535, 35227.64772352244, 35868.64131358705, 14297.571072867831, 14344.56966291013, 14454.060486068372, 14477.348519316656, 14504.564863054125, 12079.57721479744, 12224.633261002184, 12245.959093476977, 12266.325352105541, 12292.569760058355, 7772.106207786064, 7794.142644309121, 7812.492188007761, 7856.057273127261, 7862.0, 3117.957737681822, 3259.152620318734, 3265.379577880195, 3271.2312606537444, 3284.3431313737346, 875.5140896802209, 934.7522906429801, 969.3747532841419, 1048.9003544663244, 1054.3515737821338, 30426.782928682605, 30765.538516922265, 30922.690773092432, 31176.0, 31383.84308078445, 1021.4790456867051, 1110.211749657736, 1137.9601713939971, 1171.2386948483554, 1190.3036723516839, 15457.458988935557, 15569.221538923235, 15933.920330398505, 15956.920215398848, 16044.475774801374, 701362.0, 717366.0, 717396.0, 720171.7982820105, 720315.0, 59160.11259831106, 59236.7038164815, 59697.0, 60141.69929150326, 60231.69884150639, 1328.1499840102342, 1345.1525538910619, 1365.3105181883284, 1368.1380730139947, 1370.1915869636762, 29514.852425738594, 30131.698683013765, 30429.222284390482, 30458.0, 30496.0, 51909.48090519047, 52293.477065230385, 52614.473855260956, 52801.735991319794, 52841.735791320796, 611909.0, 611921.0, 611941.0, 614108.9294553677, 615895.0, 26451.60322595201, 26815.329616759736, 27139.185824425298, 27351.179464616092, 27950.86024569864, 46753.53246467628, 47373.763131184125, 47846.0, 48123.5187648119, 48584.757076214395, 33723.0, 39804.20391592094, 40776.59223407728, 40824.38763418492, 41053.38419923644, 39386.80306598449, 39603.60396395999, 40612.17245224031, 40808.3878741825, 40975.1804963905, 35957.28085438329, 37713.43429848499, 38234.42648360221, 39114.2177156461, 39676.0, 30967.380652387277, 33116.1720956978, 34147.829260853534, 35331.293374131856, 35506.467402989496, 23769.72238865602, 24079.916403762225, 25863.353416164748, 26405.339866502723, 26865.597016045165], "value": 18462.06711154605, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [370.61456085670886, 373.60584583264654, 380.11054133328014, 390.04633670675213, 400.1357068731539, 19653.803461965395, 21929.12283508662, 22081.33755987319, 22093.447663808394, 22871.771282287173, 20906.790932090673, 21019.0, 21119.57760844782, 21341.893290533524, 21368.57262854742, 5820.447057529538, 7558.508696934709, 7821.960890195541, 7836.960815195916, 7849.136594974549, 7520.323170914617, 7730.111037230706, 7827.295543401093, 7877.842443151134, 7941.880871786928, 7514.624268786566, 7878.724244651438, 7894.407919406068, 7909.090454597708, 7920.287174154325, 7760.883586746203, 7782.571958542278, 7794.883076753853, 7892.56590887501, 7895.684172633145, 7336.853262934765, 7522.962385188039, 7573.734919277799, 7624.809379765495, 7651.426143039294, 29415.0, 29460.55809162864, 29540.852295738383, 30136.8493157535, 30348.0, 2290.6678531612824, 2341.0, 2553.0, 3418.1112910643164, 3479.165000399911, 16791.32834686611, 17488.125593720262, 17710.470997668195, 18163.72754408685, 18280.817191828177, 2078.6985887046444, 2119.491322082689, 2144.9892750536146, 2208.0, 2378.5718570657273, 109945.0, 135880.0, 136080.0, 141544.99999999898, 142735.0, 19099.904500477685, 20103.994800259927, 21981.0, 21987.780122198892, 22280.554388912133, 35441.936741897785, 35528.28943421117, 35531.28937421289, 35582.75460358875, 35818.64181358153, 10557.630482933215, 10560.0, 10736.838947415796, 10864.78270434587, 10908.781824363468, 8754.168354006359, 8782.956085219534, 8841.071687472722, 8899.377043606886, 8912.910870891208, 9654.420734755937, 9867.555959981819, 9919.47053501367, 10047.24645651579, 10071.69784906454, 3262.1945127190597, 3779.6787273081545, 3858.7298889077497, 3878.437626544135, 3887.067103895045, 853.6116067189414, 873.9912600874037, 880.7489865388334, 894.8568229083315, 1054.9894501054891, 21568.676469852966, 22110.22614208495, 22111.778882211293, 22118.557628847655, 22218.444538886335, 921.1111277617132, 923.630547780893, 935.3312381647019, 944.2210176604328, 986.7237173591406, 9051.59267832949, 11650.475728592233, 11718.824217636742, 11807.17349785524, 11815.291082535075, 597418.0, 615280.0, 620790.0, 624319.0, 631264.0, 99532.00467995372, 102537.0, 130341.34829325792, 131314.0, 133945.0, 898.1467605774541, 967.4437198610686, 972.863799068131, 1022.325265324882, 1022.5654097008742, 19305.51736206606, 19499.902500487406, 19596.90201548983, 19601.80398196057, 19625.90187049113, 43993.560064398946, 56486.43513564812, 57340.0, 57498.85002299847, 57575.7121214408, 78771.0, 81195.18804811877, 82028.0, 85808.0, 86526.0, 7097.0, 7822.161791978994, 7994.88071669955, 8439.409241353047, 8572.142785721378, 11564.595239166925, 13235.735285294433, 13237.0, 13464.124831886287, 13829.654258643614, 11365.48855301497, 11366.829497557377, 11636.825447618123, 11657.417129143678, 11851.229670071418, 9663.371880827724, 11301.830472542753, 11435.428228588371, 11660.941695291469, 11722.648320550397, 11238.157138214503, 11492.712682183012, 11926.940365298118, 11994.160408771302, 12001.099917506397, 6494.577852439576, 7252.2747725227055, 7616.276453736886, 7749.573773442515, 8644.005939316807, 8697.173768491983, 10935.773946685906, 11649.650510484698, 11891.0, 11927.76144477123], "value": 11347.677434002826, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1521.246982743542, 1551.8448155184483, 1714.3571160814695, 1809.095452273863, 1843.714224295233, 7861.646225919833, 8313.334933205337, 8705.825883482326, 8846.248068914134, 8894.555272236386, 7134.001239826429, 8703.042665306826, 8742.475451472916, 8750.0, 8760.299176065915, 2307.273208939187, 2358.0, 2362.244081893795, 2365.06579900939, 2370.431096536827, 2343.5547246023284, 2366.7751563601432, 2384.1655420602824, 2387.6776635154292, 2399.460121472672, 2354.0348457132577, 2360.5160942006846, 2368.881555922197, 2376.5603363377745, 2380.750021247761, 2284.2804516577226, 2296.5866144094057, 2335.1710142899283, 2348.295511346589, 2363.444590521226, 2314.201600447843, 2320.042255065126, 2340.2394221877958, 2343.367290831483, 2348.4481146930457, 8713.99789024264, 8777.0, 8849.867251991225, 8862.379633425662, 8866.689665861664, 5162.328897243335, 5339.0, 5343.599230057761, 5344.064788661969, 5368.892622147574, 3541.274038822061, 3586.3544561978833, 3592.6586974237407, 3651.94522082169, 3715.294094122108, 1065.488565488562, 1076.1659713721929, 1085.3108276244564, 1091.0507858163448, 1100.1583788401879, 11492.195546311761, 11514.999999999916, 11522.884771152349, 11568.595099171489, 11596.0, 4517.977410112929, 4625.7687115644085, 4763.928541071887, 4769.57073863354, 4792.832250871273, 9776.755581110529, 9817.803643927082, 9869.407835529892, 9870.21038316933, 9893.01069893005, 5286.180642000496, 5297.0, 5334.359876814807, 5337.839864804062, 5337.946620533745, 4372.912541749147, 4709.693869898446, 4820.71075735457, 4858.368412106403, 4905.264210368402, 3848.2111167210655, 3924.9215015700097, 3939.995301198176, 3989.1822176453757, 4007.73949693269, 1273.796192609178, 1286.5947226623584, 1289.7356042011365, 1301.8763217494322, 1318.4660212613908, 904.3985749476525, 916.2944532709777, 918.4672889724078, 942.820864035831, 952.3666761603595, 5574.693391863405, 5785.1322301654245, 5954.136650185786, 5979.730912108966, 6060.151578778975, 423.9067405170919, 434.2379124636243, 440.5660424481883, 442.78967490442426, 446.2257982400532, 3940.9211815764097, 3970.5433875104154, 4016.365189503504, 4025.094353770437, 4053.7365071270274, 9172.403793753385, 10297.53661085253, 10753.623623173151, 10792.730181745519, 10800.135989120852, 9015.14356136166, 10384.32501887375, 10676.145908327315, 10688.89311106879, 10718.785624287471, 7856.489328193649, 8072.677092916218, 8163.3061189798345, 8226.0, 8262.586870656323, 5164.535191832753, 5182.792688292426, 5838.883222335615, 5895.498882595028, 6128.846778830387, 9580.987992521648, 9816.85274720894, 9882.505874706092, 9988.500574971367, 10025.0, 8586.398952073296, 9772.560234789593, 9997.400155990665, 10162.187025038127, 10169.338992965433, 6903.102596662402, 7362.7423040193335, 7519.248075192437, 7533.660985255567, 7623.047119110111, 8310.750677479686, 8347.791305217419, 8407.831843362976, 8462.407631465738, 8511.233988941025, 6453.774117905851, 7392.371648409945, 7510.699572017276, 7604.923950760643, 7612.619369031416, 6389.808305750835, 7194.4244460442, 7294.854102918018, 7347.375473084848, 7386.778396648109, 6924.896126558005, 6952.756653517103, 7039.8944015840825, 7039.964800175966, 7044.436445084279, 4848.17581011236, 4936.901261974812, 4979.850604481871, 4999.850004499871, 5058.1401161803315, 5006.299118123538, 5028.270900719448, 5093.414257360303, 5104.795808167632, 5115.769790359517], "value": 4480.235210483039, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [288.2462360926177, 301.5356351219122, 306.75304885639883, 306.97237248647616, 307.45273413324276, 5190.818321358754, 5329.813456529022, 5418.891622167559, 5457.045017122003, 5487.259220005303, 5352.732363381835, 5359.839204823852, 5371.5165635092835, 5412.756425960832, 5429.592780541465, 3547.840347184383, 4077.67378609712, 4170.812313445902, 4174.624283814456, 4186.56041115683, 3811.8284677189595, 4030.2544029354663, 4161.750294982311, 4184.476940382452, 4198.265303571878, 3516.6483351664756, 3648.306821703881, 3721.776693398391, 4016.7790771507557, 4050.2102090092444, 4025.37606670965, 4036.3138266494766, 4042.555318914917, 4080.6531444827224, 4099.467069280974, 3343.565336506263, 3516.525269088666, 3521.7710848794745, 3526.994806480141, 3527.0, 3774.7735135891658, 5209.322788037569, 5232.848773269875, 5232.8691782705355, 5252.8686782830355, 4278.593533614302, 4644.419447569054, 4646.372739680134, 4649.442066951953, 4661.021185551039, 5034.84895453137, 5073.695578265316, 5249.47505249472, 5720.456556627156, 5749.022666146765, 3221.5650887130173, 3547.0, 3805.5243094613174, 3846.9230615387537, 3859.649122807023, 4951.861071953471, 4959.70241785494, 5902.852428689274, 5936.456521304449, 5953.910691339634, 3734.439834024918, 3884.8446062157195, 3885.747426417274, 3892.5718171001167, 3910.393888947218, 3673.430618254175, 3906.7851268179957, 3951.130751234724, 3970.2729312749047, 3975.2447035063246, 3838.852141244153, 4591.609713174417, 4606.262997920317, 4621.353010578522, 4634.189016922025, 5146.228065790161, 5324.334458192726, 5750.769969201185, 5760.9630266551585, 5781.392953739881, 1167.3871217610822, 1234.925904445736, 1268.086977376306, 1323.782120449189, 1345.6677888889928, 843.4559708987669, 873.8470767615642, 885.9557022148866, 909.7680091576606, 914.2274777812737, 4437.489688685778, 4571.0, 4927.620266325434, 5077.365329333833, 5200.323957885526, 4972.602191824718, 5764.913526297109, 5773.653580785166, 5782.739776710058, 5811.651300921958, 4530.320451932236, 4619.722816631013, 4845.515448455197, 5018.2974383586325, 5236.39781425141, 2227.4208705736623, 2407.65089062085, 2563.8077144214258, 2606.4265861510817, 2629.500394924958, 4578.061497393093, 5063.468335824759, 5080.672159735379, 5112.488751124858, 5121.948780512222, 4323.681277210481, 4472.127935052634, 4724.574788269072, 4955.529224723646, 5031.0, 4632.050429661978, 5008.923081537414, 5032.572231360302, 5050.949490505048, 5102.489751024942, 4752.465360129821, 4901.941184702362, 4917.459079501324, 4918.2376731606655, 4929.630277729257, 4014.313988125053, 4158.234773875339, 4288.871333859989, 4593.3339665748945, 4869.366982292279, 4433.958019865265, 4864.148773964472, 4982.555059032985, 5051.823186188466, 5091.439941606346, 3098.5816914717125, 3381.18851475649, 3383.4755612880044, 3401.4829026520692, 3423.3495635829113, 4369.962875801288, 4773.474917758975, 4777.9044419112115, 4929.728864912321, 5559.666420014651, 4759.6668233223345, 4940.456549779449, 5274.12976858814, 5283.973580132075, 5631.521320687787, 4818.6626936114135, 5618.522425593706, 5676.233708449472, 5676.432356764456, 5690.317161940594, 4431.601155895984, 5520.171974203901, 5556.72216389187, 5566.775309431919, 5599.636023658449, 4859.416869975626, 5644.238027866186, 5644.491995720405, 5685.971570142288, 5711.914321285267, 5534.889302214014, 5537.5569954404355, 5552.222688823649, 5573.581981351496, 5612.691301978431], "value": 3926.067136635757, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [708.5925592784149, 730.3645828129528, 742.1317059040922, 785.9371250299977, 821.3018933906177, 15330.69338613227, 15333.386664533433, 15423.228838558069, 15788.763168552467, 15900.966437181589, 14258.358373873174, 14274.714505709879, 14381.065230759994, 14402.207878566674, 14420.711585768278, 565.2199964049606, 840.8444437779, 841.3521588376962, 855.8844555984956, 864.7319331007376, 851.1190917400492, 864.6757465950269, 869.5782545465444, 873.7990262239689, 875.011237301848, 821.5686764448652, 887.1439061305839, 921.4056933278032, 928.6239073175341, 932.9626814927394, 883.6465413834453, 886.8758373827637, 923.584387025841, 924.6347692661428, 925.9444433334022, 659.152988409891, 671.3957438305515, 678.5996262205273, 684.685044879356, 686.6978529447027, 14449.133052016912, 14481.565553033426, 14623.92688036553, 14663.926680366636, 14825.036372635852, 12540.310282934435, 12576.37118144089, 14366.77882379999, 14713.632159195999, 14894.329755161043, 11890.702732431671, 12006.459709313101, 12029.639110826689, 12193.207441516273, 12538.74922501554, 3840.827162777654, 3904.8047597620007, 3911.2959667259884, 3925.0776067624083, 4075.3886916962692, 93718.0, 111067.86451982213, 112721.43639281752, 114160.85839141585, 116944.0, 9537.809243815085, 10680.397940309016, 10703.25077244601, 10755.731106722395, 10912.399818009926, 21010.579788404146, 21067.8946605266, 21294.0, 21310.78689213119, 21339.35981920545, 7426.0, 7595.3164215220895, 7604.800214135934, 7802.336801371834, 7810.6875724971505, 4271.572842715704, 4309.676774241944, 4329.740215587075, 4386.7367957922625, 4528.954710452853, 3400.1499625093725, 3430.142464383904, 3513.9648603513638, 3517.9270322551865, 3519.9472007919903, 621.3879328861068, 623.4856243599049, 625.7403177681302, 635.0601110356606, 643.32129603269, 534.5242733966772, 589.0134025507258, 626.764963138823, 657.5035847934874, 690.7099018412279, 9458.716238512856, 9475.668351607661, 9529.523523823782, 9541.52292385378, 9589.90410095904, 583.9795607153729, 644.6261168522246, 682.4915437998723, 684.7637565040053, 704.7145905908116, 3838.769693610973, 4416.66874984371, 4457.821687132543, 4559.224931761609, 4666.580007799314, 160174.19912900595, 165827.1708641473, 168670.0, 169250.0, 172923.0, 116038.41980790043, 116659.00045997267, 142764.0, 146195.0, 149435.0, 121584.99999999822, 122526.38736806258, 126969.0, 129046.3670296578, 129359.0, 8999.280057595508, 9027.36808423404, 9083.227925626396, 9136.63453461854, 9157.816843663222, 64317.03524447043, 64696.0, 65276.34723652893, 66256.0, 68337.0, 62533.374666252756, 92949.60575591236, 99210.0, 99777.0, 102770.0, 11795.823062654239, 11826.231294965799, 11934.462949167135, 11988.820167697317, 12263.570775022832, 10773.24587278883, 13452.192868427926, 13454.394552245369, 13465.0, 13835.100718453268, 12165.75668486643, 12263.448144833683, 12369.381530923598, 12529.93735031319, 12801.359932003177, 11962.641120766391, 12192.695182620506, 12543.24740515572, 12624.0, 12667.80998285045, 12237.0, 12352.444140013542, 12438.129330946747, 12570.371481426075, 12754.298513581842, 8892.555372231493, 10109.901039335797, 10262.589496420358, 10638.41488718128, 10701.250912436366, 9634.9036509634, 9961.0, 10063.899361006297, 10749.247552671239, 10806.945965270123], "value": 7723.06809731695, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1565.6, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 118.0, 109.0, 118.0, 116.0, 117.0, 115.0, 117.0, 116.0, 117.0], "value": 114.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 110.0, 133.0, 158.0, 109.0, 130.0, 132.0, 110.0, 158.0, 134.0], "value": 131.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [202.0, 202.0, 215.0, 229.0, 200.0, 196.0, 199.0, 227.0, 276.0, 237.0], "value": 218.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 81.0, 76.0, 145.0, 60.0, 58.0, 60.0, 64.0, 149.0, 87.0], "value": 85.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 70.0, 121.0, 74.0, 72.0, 82.0, 114.0, 68.0, 72.0, 114.0], "value": 85.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 89.0, 92.0, 89.0, 93.0, 91.0, 92.0, 90.0, 92.0, 90.0], "value": 90.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 97.0, 144.0, 97.0, 96.0, 97.0, 96.0, 115.0, 131.0, 97.0], "value": 107.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [125.0, 140.0, 91.0, 91.0, 90.0, 93.0, 91.0, 75.0, 151.0, 148.0], "value": 109.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 75.0, 58.0, 57.0, 57.0, 58.0, 57.0, 56.0, 56.0, 56.0], "value": 58.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 72.0, 70.0, 89.0, 70.0, 77.0, 74.0, 72.0, 71.0, 71.0], "value": 73.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 77.0, 76.0, 106.0, 105.0, 73.0, 99.0, 109.0, 104.0, 107.0], "value": 93.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 129.0, 152.0, 156.0, 154.0, 145.0, 152.0, 140.0, 159.0, 158.0], "value": 150.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 198.0, 230.0, 185.0, 164.0, 169.0, 171.0, 171.0, 168.0, 170.0], "value": 179.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 68.0, 70.0, 70.0, 68.0, 68.0, 68.0, 68.0, 67.0, 67.0], "value": 68.5, "unit": "score"}]}]} 09:16:57 INFO - Return code: 0 09:16:57 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:16:57 ERROR - # TBPL SUCCESS # 09:16:57 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:16:57 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:16:57 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:16:57 INFO - 2016-08-04 09:16:57.271 screenresolution[1672:10648] starting screenresolution argv=screenresolution get 09:16:57 INFO - 2016-08-04 09:16:57.274 screenresolution[1672:10648] Display 0: 1600x1200x32@60 09:16:57 INFO - 2016-08-04 09:16:57.279 screenresolution[1673:10652] starting screenresolution argv=screenresolution list 09:16:57 INFO - Available Modes on Display 0 09:16:57 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:16:57 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:16:57 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:16:57 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:16:57 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:16:57 INFO - Intel Iris: 09:16:57 INFO - Chipset Model: Intel Iris 09:16:57 INFO - Type: GPU 09:16:57 INFO - Bus: Built-In 09:16:57 INFO - VRAM (Dynamic, Max): 1536 MB 09:16:57 INFO - Vendor: Intel (0x8086) 09:16:57 INFO - Device ID: 0x0a2e 09:16:57 INFO - Revision ID: 0x0009 09:16:57 INFO - Displays: 09:16:57 INFO - Display: 09:16:57 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:16:57 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:16:57 INFO - Display Serial Number: 1600x1200 60 09:16:57 INFO - Main Display: Yes 09:16:57 INFO - Mirror: Off 09:16:57 INFO - Online: Yes 09:16:57 INFO - Rotation: Supported 09:16:57 INFO - Return code: 0 09:16:57 INFO - Running post-action listener: _resource_record_post_action 09:16:57 INFO - [mozharness: 2016-08-04 16:16:57.506057Z] Finished run-tests step (success) 09:16:57 INFO - Running post-run listener: _resource_record_post_run 09:16:57 INFO - Total resource usage - Wall time: 1209s; CPU: 55.0%; Read bytes: 38138880; Write bytes: 702607360; Read time: 386; Write time: 1961 09:16:57 INFO - TinderboxPrint: CPU usage
54.5% 09:16:57 INFO - TinderboxPrint: I/O read bytes / time
38,138,880 / 386 09:16:57 INFO - TinderboxPrint: I/O write bytes / time
702,607,360 / 1,961 09:16:57 INFO - TinderboxPrint: CPU idle
2,200.4 (45.5%) 09:16:57 INFO - TinderboxPrint: CPU system
978.6 (20.2%) 09:16:57 INFO - TinderboxPrint: CPU user
1,658.6 (34.3%) 09:16:57 INFO - TinderboxPrint: Swap in / out
440,967,168 / 0 09:16:57 INFO - install - Wall time: 35s; CPU: 55.0%; Read bytes: 388219392; Write bytes: 381904896; Read time: 29514; Write time: 640 09:16:57 INFO - run-tests - Wall time: 1175s; CPU: 55.0%; Read bytes: 37172224; Write bytes: 297531392; Read time: 370; Write time: 1274 09:16:57 INFO - Running post-run listener: _upload_blobber_files 09:16:57 INFO - Blob upload gear active. 09:16:57 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:16:57 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 09:16:57 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', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:16:57 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 Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:16:58 INFO - (blobuploader) - INFO - Open directory for files ... 09:16:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:16:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:16:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:16:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:16:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:16:59 INFO - (blobuploader) - INFO - Done attempting. 09:16:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:16:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:16:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:17:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:17:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:17:00 INFO - (blobuploader) - INFO - Done attempting. 09:17:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:17:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:17:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:17:03 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:17:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:17:03 INFO - (blobuploader) - INFO - Done attempting. 09:17:03 INFO - (blobuploader) - INFO - Iteration through files over. 09:17:03 INFO - Return code: 0 09:17:03 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:17:03 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:17:03 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/38191cc294ffdda793c749b86a765ea470585a280b2065e4b7172c506d400d4e892c054328ce28f44ceef5403e6fcfc72d981569cdc02331fc714a0e7bbb1864", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9cfb6b11c6cb3c6823af1691ae8655ffed668706fadedf652a0eabea2465192b0060be8349b913655c5baf151ff7923e3d151a5ae5ab9946d5fc223325477e62", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0a6f5c4d203feb35a1690fd723b20850a042816f7736c2be3dba8bc07fa9f7c63fed2def6f643dc62728d5b00a7a42bff4ef16c35353958b1c1e20bc486b4cfb"} 09:17:03 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:17:03 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:17:03 INFO - Contents: 09:17:03 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/38191cc294ffdda793c749b86a765ea470585a280b2065e4b7172c506d400d4e892c054328ce28f44ceef5403e6fcfc72d981569cdc02331fc714a0e7bbb1864", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9cfb6b11c6cb3c6823af1691ae8655ffed668706fadedf652a0eabea2465192b0060be8349b913655c5baf151ff7923e3d151a5ae5ab9946d5fc223325477e62", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0a6f5c4d203feb35a1690fd723b20850a042816f7736c2be3dba8bc07fa9f7c63fed2def6f643dc62728d5b00a7a42bff4ef16c35353958b1c1e20bc486b4cfb"} 09:17:03 INFO - Running post-run listener: copy_logs_to_upload_dir 09:17:03 INFO - Copying logs to upload dir... 09:17:03 INFO - mkdir: /builds/slave/test/build/upload/logs 09:17:03 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1264.625215 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2016-08-04 09:17:03.729322) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-04 09:17:03.732923) ========= 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.LtgpIoBLRg/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.Iknv6o9QUC/Listeners TMPDIR=/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/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/Firefox/sha512/38191cc294ffdda793c749b86a765ea470585a280b2065e4b7172c506d400d4e892c054328ce28f44ceef5403e6fcfc72d981569cdc02331fc714a0e7bbb1864", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9cfb6b11c6cb3c6823af1691ae8655ffed668706fadedf652a0eabea2465192b0060be8349b913655c5baf151ff7923e3d151a5ae5ab9946d5fc223325477e62", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0a6f5c4d203feb35a1690fd723b20850a042816f7736c2be3dba8bc07fa9f7c63fed2def6f643dc62728d5b00a7a42bff4ef16c35353958b1c1e20bc486b4cfb"} build_url:https://queue.taskcluster.net/v1/task/fbjJOKZMRIOpvfQ_91p8-g/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011147 build_url: 'https://queue.taskcluster.net/v1/task/fbjJOKZMRIOpvfQ_91p8-g/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/38191cc294ffdda793c749b86a765ea470585a280b2065e4b7172c506d400d4e892c054328ce28f44ceef5403e6fcfc72d981569cdc02331fc714a0e7bbb1864", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9cfb6b11c6cb3c6823af1691ae8655ffed668706fadedf652a0eabea2465192b0060be8349b913655c5baf151ff7923e3d151a5ae5ab9946d5fc223325477e62", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0a6f5c4d203feb35a1690fd723b20850a042816f7736c2be3dba8bc07fa9f7c63fed2def6f643dc62728d5b00a7a42bff4ef16c35353958b1c1e20bc486b4cfb"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-04 09:17:03.766090) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-04 09:17:03.766419) ========= 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.LtgpIoBLRg/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.Iknv6o9QUC/Listeners TMPDIR=/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/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.004772 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-04 09:17:03.815416) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-04 09:17:03.815740) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-04 09:17:03.816055) ========= ========= Total master_lag: 0.18 =========