builder: autoland_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0237 starttime: 1470768869.28 results: success (0) buildid: 20160809104420 builduid: c8e059b7d9dd407b89253f39cedbb055 revision: b47abe0917b074d95b7e240a8deda72bf4a71b84 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-09 11:54:29.282769) ========= master: http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-09 11:54:29.283364) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-09 11:54:29.283789) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-09 11:54:29.307842) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-09 11:54:29.308214) ========= 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.u0PW9wkOWx/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.ETnL0WfxrY/Listeners TMPDIR=/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-08-09 11:54:29-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 7.74M=0.001s 2016-08-09 11:54:29 (7.74 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.121545 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-09 11:54:29.451691) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-09 11:54:29.451974) ========= 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.u0PW9wkOWx/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.ETnL0WfxrY/Listeners TMPDIR=/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/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.020885 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-09 11:54:29.500107) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2016-08-09 11:54:29.500432) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev b47abe0917b074d95b7e240a8deda72bf4a71b84 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/autoland --rev b47abe0917b074d95b7e240a8deda72bf4a71b84 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.u0PW9wkOWx/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.ETnL0WfxrY/Listeners TMPDIR=/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-08-09 11:54:29,577 truncating revision to first 12 chars 2016-08-09 11:54:29,577 Setting DEBUG logging. 2016-08-09 11:54:29,577 attempt 1/10 2016-08-09 11:54:29,577 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/b47abe0917b0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-09 11:54:31,082 unpacking tar archive at: autoland-b47abe0917b0/testing/mozharness/ program finished with exit code 0 elapsedTime=1.788352 ========= master_lag: 1.75 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2016-08-09 11:54:33.040265) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-09 11:54:33.040585) ========= script_repo_revision: b47abe0917b074d95b7e240a8deda72bf4a71b84 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-09 11:54:33.040964) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-09 11:54:33.041223) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-09 11:54:33.059648) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2016-08-09 11:54:33.059914) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland 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', '--add-option', '--webServer,localhost', '--branch-name', 'Autoland', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.u0PW9wkOWx/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.ETnL0WfxrY/Listeners TMPDIR=/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 11:54:33 INFO - MultiFileLogger online at 20160809 11:54:33 in /builds/slave/test 11:54:33 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland 11:54:33 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:54:33 INFO - {'append_to_log': False, 11:54:33 INFO - 'base_work_dir': '/builds/slave/test', 11:54:33 INFO - 'blob_upload_branch': 'Autoland', 11:54:33 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:54:33 INFO - 'branch': 'Autoland', 11:54:33 INFO - 'buildbot_json_path': 'buildprops.json', 11:54:33 INFO - 'config_files': ('talos/mac_config.py',), 11:54:33 INFO - 'default_actions': ('clobber', 11:54:33 INFO - 'read-buildbot-config', 11:54:33 INFO - 'download-and-extract', 11:54:33 INFO - 'populate-webroot', 11:54:33 INFO - 'create-virtualenv', 11:54:33 INFO - 'install', 11:54:33 INFO - 'run-tests'), 11:54:33 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:54:33 INFO - 'download_minidump_stackwalk': True, 11:54:33 INFO - 'download_symbols': 'ondemand', 11:54:33 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:54:33 INFO - 'tooltool.py': '/tools/tooltool.py', 11:54:33 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:54:33 INFO - '/tools/misc-python/virtualenv.py')}, 11:54:33 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:54:33 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:54:33 INFO - 'installer_path': 'installer.exe', 11:54:33 INFO - 'log_level': 'info', 11:54:33 INFO - 'log_name': 'talos', 11:54:33 INFO - 'log_to_console': True, 11:54:33 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 11:54:33 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 11:54:33 INFO - 'opt_config_files': (), 11:54:33 INFO - 'pip_index': False, 11:54:33 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 11:54:33 INFO - 'cmd': ('bash', 11:54:33 INFO - '-c', 11:54:33 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 11:54:33 INFO - 'enabled': True, 11:54:33 INFO - 'halt_on_failure': False, 11:54:33 INFO - 'name': 'check_screen_resolution'},), 11:54:33 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 11:54:33 INFO - 'cmd': ('bash', 11:54:33 INFO - '-c', 11:54:33 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 11:54:33 INFO - 'enabled': True, 11:54:33 INFO - 'halt_on_failure': False, 11:54:33 INFO - 'name': 'check_screen_resolution'},), 11:54:33 INFO - 'run_cmd_checks_enabled': True, 11:54:33 INFO - 'sps_profile': False, 11:54:33 INFO - 'sps_profile_interval': 0, 11:54:33 INFO - 'suite': 'dromaeojs', 11:54:33 INFO - 'system_bits': '32', 11:54:33 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:54:33 INFO - 'title': 't-yosemite-r7-0237', 11:54:33 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:54:33 INFO - 'use_talos_json': True, 11:54:33 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:54:33 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:54:33 INFO - 'work_dir': 'build'} 11:54:33 INFO - [mozharness: 2016-08-09 18:54:33.244913Z] Running clobber step. 11:54:33 INFO - Running pre-action listener: _resource_record_pre_action 11:54:33 INFO - Running main action method: clobber 11:54:33 INFO - rmtree: /builds/slave/test/build 11:54:33 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:54:33 INFO - Running post-action listener: _resource_record_post_action 11:54:33 INFO - [mozharness: 2016-08-09 18:54:33.430898Z] Finished clobber step (success) 11:54:33 INFO - [mozharness: 2016-08-09 18:54:33.431023Z] Running read-buildbot-config step. 11:54:33 INFO - Running pre-action listener: _resource_record_pre_action 11:54:33 INFO - Running main action method: read_buildbot_config 11:54:33 INFO - Using buildbot properties: 11:54:33 INFO - { 11:54:33 INFO - "project": "", 11:54:33 INFO - "product": "firefox", 11:54:33 INFO - "script_repo_revision": "production", 11:54:33 INFO - "builddir": "autoland_yosemite_r7_test-dromaeojs", 11:54:33 INFO - "repository": "", 11:54:33 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 autoland talos dromaeojs", 11:54:33 INFO - "buildid": "20160809104420", 11:54:33 INFO - "pgo_build": "False", 11:54:33 INFO - "basedir": "/builds/slave/test", 11:54:33 INFO - "buildnumber": 60, 11:54:33 INFO - "slavename": "t-yosemite-r7-0237", 11:54:33 INFO - "master": "http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/", 11:54:33 INFO - "platform": "yosemite_r7", 11:54:33 INFO - "scheduler": "tests-autoland-macosx64-talos", 11:54:33 INFO - "branch": "autoland", 11:54:33 INFO - "repo_path": "integration/autoland", 11:54:33 INFO - "revision": "b47abe0917b074d95b7e240a8deda72bf4a71b84", 11:54:33 INFO - "stage_platform": "macosx64", 11:54:33 INFO - "builduid": "c8e059b7d9dd407b89253f39cedbb055", 11:54:33 INFO - "slavebuilddir": "test" 11:54:33 INFO - } 11:54:33 INFO - Found installer url https://queue.taskcluster.net/v1/task/QMxP0Sx4R86BMwt6vqWRBg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg. 11:54:33 INFO - Running post-action listener: _resource_record_post_action 11:54:33 INFO - [mozharness: 2016-08-09 18:54:33.434291Z] Finished read-buildbot-config step (success) 11:54:33 INFO - [mozharness: 2016-08-09 18:54:33.434393Z] Running download-and-extract step. 11:54:33 INFO - Running pre-action listener: _resource_record_pre_action 11:54:33 INFO - Running main action method: download_and_extract 11:54:33 INFO - mkdir: /builds/slave/test/build/tests 11:54:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:54:33 INFO - trying https://queue.taskcluster.net/v1/task/QMxP0Sx4R86BMwt6vqWRBg/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json 11:54:33 INFO - Downloading https://queue.taskcluster.net/v1/task/QMxP0Sx4R86BMwt6vqWRBg/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 11:54:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/QMxP0Sx4R86BMwt6vqWRBg/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json'}, attempt #1 11:54:34 INFO - Downloaded 1199 bytes. 11:54:34 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 11:54:34 INFO - Using the following test package requirements: 11:54:34 INFO - {u'common': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 11:54:34 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 11:54:34 INFO - u'firefox-51.0a1.en-US.mac.cppunittest.tests.zip'], 11:54:34 INFO - u'gtest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 11:54:34 INFO - u'firefox-51.0a1.en-US.mac.gtest.tests.zip'], 11:54:34 INFO - u'jittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 11:54:34 INFO - u'jsshell-mac.zip'], 11:54:34 INFO - u'mochitest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 11:54:34 INFO - u'firefox-51.0a1.en-US.mac.mochitest.tests.zip'], 11:54:34 INFO - u'mozbase': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 11:54:34 INFO - u'reftest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 11:54:34 INFO - u'firefox-51.0a1.en-US.mac.reftest.tests.zip'], 11:54:34 INFO - u'talos': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 11:54:34 INFO - u'firefox-51.0a1.en-US.mac.talos.tests.zip'], 11:54:34 INFO - u'web-platform': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 11:54:34 INFO - u'firefox-51.0a1.en-US.mac.web-platform.tests.zip'], 11:54:34 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 11:54:34 INFO - u'firefox-51.0a1.en-US.mac.xpcshell.tests.zip']} 11:54:34 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip'] for test suite category: common 11:54:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:54:34 INFO - trying https://queue.taskcluster.net/v1/task/QMxP0Sx4R86BMwt6vqWRBg/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 11:54:34 INFO - Downloading https://queue.taskcluster.net/v1/task/QMxP0Sx4R86BMwt6vqWRBg/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip 11:54:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/QMxP0Sx4R86BMwt6vqWRBg/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip'}, attempt #1 11:54:35 INFO - Downloaded 16326422 bytes. 11:54:35 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:54:35 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 11:54:38 INFO - Return code: 0 11:54:38 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip', u'firefox-51.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 11:54:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:54:38 INFO - trying https://queue.taskcluster.net/v1/task/QMxP0Sx4R86BMwt6vqWRBg/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 11:54:38 INFO - Downloading https://queue.taskcluster.net/v1/task/QMxP0Sx4R86BMwt6vqWRBg/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip 11:54:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/QMxP0Sx4R86BMwt6vqWRBg/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip'}, attempt #1 11:54:39 INFO - Downloaded 16326422 bytes. 11:54:39 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:54:39 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 11:54:42 INFO - Return code: 0 11:54:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:54:42 INFO - trying https://queue.taskcluster.net/v1/task/QMxP0Sx4R86BMwt6vqWRBg/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip 11:54:42 INFO - Downloading https://queue.taskcluster.net/v1/task/QMxP0Sx4R86BMwt6vqWRBg/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip 11:54:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/QMxP0Sx4R86BMwt6vqWRBg/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip'}, attempt #1 11:54:43 INFO - Downloaded 14413723 bytes. 11:54:43 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:54:43 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 11:54:44 INFO - Return code: 0 11:54:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:54:44 INFO - trying https://queue.taskcluster.net/v1/task/QMxP0Sx4R86BMwt6vqWRBg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 11:54:44 INFO - Downloading https://queue.taskcluster.net/v1/task/QMxP0Sx4R86BMwt6vqWRBg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg 11:54:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/QMxP0Sx4R86BMwt6vqWRBg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg'}, attempt #1 11:54:47 INFO - Downloaded 110907275 bytes. 11:54:47 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/QMxP0Sx4R86BMwt6vqWRBg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 11:54:47 INFO - mkdir: /builds/slave/test/properties 11:54:47 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:54:47 INFO - Writing to file /builds/slave/test/properties/build_url 11:54:47 INFO - Contents: 11:54:47 INFO - build_url:https://queue.taskcluster.net/v1/task/QMxP0Sx4R86BMwt6vqWRBg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 11:54:47 INFO - Running post-action listener: _resource_record_post_action 11:54:47 INFO - Running post-action listener: set_extra_try_arguments 11:54:47 INFO - [mozharness: 2016-08-09 18:54:47.790627Z] Finished download-and-extract step (success) 11:54:47 INFO - [mozharness: 2016-08-09 18:54:47.790753Z] Running populate-webroot step. 11:54:47 INFO - Running pre-action listener: _resource_record_pre_action 11:54:47 INFO - Running main action method: populate_webroot 11:54:47 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:54:47 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:54:47 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:54:47 INFO - '--tppagecycles', 11:54:47 INFO - '7'], 11:54:47 INFO - 'tests': ['tsvgm']}}, 11:54:47 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:54:47 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:54:47 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:54:47 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:54:47 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:54:47 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:54:47 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:54:47 INFO - 'talos_options': ['--disable-e10s'], 11:54:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:54:47 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:54:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:54:47 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:54:47 INFO - 'talos_options': ['--disable-e10s'], 11:54:47 INFO - 'tests': ['damp', 'tps']}, 11:54:47 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:54:47 INFO - 'tests': ['damp', 'tps']}, 11:54:47 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:54:47 INFO - 'tests': ['dromaeo_dom']}, 11:54:47 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:54:47 INFO - 'g4': {'talos_options': ['--disable-e10s'], 11:54:47 INFO - 'tests': ['basic_compositor_video']}, 11:54:47 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 11:54:47 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:54:47 INFO - 'tests': ['a11yr', 11:54:47 INFO - 'ts_paint', 11:54:47 INFO - 'tpaint', 11:54:47 INFO - 'sessionrestore', 11:54:47 INFO - 'sessionrestore_no_auto_restore', 11:54:47 INFO - 'tabpaint']}, 11:54:47 INFO - 'other-e10s': {'tests': ['a11yr', 11:54:47 INFO - 'ts_paint', 11:54:47 INFO - 'tpaint', 11:54:47 INFO - 'sessionrestore', 11:54:47 INFO - 'sessionrestore_no_auto_restore', 11:54:47 INFO - 'tabpaint']}, 11:54:47 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:54:47 INFO - 'ts_paint', 11:54:47 INFO - 'tpaint', 11:54:47 INFO - 'sessionrestore', 11:54:47 INFO - 'sessionrestore_no_auto_restore', 11:54:47 INFO - 'tabpaint']}, 11:54:47 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:54:47 INFO - 'ts_paint', 11:54:47 INFO - 'tpaint', 11:54:47 INFO - 'sessionrestore', 11:54:47 INFO - 'sessionrestore_no_auto_restore', 11:54:47 INFO - 'tabpaint']}, 11:54:47 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:54:47 INFO - 'tests': ['a11yr', 11:54:47 INFO - 'ts_paint', 11:54:47 INFO - 'tpaint', 11:54:47 INFO - 'sessionrestore', 11:54:47 INFO - 'sessionrestore_no_auto_restore', 11:54:47 INFO - 'tabpaint']}, 11:54:47 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:54:47 INFO - 'tests': ['a11yr', 11:54:47 INFO - 'ts_paint', 11:54:47 INFO - 'tpaint', 11:54:47 INFO - 'sessionrestore', 11:54:47 INFO - 'sessionrestore_no_auto_restore', 11:54:47 INFO - 'tabpaint']}, 11:54:47 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:54:47 INFO - 'tests': ['tsvgx', 11:54:47 INFO - 'tsvgr_opacity', 11:54:47 INFO - 'tart', 11:54:47 INFO - 'tscrollx', 11:54:47 INFO - 'cart']}, 11:54:47 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:54:47 INFO - 'tsvgr_opacity', 11:54:47 INFO - 'tart', 11:54:47 INFO - 'tscrollx', 11:54:47 INFO - 'cart']}, 11:54:47 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:54:47 INFO - 'talos_options': ['--disable-e10s'], 11:54:47 INFO - 'tests': ['tp5o']}, 11:54:47 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:54:47 INFO - 'tests': ['tp5o']}, 11:54:47 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:54:47 INFO - 'talos_options': ['--disable-e10s', 11:54:47 INFO - '--xperf_path', 11:54:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:54:47 INFO - 'tests': ['tp5n']}, 11:54:47 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:54:47 INFO - 'talos_options': ['--xperf_path', 11:54:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:54:47 INFO - 'tests': ['tp5n']}}, 11:54:47 INFO - 'talos.zip': {'path': '', 11:54:47 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:54:47 INFO - Running post-action listener: _resource_record_post_action 11:54:47 INFO - [mozharness: 2016-08-09 18:54:47.809459Z] Finished populate-webroot step (success) 11:54:47 INFO - [mozharness: 2016-08-09 18:54:47.809568Z] Running create-virtualenv step. 11:54:47 INFO - Running pre-action listener: _resource_record_pre_action 11:54:47 INFO - Running main action method: create_virtualenv 11:54:47 INFO - Creating virtualenv /builds/slave/test/build/venv 11:54:47 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 11:54:47 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:54:47 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:54:47 INFO - Using real prefix '/tools/python27' 11:54:47 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:54:48 INFO - Installing distribute.............................................................................................................................................................................................done. 11:54:51 INFO - Installing pip.................done. 11:54:51 INFO - Return code: 0 11:54:51 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:54:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:54:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:54:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:54:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:54:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:54:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:54:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10121aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1012af618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe5a847a6f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10117ed30>, '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 0x100ee3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101176b20>, '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.u0PW9wkOWx/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.ETnL0WfxrY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 11:54:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 11:54:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 11:54:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.u0PW9wkOWx/Render', 11:54:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:54:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:54:51 INFO - 'HOME': '/Users/cltbld', 11:54:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:54:51 INFO - 'LOGNAME': 'cltbld', 11:54:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:54:51 INFO - 'MOZ_NO_REMOTE': '1', 11:54:51 INFO - 'NO_EM_RESTART': '1', 11:54:51 INFO - 'PAGER': '/bin/cat', 11:54:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:54:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:54:51 INFO - 'PWD': '/builds/slave/test', 11:54:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:54:51 INFO - 'SHELL': '/bin/bash', 11:54:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ETnL0WfxrY/Listeners', 11:54:51 INFO - 'TMPDIR': '/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/', 11:54:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:54:51 INFO - 'USER': 'cltbld', 11:54:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:54:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:54:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:54:51 INFO - 'XPC_FLAGS': '0x0', 11:54:51 INFO - 'XPC_SERVICE_NAME': '0', 11:54:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:54:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:54:51 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 11:54:51 INFO - Cleaning up... 11:54:51 INFO - Return code: 0 11:54:51 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:54:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:54:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:54:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:54:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:54:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:54:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:54:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10121aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1012af618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe5a847a6f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10117ed30>, '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 0x100ee3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101176b20>, '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.u0PW9wkOWx/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.ETnL0WfxrY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 11:54:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 11:54:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 11:54:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.u0PW9wkOWx/Render', 11:54:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:54:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:54:51 INFO - 'HOME': '/Users/cltbld', 11:54:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:54:51 INFO - 'LOGNAME': 'cltbld', 11:54:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:54:51 INFO - 'MOZ_NO_REMOTE': '1', 11:54:51 INFO - 'NO_EM_RESTART': '1', 11:54:51 INFO - 'PAGER': '/bin/cat', 11:54:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:54:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:54:51 INFO - 'PWD': '/builds/slave/test', 11:54:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:54:51 INFO - 'SHELL': '/bin/bash', 11:54:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ETnL0WfxrY/Listeners', 11:54:51 INFO - 'TMPDIR': '/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/', 11:54:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:54:51 INFO - 'USER': 'cltbld', 11:54:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:54:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:54:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:54:51 INFO - 'XPC_FLAGS': '0x0', 11:54:51 INFO - 'XPC_SERVICE_NAME': '0', 11:54:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:54:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:54:52 INFO - Downloading/unpacking psutil>=3.1.1 11:54:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:54:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:54:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:54:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:54:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:54:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:54:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:54:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:54:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:54:54 INFO - Installing collected packages: psutil 11:54:54 INFO - Running setup.py install for psutil 11:54:55 INFO - building 'psutil._psutil_osx' extension 11:54:55 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 11:54:55 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 11:54:55 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 11:54:55 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 11:54:55 INFO - building 'psutil._psutil_posix' extension 11:54:55 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 11:54:55 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 11:54:55 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 11:54:55 INFO - ^ 11:54:55 INFO - 1 warning generated. 11:54:55 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 11:54:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:54:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:54:55 INFO - Successfully installed psutil 11:54:55 INFO - Cleaning up... 11:54:55 INFO - Return code: 0 11:54:55 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:54:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:54:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:54:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:54:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:54:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:54:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:54:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10121aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1012af618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe5a847a6f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10117ed30>, '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 0x100ee3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101176b20>, '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.u0PW9wkOWx/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.ETnL0WfxrY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 11:54:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 11:54:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 11:54:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.u0PW9wkOWx/Render', 11:54:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:54:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:54:55 INFO - 'HOME': '/Users/cltbld', 11:54:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:54:55 INFO - 'LOGNAME': 'cltbld', 11:54:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:54:55 INFO - 'MOZ_NO_REMOTE': '1', 11:54:55 INFO - 'NO_EM_RESTART': '1', 11:54:55 INFO - 'PAGER': '/bin/cat', 11:54:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:54:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:54:55 INFO - 'PWD': '/builds/slave/test', 11:54:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:54:55 INFO - 'SHELL': '/bin/bash', 11:54:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ETnL0WfxrY/Listeners', 11:54:55 INFO - 'TMPDIR': '/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/', 11:54:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:54:55 INFO - 'USER': 'cltbld', 11:54:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:54:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:54:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:54:55 INFO - 'XPC_FLAGS': '0x0', 11:54:55 INFO - 'XPC_SERVICE_NAME': '0', 11:54:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:54:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:54:56 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:54:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:54:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:54:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:54:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:54:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:54:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:54:58 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:54:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:54:58 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:54:58 INFO - Installing collected packages: mozsystemmonitor 11:54:58 INFO - Running setup.py install for mozsystemmonitor 11:54:58 INFO - Successfully installed mozsystemmonitor 11:54:58 INFO - Cleaning up... 11:54:58 INFO - Return code: 0 11:54:58 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:54:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:54:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:54:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:54:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:54:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:54:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:54:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10121aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1012af618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe5a847a6f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10117ed30>, '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 0x100ee3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101176b20>, '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.u0PW9wkOWx/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.ETnL0WfxrY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 11:54:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 11:54:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 11:54:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.u0PW9wkOWx/Render', 11:54:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:54:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:54:58 INFO - 'HOME': '/Users/cltbld', 11:54:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:54:58 INFO - 'LOGNAME': 'cltbld', 11:54:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:54:58 INFO - 'MOZ_NO_REMOTE': '1', 11:54:58 INFO - 'NO_EM_RESTART': '1', 11:54:58 INFO - 'PAGER': '/bin/cat', 11:54:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:54:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:54:58 INFO - 'PWD': '/builds/slave/test', 11:54:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:54:58 INFO - 'SHELL': '/bin/bash', 11:54:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ETnL0WfxrY/Listeners', 11:54:58 INFO - 'TMPDIR': '/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/', 11:54:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:54:58 INFO - 'USER': 'cltbld', 11:54:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:54:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:54:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:54:58 INFO - 'XPC_FLAGS': '0x0', 11:54:58 INFO - 'XPC_SERVICE_NAME': '0', 11:54:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:54:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:54:59 INFO - Downloading/unpacking jsonschema==2.5.1 11:54:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:54:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:54:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:54:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:54:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:54:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:55:01 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:55:01 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:55:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:55:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:55:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:55:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:55:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:55:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:55:01 INFO - Downloading functools32-3.2.3-2.tar.gz 11:55:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:55:02 INFO - warning: no files found matching '*.txt' 11:55:02 INFO - no previously-included directories found matching 'build' 11:55:02 INFO - no previously-included directories found matching 'dist' 11:55:02 INFO - no previously-included directories found matching '.git*' 11:55:02 INFO - Installing collected packages: jsonschema, functools32 11:55:02 INFO - Running setup.py install for functools32 11:55:02 INFO - warning: no files found matching '*.txt' 11:55:02 INFO - no previously-included directories found matching 'build' 11:55:02 INFO - no previously-included directories found matching 'dist' 11:55:02 INFO - no previously-included directories found matching '.git*' 11:55:02 INFO - Successfully installed jsonschema functools32 11:55:02 INFO - Cleaning up... 11:55:02 INFO - Return code: 0 11:55:02 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:55:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:55:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:55:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:55:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:55:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:55:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:55:02 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 0x10121aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1012af618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe5a847a6f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10117ed30>, '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 0x100ee3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101176b20>, '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.u0PW9wkOWx/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.ETnL0WfxrY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 11:55:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 11:55:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 11:55:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.u0PW9wkOWx/Render', 11:55:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:55:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:55:02 INFO - 'HOME': '/Users/cltbld', 11:55:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:55:02 INFO - 'LOGNAME': 'cltbld', 11:55:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:55:02 INFO - 'MOZ_NO_REMOTE': '1', 11:55:02 INFO - 'NO_EM_RESTART': '1', 11:55:02 INFO - 'PAGER': '/bin/cat', 11:55:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:55:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:55:02 INFO - 'PWD': '/builds/slave/test', 11:55:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:55:02 INFO - 'SHELL': '/bin/bash', 11:55:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ETnL0WfxrY/Listeners', 11:55:02 INFO - 'TMPDIR': '/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/', 11:55:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:55:02 INFO - 'USER': 'cltbld', 11:55:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:55:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:55:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:55:02 INFO - 'XPC_FLAGS': '0x0', 11:55:02 INFO - 'XPC_SERVICE_NAME': '0', 11:55:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:55:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:55:02 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:55:02 INFO - Cleaning up... 11:55:02 INFO - Return code: 0 11:55:02 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:55:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:55:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:55:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:55:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:55:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:55:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:55:02 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 0x10121aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1012af618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe5a847a6f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10117ed30>, '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 0x100ee3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101176b20>, '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.u0PW9wkOWx/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.ETnL0WfxrY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 11:55:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 11:55:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 11:55:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.u0PW9wkOWx/Render', 11:55:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:55:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:55:02 INFO - 'HOME': '/Users/cltbld', 11:55:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:55:02 INFO - 'LOGNAME': 'cltbld', 11:55:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:55:02 INFO - 'MOZ_NO_REMOTE': '1', 11:55:02 INFO - 'NO_EM_RESTART': '1', 11:55:02 INFO - 'PAGER': '/bin/cat', 11:55:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:55:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:55:02 INFO - 'PWD': '/builds/slave/test', 11:55:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:55:02 INFO - 'SHELL': '/bin/bash', 11:55:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ETnL0WfxrY/Listeners', 11:55:02 INFO - 'TMPDIR': '/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/', 11:55:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:55:02 INFO - 'USER': 'cltbld', 11:55:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:55:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:55:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:55:02 INFO - 'XPC_FLAGS': '0x0', 11:55:02 INFO - 'XPC_SERVICE_NAME': '0', 11:55:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:55:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:55:02 INFO - Downloading/unpacking blobuploader==1.2.4 11:55:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:55:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:55:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:55:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:55:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:55:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:55:05 INFO - Downloading blobuploader-1.2.4.tar.gz 11:55:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:55:05 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:55:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:55:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:55:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:55:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:55:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:55:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:55:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:55:06 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:55:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:55:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:55:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:55:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:55:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:55:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:55:06 INFO - Downloading docopt-0.6.1.tar.gz 11:55:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:55:06 INFO - Installing collected packages: blobuploader, requests, docopt 11:55:06 INFO - Running setup.py install for blobuploader 11:55:06 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:55:06 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:55:06 INFO - Running setup.py install for requests 11:55:07 INFO - Running setup.py install for docopt 11:55:07 INFO - Successfully installed blobuploader requests docopt 11:55:07 INFO - Cleaning up... 11:55:07 INFO - Return code: 0 11:55:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:55:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:55:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:55:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:55:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:55:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:55:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:55:07 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 0x10121aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1012af618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe5a847a6f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10117ed30>, '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 0x100ee3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101176b20>, '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.u0PW9wkOWx/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.ETnL0WfxrY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 11:55:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 11:55:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:55:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.u0PW9wkOWx/Render', 11:55:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:55:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:55:07 INFO - 'HOME': '/Users/cltbld', 11:55:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:55:07 INFO - 'LOGNAME': 'cltbld', 11:55:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:55:07 INFO - 'MOZ_NO_REMOTE': '1', 11:55:07 INFO - 'NO_EM_RESTART': '1', 11:55:07 INFO - 'PAGER': '/bin/cat', 11:55:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:55:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:55:07 INFO - 'PWD': '/builds/slave/test', 11:55:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:55:07 INFO - 'SHELL': '/bin/bash', 11:55:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ETnL0WfxrY/Listeners', 11:55:07 INFO - 'TMPDIR': '/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/', 11:55:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:55:07 INFO - 'USER': 'cltbld', 11:55:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:55:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:55:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:55:07 INFO - 'XPC_FLAGS': '0x0', 11:55:07 INFO - 'XPC_SERVICE_NAME': '0', 11:55:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:55:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:55:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:55:07 INFO - Running setup.py (path:/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/pip-bpH3Hw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:55:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:55:07 INFO - Running setup.py (path:/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/pip-7qg9ne-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:55:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:55:07 INFO - Running setup.py (path:/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/pip-V86s1V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:55:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:55:08 INFO - Running setup.py (path:/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/pip-hNYDWU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:55:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:55:08 INFO - Running setup.py (path:/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/pip-bh71hr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:55:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:55:08 INFO - Running setup.py (path:/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/pip-1ZXH1j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:55:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:55:08 INFO - Running setup.py (path:/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/pip-Ogh7ic-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:55:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:55:08 INFO - Running setup.py (path:/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/pip-S_QcjA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:55:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:55:08 INFO - Running setup.py (path:/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/pip-0_BdHa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:55:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:55:08 INFO - Running setup.py (path:/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/pip-NJvoEs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:55:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:55:08 INFO - Running setup.py (path:/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/pip-cYr2Pt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:55:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:55:08 INFO - Running setup.py (path:/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/pip-_xxEt6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:55:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:55:08 INFO - Running setup.py (path:/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/pip-mnzLCy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:55:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:55:09 INFO - Running setup.py (path:/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/pip-QVY1BR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:55:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:55:09 INFO - Running setup.py (path:/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/pip-ac9__F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:55:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:55:09 INFO - Running setup.py (path:/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/pip-kHXHPM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:55:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:55:09 INFO - Running setup.py (path:/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/pip-za0QXx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:55:09 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:55:09 INFO - Running setup.py install for manifestparser 11:55:09 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:55:09 INFO - Running setup.py install for mozcrash 11:55:09 INFO - Running setup.py install for mozdebug 11:55:09 INFO - Running setup.py install for mozdevice 11:55:10 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:55:10 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:55:10 INFO - Running setup.py install for mozfile 11:55:10 INFO - Running setup.py install for mozhttpd 11:55:10 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:55:10 INFO - Running setup.py install for mozinfo 11:55:10 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:55:10 INFO - Running setup.py install for mozInstall 11:55:10 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:55:10 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:55:10 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:55:10 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:55:10 INFO - Running setup.py install for mozleak 11:55:10 INFO - Running setup.py install for mozlog 11:55:10 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:55:10 INFO - Running setup.py install for moznetwork 11:55:11 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:55:11 INFO - Running setup.py install for mozprocess 11:55:11 INFO - Running setup.py install for mozprofile 11:55:11 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:55:11 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:55:11 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:55:11 INFO - Running setup.py install for mozrunner 11:55:11 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:55:11 INFO - Running setup.py install for mozscreenshot 11:55:11 INFO - Running setup.py install for moztest 11:55:11 INFO - Running setup.py install for mozversion 11:55:12 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:55:12 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:55:12 INFO - Cleaning up... 11:55:12 INFO - Return code: 0 11:55:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:55:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:55:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:55:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:55:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:55:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:55:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:55:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/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 0x10121aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1012af618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe5a847a6f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10117ed30>, '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 0x100ee3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101176b20>, '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.u0PW9wkOWx/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.ETnL0WfxrY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 11:55:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 11:55:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:55:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.u0PW9wkOWx/Render', 11:55:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:55:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:55:12 INFO - 'HOME': '/Users/cltbld', 11:55:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:55:12 INFO - 'LOGNAME': 'cltbld', 11:55:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:55:12 INFO - 'MOZ_NO_REMOTE': '1', 11:55:12 INFO - 'NO_EM_RESTART': '1', 11:55:12 INFO - 'PAGER': '/bin/cat', 11:55:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:55:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:55:12 INFO - 'PWD': '/builds/slave/test', 11:55:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:55:12 INFO - 'SHELL': '/bin/bash', 11:55:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ETnL0WfxrY/Listeners', 11:55:12 INFO - 'TMPDIR': '/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/', 11:55:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:55:12 INFO - 'USER': 'cltbld', 11:55:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:55:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:55:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:55:12 INFO - 'XPC_FLAGS': '0x0', 11:55:12 INFO - 'XPC_SERVICE_NAME': '0', 11:55:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:55:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:55:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:55:12 INFO - Running setup.py (path:/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/pip-2Q0dIH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:55:12 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 11:55:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:55:12 INFO - Running setup.py (path:/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/pip-ukWU3M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:55:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:55:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:55:12 INFO - Running setup.py (path:/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/pip-3owp__-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:55:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 11:55:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:55:12 INFO - Running setup.py (path:/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/pip-u4zNSi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:55:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:55:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:55:12 INFO - Running setup.py (path:/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/pip-Kf2t0F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:55:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 11:55:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:55:12 INFO - Running setup.py (path:/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/pip-_jdfeL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:55:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 11:55:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:55:12 INFO - Running setup.py (path:/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/pip-9GTaD2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:55:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 11:55:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:55:13 INFO - Running setup.py (path:/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/pip-aCxbJ9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:55:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 11:55:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:55:13 INFO - Running setup.py (path:/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/pip-8IkVrA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:55:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 11:55:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:55:13 INFO - Running setup.py (path:/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/pip-JOahH2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:55:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:55:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:55:13 INFO - Running setup.py (path:/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/pip-sSPFL3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:55:13 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 11:55:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:55:13 INFO - Running setup.py (path:/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/pip-KFOT7i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:55:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 11:55:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:55:13 INFO - Running setup.py (path:/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/pip-WyGLpe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:55:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 11:55:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:55:13 INFO - Running setup.py (path:/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/pip-q84jPt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:55:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 11:55:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:55:13 INFO - Running setup.py (path:/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/pip-Xs64je-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:55:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 11:55:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:55:13 INFO - Running setup.py (path:/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/pip-Usylhg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:55:14 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 11:55:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:55:14 INFO - Running setup.py (path:/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/pip-ldnDDd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:55:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 11:55:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:55:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:55:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 11:55:14 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:55:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:55:14 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:55:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:55:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:55:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:55:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:55:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:55:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:55:16 INFO - Downloading blessings-1.6.tar.gz 11:55:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:55:16 INFO - Installing collected packages: blessings 11:55:16 INFO - Running setup.py install for blessings 11:55:16 INFO - Successfully installed blessings 11:55:16 INFO - Cleaning up... 11:55:16 INFO - Return code: 0 11:55:16 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:55:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:55:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:55:17 INFO - Reading from file tmpfile_stdout 11:55:17 INFO - Current package versions: 11:55:17 INFO - blessings == 1.6 11:55:17 INFO - blobuploader == 1.2.4 11:55:17 INFO - docopt == 0.6.1 11:55:17 INFO - functools32 == 3.2.3-2 11:55:17 INFO - jsonschema == 2.5.1 11:55:17 INFO - manifestparser == 1.1 11:55:17 INFO - mozInstall == 1.12 11:55:17 INFO - mozcrash == 0.17 11:55:17 INFO - mozdebug == 0.1 11:55:17 INFO - mozdevice == 0.48 11:55:17 INFO - mozfile == 1.2 11:55:17 INFO - mozhttpd == 0.7 11:55:17 INFO - mozinfo == 0.9 11:55:17 INFO - mozleak == 0.1 11:55:17 INFO - mozlog == 3.3 11:55:17 INFO - moznetwork == 0.27 11:55:17 INFO - mozprocess == 0.23 11:55:17 INFO - mozprofile == 0.28 11:55:17 INFO - mozrunner == 6.12 11:55:17 INFO - mozscreenshot == 0.1 11:55:17 INFO - mozsystemmonitor == 0.3 11:55:17 INFO - moztest == 0.7 11:55:17 INFO - mozversion == 1.4 11:55:17 INFO - psutil == 3.1.1 11:55:17 INFO - requests == 1.2.3 11:55:17 INFO - wsgiref == 0.1.2 11:55:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:55:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:55:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:55:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:55:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:55:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:55:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:55:17 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 0x10121aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1012af618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe5a847a6f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10117ed30>, '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 0x100ee3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101176b20>, '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.u0PW9wkOWx/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.ETnL0WfxrY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 11:55:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 11:55:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:55:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.u0PW9wkOWx/Render', 11:55:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:55:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:55:17 INFO - 'HOME': '/Users/cltbld', 11:55:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:55:17 INFO - 'LOGNAME': 'cltbld', 11:55:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:55:17 INFO - 'MOZ_NO_REMOTE': '1', 11:55:17 INFO - 'NO_EM_RESTART': '1', 11:55:17 INFO - 'PAGER': '/bin/cat', 11:55:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:55:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:55:17 INFO - 'PWD': '/builds/slave/test', 11:55:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:55:17 INFO - 'SHELL': '/bin/bash', 11:55:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ETnL0WfxrY/Listeners', 11:55:17 INFO - 'TMPDIR': '/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/', 11:55:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:55:17 INFO - 'USER': 'cltbld', 11:55:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:55:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:55:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:55:17 INFO - 'XPC_FLAGS': '0x0', 11:55:17 INFO - 'XPC_SERVICE_NAME': '0', 11:55:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:55:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:55:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 11:55:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 11:55:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 11:55:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 11:55:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 11:55:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 11:55:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 11:55:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 11:55:17 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 11:55:17 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 11:55:17 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 11:55:17 INFO - Cleaning up... 11:55:17 INFO - Return code: 0 11:55:17 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:55:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:55:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:55:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:55:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:55:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:55:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:55:17 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 0x10121aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1012af618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe5a847a6f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10117ed30>, '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 0x100ee3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101176b20>, '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.u0PW9wkOWx/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.ETnL0WfxrY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 11:55:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 11:55:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 11:55:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.u0PW9wkOWx/Render', 11:55:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:55:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:55:17 INFO - 'HOME': '/Users/cltbld', 11:55:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:55:17 INFO - 'LOGNAME': 'cltbld', 11:55:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:55:17 INFO - 'MOZ_NO_REMOTE': '1', 11:55:17 INFO - 'NO_EM_RESTART': '1', 11:55:17 INFO - 'PAGER': '/bin/cat', 11:55:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:55:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:55:17 INFO - 'PWD': '/builds/slave/test', 11:55:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:55:17 INFO - 'SHELL': '/bin/bash', 11:55:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ETnL0WfxrY/Listeners', 11:55:17 INFO - 'TMPDIR': '/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/', 11:55:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:55:17 INFO - 'USER': 'cltbld', 11:55:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:55:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:55:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:55:17 INFO - 'XPC_FLAGS': '0x0', 11:55:17 INFO - 'XPC_SERVICE_NAME': '0', 11:55:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:55:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:55:17 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:55:17 INFO - Cleaning up... 11:55:17 INFO - Return code: 0 11:55:17 INFO - Running post-action listener: _resource_record_post_action 11:55:17 INFO - Running post-action listener: _start_resource_monitoring 11:55:17 INFO - Starting resource monitoring. 11:55:17 INFO - [mozharness: 2016-08-09 18:55:17.760273Z] Finished create-virtualenv step (success) 11:55:17 INFO - [mozharness: 2016-08-09 18:55:17.761214Z] Running install step. 11:55:17 INFO - Running pre-action listener: _resource_record_pre_action 11:55:17 INFO - Running main action method: install 11:55:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:55:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:55:18 INFO - Reading from file tmpfile_stdout 11:55:18 INFO - Detecting whether we're running mozinstall >=1.0... 11:55:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:55:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:55:18 INFO - Reading from file tmpfile_stdout 11:55:18 INFO - Output received: 11:55:18 INFO - Usage: mozinstall [options] installer 11:55:18 INFO - Options: 11:55:18 INFO - -h, --help show this help message and exit 11:55:18 INFO - -d DEST, --destination=DEST 11:55:18 INFO - Directory to install application into. [default: 11:55:18 INFO - "/builds/slave/test"] 11:55:18 INFO - --app=APP Application being installed. [default: firefox] 11:55:18 INFO - mkdir: /builds/slave/test/build/application 11:55:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 11:55:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 11:55:52 INFO - Reading from file tmpfile_stdout 11:55:52 INFO - Output received: 11:55:52 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 11:55:52 INFO - Running post-action listener: _resource_record_post_action 11:55:52 INFO - [mozharness: 2016-08-09 18:55:52.025574Z] Finished install step (success) 11:55:52 INFO - [mozharness: 2016-08-09 18:55:52.025722Z] Running run-tests step. 11:55:52 INFO - Running pre-action listener: _resource_record_pre_action 11:55:52 INFO - Running main action method: run_tests 11:55:52 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 11:55:52 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 11:55:52 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 11:55:52 INFO - 2016-08-09 11:55:52.040 screenresolution[1991:277316] starting screenresolution argv=screenresolution get 11:55:52 INFO - 2016-08-09 11:55:52.043 screenresolution[1991:277316] Display 0: 1600x1200x32@60 11:55:52 INFO - 2016-08-09 11:55:52.049 screenresolution[1992:277318] starting screenresolution argv=screenresolution list 11:55:52 INFO - Available Modes on Display 0 11:55:52 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 11:55:52 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 11:55:52 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 11:55:52 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 11:55:52 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 11:55:52 INFO - Intel Iris: 11:55:52 INFO - Chipset Model: Intel Iris 11:55:52 INFO - Type: GPU 11:55:52 INFO - Bus: Built-In 11:55:52 INFO - VRAM (Dynamic, Max): 1536 MB 11:55:52 INFO - Vendor: Intel (0x8086) 11:55:52 INFO - Device ID: 0x0a2e 11:55:52 INFO - Revision ID: 0x0009 11:55:52 INFO - Displays: 11:55:52 INFO - Display: 11:55:52 INFO - Resolution: 1600 x 1200 @ 60 Hz 11:55:52 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 11:55:52 INFO - Display Serial Number: 1600x1200 60 11:55:52 INFO - Main Display: Yes 11:55:52 INFO - Mirror: Off 11:55:52 INFO - Online: Yes 11:55:52 INFO - Rotation: Supported 11:55:52 INFO - Return code: 0 11:55:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:55:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:55:52 INFO - Python 2.7.3 11:55:52 INFO - Return code: 0 11:55:52 INFO - grabbing minidump binary from tooltool 11:55:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:55:52 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 0x10117ed30>, '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 0x100ee3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101176b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:55:52 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 11:55:52 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 11:55:52 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 11:55:52 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:55:52 INFO - Return code: 0 11:55:52 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 11:55:52 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:55:52 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:55:52 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 11:55:52 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:55:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/QMxP0Sx4R86BMwt6vqWRBg/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0237', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 11:55:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/QMxP0Sx4R86BMwt6vqWRBg/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0237 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 11:55:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.u0PW9wkOWx/Render', 11:55:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:55:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:55:52 INFO - 'HOME': '/Users/cltbld', 11:55:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:55:52 INFO - 'LOGNAME': 'cltbld', 11:55:52 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:55:52 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 11:55:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:55:52 INFO - 'MOZ_NO_REMOTE': '1', 11:55:52 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:55:52 INFO - 'NO_EM_RESTART': '1', 11:55:52 INFO - 'PAGER': '/bin/cat', 11:55:52 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:55:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:55:52 INFO - 'PWD': '/builds/slave/test', 11:55:52 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:55:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:55:52 INFO - 'SHELL': '/bin/bash', 11:55:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ETnL0WfxrY/Listeners', 11:55:52 INFO - 'TMPDIR': '/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/', 11:55:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:55:52 INFO - 'USER': 'cltbld', 11:55:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:55:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:55:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:55:52 INFO - 'XPC_FLAGS': '0x0', 11:55:52 INFO - 'XPC_SERVICE_NAME': '0', 11:55:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:55:52 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/QMxP0Sx4R86BMwt6vqWRBg/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0237', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 11:55:52 INFO - mozversion application_buildid: 20160809104420 11:55:52 INFO - mozversion application_changeset: b47abe0917b074d95b7e240a8deda72bf4a71b84 11:55:52 INFO - mozversion application_display_name: Nightly 11:55:52 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:55:52 INFO - mozversion application_name: Firefox 11:55:52 INFO - mozversion application_remotingname: firefox 11:55:52 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 11:55:52 INFO - mozversion application_vendor: Mozilla 11:55:52 INFO - mozversion application_version: 51.0a1 11:55:52 INFO - mozversion platform_buildid: 20160809104420 11:55:52 INFO - mozversion platform_changeset: b47abe0917b074d95b7e240a8deda72bf4a71b84 11:55:52 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 11:55:52 INFO - mozversion platform_version: 51.0a1 11:55:52 INFO - using testdate: 1470768952 11:55:52 INFO - actual date: 1470768952 11:55:52 INFO - starting webserver on 'localhost:49372' 11:55:52 INFO - SUITE-START | Running 2 tests 11:55:52 INFO - TEST-START | dromaeo_css 11:55:52 INFO - operating with platform_type : mac_ 11:55:52 INFO - Initialising browser for dromaeo_css test... 11:55:52 INFO - TEST-INFO | started process 2002 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/tmpI37i2B/profile http://localhost:49372/getInfo.html) 11:55:55 INFO - PROCESS | 2002 | __metrics Screen width/height:1600/1200 11:55:55 INFO - PROCESS | 2002 | colorDepth:24 11:55:55 INFO - PROCESS | 2002 | Browser inner width/height: 1024/689 11:55:55 INFO - PROCESS | 2002 | __metrics 11:55:55 INFO - PROCESS | 2002 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 11:55:55 INFO - PROCESS | 2002 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:55:55 INFO - TEST-INFO | 2002: exit 0 11:55:55 INFO - Browser initialized. 11:55:55 INFO - Running cycle 1/1 for dromaeo_css test... 11:55:55 INFO - TEST-INFO | started process 2006 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/tmpI37i2B/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:56:07 INFO - PROCESS | 2006 | RSS: Main: 243220480 11:56:07 INFO - PROCESS | 2006 | 11:56:59 INFO - PROCESS | 2006 | 1470769019662 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] 11:59:11 INFO - PROCESS | 2006 | Cycle 1(1): loaded http://localhost:49372/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49372/tests/dromaeo/cssquery-ext.html) 11:59:13 INFO - PROCESS | 2006 | RSS: Main: 350502912 11:59:13 INFO - PROCESS | 2006 | 12:02:16 INFO - PROCESS | 2006 | Cycle 1(1): loaded http://localhost:49372/tests/dromaeo/cssquery-ext.html (next: http://localhost:49372/tests/dromaeo/cssquery-jquery.html) 12:02:16 INFO - PROCESS | 2006 | RSS: Main: 387919872 12:02:16 INFO - PROCESS | 2006 | 12:05:18 INFO - PROCESS | 2006 | Cycle 1(1): loaded http://localhost:49372/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49372/tests/dromaeo/cssquery-mootools.html) 12:05:19 INFO - PROCESS | 2006 | RSS: Main: 384565248 12:05:19 INFO - PROCESS | 2006 | 12:08:21 INFO - PROCESS | 2006 | Cycle 1(1): loaded http://localhost:49372/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49372/tests/dromaeo/cssquery-prototype.html) 12:08:22 INFO - PROCESS | 2006 | RSS: Main: 375885824 12:08:22 INFO - PROCESS | 2006 | 12:11:25 INFO - PROCESS | 2006 | Cycle 1(1): loaded http://localhost:49372/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49372/tests/dromaeo/cssquery-yui.html) 12:11:26 INFO - PROCESS | 2006 | RSS: Main: 355225600 12:11:26 INFO - PROCESS | 2006 | 12:14:29 INFO - PROCESS | 2006 | Cycle 1(1): loaded http://localhost:49372/tests/dromaeo/cssquery-yui.html (next: http://localhost:49372/tests/dromaeo/cssquery-dojo.html) 12:14:29 INFO - PROCESS | 2006 | RSS: Main: 396419072 12:14:29 INFO - PROCESS | 2006 | 12:14:29 INFO - PROCESS | 2006 | __start_tp_report 12:14:29 INFO - PROCESS | 2006 | _x_x_mozilla_page_load 12:14:29 INFO - PROCESS | 2006 | _x_x_mozilla_page_load_details 12:14:29 INFO - PROCESS | 2006 | |i|pagename|runs| 12:14:29 INFO - PROCESS | 2006 | |0;dojo.html;3313.8070294693907;3343.7325013998884;3348.179695974485;3391.4573668213093;3414.0611331883742;5591.916121258185;5704.229928959589;5736.196932429463;5785.595008349412;5822.737976791044;5705.372409035002;5743.339515955656;5748.942510574893;5754.280714910637;5770.278715160605;4619.838305659303;4839.419269687624;5232.529072383485;5249.763760630781;5299.814506492274;4428.247197976336;5296;5305.840824775263;5325.7603407846545;5327.493888080626;5230.712310822903;5267.26258323835;5270.341207349082;5274.841754747345;5311.256424100629;5327.706976116331;5340.893182136336;5350.491703288181;5363.54409875161;5367.785288588452;5095.796168153306;5120.411152717411;5173.689578625294;5250.8687282817855;5258.684478931238;5694.117411801178;5717.028105222123;5745.224394706703;5764.221830052931;5781.624194427391;6290.559660823744;6290.9685451572905;6305.243370795488;6309;6314.494840412802;6163.8150855474405;6232.127502149703;6253.749850005995;6268.091126786636;6299.748010079591;5883.882322353529;5888.735006924699;5895.557833162487;5922.674252916045;5924.992751232301;6260.373962603703;6271.43557079865;6273.153124328157;6281.654509002049;6281.905771413432;6058.545609079249;6103.084537319438;6125.326214116443;6186.226721659793;6203.906941395882;6303.149074874925;6304.18045654062;6305.117283580303;6310;6320.55756097078;6217.751289948352;6262.1546091278005;6262.530310226751;6278.748850046039;6286.842828929313;6133.51829027926;6186.041163619646;6209.0996805462955;6284.528660350492;6319.0837328587095;4983.626228032839;5001.124803159432;5027.824026159067;5030.0694371541385;5034.79860805571;4463.419755431838;4531.886702832456;4536;4554.111948170142;4571.771411429415;5797.536197104221;5799.536037117021;5846.1523079153285;5853.414658534112;5862.853428664317;5213.921791173136;6147.323794382614;6267.6866156692895;6268.153799237045;6304.148939893055;4921.212605983025;5637.43625637433;5682.602217844711;5818;5821;5457.208704737791;5464.3442786865835;5480.643758155787;5525.696086715269;5529.778808847682;5655.943440565542;6220.222472190976;6241.656708881055;6307.085472606538;6354.650494222862;5221.869453263699;5230.476952304739;5260.342457192851;6103.337669688931;6111.37903775109;6295.150154729236;6340.302566717565;6353.047042943595;6359.523035772429;6386.16979792624;6170.969145154246;6175.96912015437;6182.319944805978;6190.535709821871;6212.192414986203;6102.2771839767565;6105.368770830132;6162.815115546541;6168.352323006199;6172.876542469216;6083.802176498202;6130.551011451029;6145.617236121837;6171.13604095418;6177.62934223948;5207.3490813648295;6211.81364559064;6227.034809604518;6230.06549017651;6231.657258850807;5809.419058094157;5857.736401861841;6033.064874944391;6090.512758979359;6097.2683278006925;6117.357677443804;6123.679189354865;6128.717018009172;6184;6184.474319682698;6034.698265086816;6036.547258955684;6043.697815109139;6047.425494578008;6086.239220097488 12:14:29 INFO - PROCESS | 2006 | |1;ext.html;510.27540891933455;518.170926517572;528.3633221967532;543.2584522127297;550.342340902621;30817.075487735347;41207.79396103019;42549.14901701968;42558.787206064;45112.3233151503;44452.110957780904;44879;44906.77546612271;44919.10161796762;44965;9693.12761851435;9876.222279989599;9881.20950323976;9881.407115573053;9882.604695812195;9776.560054797552;9871.555779989918;9879.20966322696;9882.456464894463;9893.950530247375;9845.852312215287;9912.752181195492;9914.405135691846;9935.552900119512;9945.900540994606;9822.361546499455;9883.209343252558;9884.90115098847;9888.25838062141;9888.357256778358;9772.657956971472;9838.163756080741;9839.55721992505;9846.556904939294;9871.457069861155;34071;42041.15917681629;42051.158976820596;42054.57945420537;42251.57748422538;3470.3753324401596;3534.2224710563637;3608.729345299113;3680.208755117636;3738.3271011218244;31573.368532629218;32198.517022244687;32496.18759531007;32582;32596.348073038644;3305.6529064448127;3336.916577085568;3368.006438100766;3387.1362802485455;3411.5053317268857;453699;458468;460008;460294;460539;31695.841520792248;31924.840375797972;31940.680593194236;62204.06693899595;62707.6864615674;34879;35007.4748878767;35042;35085.47371789374;35211.82394088013;14328.355224014944;14509.419623215164;14515.491957781427;14534.563963081124;14546.345414456164;12162.209456385306;12218.450169742206;12219.816702749466;12220.75558488843;12239.755204895851;7856.017997750281;7866.72466463671;7869.921300786918;7957.920420795834;7967.442279040528;3197.6802319768303;3224.1778346521487;3225.8870939517005;3228.5157226416227;3263.0863358259726;989.6288891665625;1005.3666190300064;1030.2633616963758;1044.9320794148357;1120.2046546951592;26773.866130669223;31039.379212415624;31165.065048048597;31256;31812.681873180973;1005.2008653120787;1065.8667666541683;1077.6012875236213;1126.8704099028553;1176.335370515656;13943.233122178377;14244.643883902985;15996.280167392262;16020.038797671943;16704.58238544022;670183;700079;700312;700728;701327;59711.701441492514;60402.0939685905;60412;60472.69763651153;60651.393486064575;1258.6853286678331;1376.078027721429;1398.797174409705;1424.0672359604475;1433.5555977646964;31417.37165256728;31949.36101277915;32165.356692865542;32751.836240818644;33087.172820679676;42734.5726542743;58709.82580348454;59790.40209598022;59874;63633;639282;645078;645896;646913;649320;35548;37016.889493314164;42834;45321.64035078953;46025.769871151766;48428.789280268276;49101;49123;49216;49683.254751178036;30921.8453907729;38615;39603;40485.72522995334;40882.79558602188;38437;39129.6087039126;39477.802610986764;39799;41284.58715412927;38604;39219.60780392159;39439.80280098696;39659.60340396674;39748.40377394284;33816.661833382335;34098.48852267268;34422;35051;35129.64870351366;20905.581888361845;24690.13584524533;25582;26042;26315.605265920643 12:14:29 INFO - PROCESS | 2006 | |2;jquery.html;353.8177838413216;370.84239198340697;371.1759893037458;378.5400738103204;400.98396064157436;15092.47176348828;15468.071915685052;20573.897130514364;20810;20900.37298881034;20514.89742551289;20575.588488230263;21196;21202.575948481022;21251.68122478164;5117.820876269331;5747.137929310606;5916.3787802280785;6000.429959153896;6010.398960103977;5955.910661340084;6067.059605761114;6079.118527813464;6079.20970273866;6085.300190478085;5779.479846813786;6015.0676645120075;6031.638101713911;6089;6146.877062458748;6052.456623561008;6110.694465276741;6144.5084393248435;6145.508359331265;6150.077488376757;5784.045632470637;5840.883182336372;5920.200772895647;5924.348321684612;5926.822195334147;13101.279429631366;13117.803232951514;13192.472301107944;13291.468341266338;13438.731225375535;2242.843000989931;2256.8194544436406;2461.2247142150163;2682.4500977299804;2994;10188.083072523508;10592.68221953335;14192.432302707879;15109.54671359861;16045.679086418206;1824.3341180469165;1841.9079046047643;1932.1981377728366;1941;1954.9120289587004;115992;123199;126345;126368.1044784329;131177.34411327977;11376.601818936297;11457.197996140358;11579.363135027486;11637.243579167327;11787.057035437145;14563;14600.634984125481;14609.415623374945;14612.561623151323;14647.560573182822;8220.342372610177;8341.45780524264;8362.372822038371;8397.874031889527;8497.830043399097;8226.506409615322;8230.62962166704;8231.300339471212;8372.204640559137;8403.24370806618;4508.752018638941;4535.206338890681;4537.478190008125;4542.568455996675;4581.65637577183;1875.6998880179378;1896.8956707381226;1905.180772267938;1908.179482822372;1916.559191385989;690.4234963805178;825.9752207433787;882.7440042387764;923.4643906534194;976.4190306767462;15883.209349633922;16774.664506709796;20413.183472660927;21836.672449913265;22471.775282247294;889.7197382824389;907.9092090790868;957.3777044920718;959.6449313753816;1001.2640709078821;10879.728006799893;11170.664880053611;11197.992180703775;11206.943965280121;11259.887401125883;591871.040644794;593458.0327098337;597716;610422;611497;105623;132931;134033;134478;135141.3242933779;979.3340528440586;996.6212839121088;1011.6964910526813;1018.7300365403174;1019.0471908765328;18723.812761872206;18825.34111306098;18836.058197090366;18855.605990921766;18907.243710251987;52736;55271;56398.71800641135;56606;57504.71247643735;81089;81716.77424838513;83440;83768.58115709382;84185;7095.254998225112;7219.8556028880175;7287.103959045334;7486.326230639269;8249.752507424786;11114.444277785917;11438.767655967345;12070.517179312728;13378.063535552417;13518.729625407634;10423.114035307084;11077.556897724324;11605.245659032136;11639.359835208807;11674.474648641002;8989.876265466817;11044.834327485254;11121.443927803739;11535.250208736405;11627.476763545492;11295.265807722471;11454.599089031844;11484.966353028267;11929.940350298193;11965.282083075042;7338.412926965937;7363.889541656772;7509.7371591994015;7606.9619651901385;7625.809354766176;11065.446727663424;11201.60794372193;11239.494222759831;11594.88405115938;11619.767604648028 12:14:29 INFO - PROCESS | 2006 | |3;mootools.html;1221.8778122187778;1472.9779053314198;1520.0575643101276;1689.5100420877945;1849.6670599292122;7645.388368930486;8092.312153466963;8092.554909479976;8093.231143041402;8125.878111828328;7904;8182.549959752226;8454.704085357014;8462.492250464977;8566.357523185754;2284.3375421127894;2314.1784666443423;2314.560233555619;2314.837961342707;2315.6526521021897;1950.4538729155859;2270.579942710596;2316.073570571776;2323.372689373868;2323.5352929414184;2036.6639504481743;2205.272260154153;2286.9085236590518;2308.134449581407;2330.603797354454;2265.648824432216;2294.27730264966;2296.5062511560095;2305.0318866076286;2307.7692230776956;2302.3208153594564;2312.410335364488;2312.595295823241;2313.363824948136;2318.8492747971327;8558.743237702878;8568.314534837198;8646.394752367336;8687.739367818913;8692.652293908299;5049.166887463564;5097.643164978453;5229.294045303874;5230.293910322096;5231.215317702375;3411.5053317268857;3476.8261586920553;3488.6162522122545;3494.668006539375;3507.789532628025;978.9755256118583;991.2268430624125;1002.684154491333;1006.6979906028163;1017.3590637898151;11281.774364512663;11371.488283027284;11383.317000979885;11406.42967851604;11415.600453984154;4190.20386126635;4413.470383553994;4518.457785065747;4521.615662668644;4528.162289976365;8890.644374225089;8902.86645700315;8910.55447227636;8912.242459390895;8929.955350223338;5129.512696293846;5130.589552835764;5132.615053870974;5137.51193636604;5143.742812859342;4329.740215587012;4479.432198730484;4557.407537020233;4746.2168742157155;4792.880177995578;3610.5306310180035;3629.0927268182954;3732.4401339799247;3754.511913451234;3764.5106136202667;933.3746389918771;1097.632293181793;1113.6659002299277;1120.6301920366259;1124.173732306754;808.871624084399;881.9206271435602;904.8235594059227;923.5105394141116;966.9468179250209;5105.642605017613;5696.629719068247;5898.4101589840675;5963.165156878041;6031.547633927473;807.5840941914919;956.2780101023683;959.5058544849409;969.8836139663144;1009.6264382178641;3458.671426214556;3500.68493835556;3913.8238779255003;3970.909962738384;4190.413342132104;10443.007914248134;10548.208884333706;10671.733206669895;10679.679609611723;10740.140788736882;8104.39217058723;10404.219683523766;10570.418626975435;10641.361518308926;10656.520456579317;7886.605669716606;8022.638981245858;8079.717209897625;8126.146754590801;8142.837143257102;5618.353889302783;5771.307443106686;5821.79623713168;5993.460588547052;6005;7808.375329973702;9602.95198524003;9748.22014238845;9777.315587908779;9789.070038346346;9965.10314071737;10088.142507886618;10095.343802652804;10097.747556311151;10098.646547371101;6674.16572928384;6795.38841504267;7286.417086633162;7303.233160518282;7490.550566966;8061.758147255592;8112.594370281345;8288.254057134645;8295.377846661646;8297.087320394872;6330;7231.204567497676;7293.452991025588;7326.780196594111;7390.556566606021;7199.1001124859395;7258.346748792634;7262.092238470192;7311.780646580611;7333.376662983706;6718.160229971254;6831.658417079226;6908.032875397348;6912.861742765217;6915.723371065101;4875.317455556154;4914.803407863646;4960.801567937242;4990.600751939909;5062.645614806928;4876.561109500162;4884.82903098404;4995.300657907968;5032.194848824171;5042.235217673785 12:14:29 INFO - PROCESS | 2006 | |4;prototype.html;296.8130078050829;299.7691777331454;309.5326057652945;314.36655139893134;318.1727508477958;4327.285997810362;5206.177837756783;5229.660072095311;5238.86902827429;5254.108520932461;4344.913101737963;4882.487338829416;5069.366329208849;5071.949280507194;5246.924380501998;3872.6514613684762;3911.6675082618012;3917.9804100979454;3931.8820435386983;3932.705047121463;3590.838412271441;3719.3491139050693;3815.4086116651965;4022.2558826617023;4037.3742069979053;3859.787711675857;3929.5677475477673;3948.5261768587666;3949.526056873179;3990.3016972029923;3219;3567.554055743032;3985.521737391517;3994.7403418777976;4044.5753195914444;3453.568303962005;3468.757186996911;3470.548828652284;3485.6165821759587;3506.929861402783;4215.831366745327;4250.76834661802;5114.977004599058;5154.149565321717;5162.483751624845;3837.501124853779;4440.911181776379;4568.817247310104;4597.3333866589155;4610.56199661035;4571.725696458223;4693.389859318301;4893.363862697862;5516.420775818521;5525.364583072917;3354.9161270968175;3383.4079036168573;3650.3976843821;3874.670652994499;3887.669548088416;4938.876528086791;5307.946920530784;5801.071828507418;5812.500624731364;5822.475977162034;3419.247765491588;3636.9818150909077;3791.753536020205;3800.8289626966853;3802.429635554689;3601.873934412283;3901.6929328674646;3909.139989202371;3909.6872250219913;3915.960840391617;3775.9244815104094;4368.847090351823;4565.20108980927;4589.816407343669;4592.678512504092;4729.115239703778;4857.4825412366135;5591.539722522078;5591.580631452657;5648.971755141198;1150.6548035589458;1291.7222797098668;1296.5462088269219;1324.6224825924564;1325.9524975269621;706.9964650176819;820.5774026376421;863.5509535041869;889.7063968890251;897.4839467306325;4734.55021772931;4751.809927602857;5184.429712731597;5199.584033277329;5201.375834899836;4333.1766964276685;5295.973520132452;5587.870792356293;5619.522340601095;5727.255456790591;4281.01536646573;4557.043020965634;4631.328457373729;4929.950700492949;5191.131192770599;2943.7792165587666;2968.4656761782653;2979.5679626454044;2981.746551543143;2981.9552706709414;5048.671836330626;5448.126614342867;5749.792543565898;5756.48191662744;5819.592628516048;5019.364833462461;5744.214056182748;5764.337101233328;5788.450097240755;5815.447532484407;5013.5989120870245;5747.5114615257335;5758.2514273144225;5767.394423585547;5783.392743761844;4679.906401872012;5403.297571315704;5489.972550137383;5582.6043489127715;5699.89104031511;5495.560355171657;5556.99974004683;5565.719884426524;5575.303087114111;5602.719864006702;5065.113605119016;5458.317710286215;5708.257926469532;5752.066446112596;5792.653975140075;3247.675232476828;3528.558930133733;3756.549214094326;3788.6021967692996;3838.462615233925;5666.263385759825;5705.543556515552;5710.2291190690385;5728.513076388554;5729.427057294237;5545.890821835568;5548.199483353916;5566;5584.38052964652;5584.86037849057;5253.2701781735395;5462.590305727166;5483.4516548344845;5567.464659940886;5585.888282234414;4682.822487543309;4896.632752543503;5119.97600479898;5435.83692489226;5443.32575511536;4490.326451032372;4926.926096108633;5477.917831232615;5486.0774546199655;5498.725063746877;5360.68663177524;5455.236266922713;5463.235147079492;5464;5480.972595136999 12:14:29 INFO - PROCESS | 2006 | |5;yui.html;603.1585937617022;636.3382082634058;728.1771598094155;735.5219107580073;816.4570560577216;14970.850291497081;16408.58978525536;16414.261358238877;16439.01365918046;16440.342386304532;14620.268986550684;14744.852551474482;14780;14783.408663653441;14788.852111478882;673.4545018534977;695.8190870373688;733.8532293541286;843.3295530053591;851.1658574596898;854.8076682746395;855.2003876375578;856.0711627883722;856.1695155698962;862.5988915154452;915.7802127489388;917.312015988009;917.921976631987;917.9311551633621;924.1590152960807;711.537500624593;728.1444302944072;729.4529103172621;730.6419854271369;914.7941713114529;545.2693390856232;663.7709990053423;672.5325898500544;676.2324761395802;680.404645934807;14640.487582934653;14696.191709455976;14712.55862324132;14725.895557833206;14735.115893046452;13741.587752367444;13977.161370317814;14026.368813403422;14061.78907316391;14088.506902258372;12924;13050.347482625832;13050.934745326213;13050.934745326307;13120.60638180856;4583.9083218335445;4659.091477161955;4660.324252983332;4711.411073615798;4820.927686084677;121981;124604;129133;130259.48702564834;131208;11052.889471105185;11202.831957520644;11243.212975091665;11245.83131253032;11358.716032099099;22095.44761380978;22120.778792212193;22123.668144977837;22130.225442109448;22146.446338841335;6614.177945750556;7862;7987.600619968978;8005.119436861941;8093.676252949934;4393.538678438718;4404.845830395985;4472.396226509444;4522.5929666330185;4638.072385522909;3412.4369479036177;3515.6835884770494;3517.1558825881602;3517.786363704518;3538.2569660371096;650.440621065883;655.1417642887737;663.2670898657011;663.2704025571833;663.9568428052161;609.8444896551351;616.1589430427434;632.6963057732314;651.1860174781523;652.7030201258416;8429.283510901641;8944.284457243404;9101.408408453563;9120.361574689841;9214.078592140731;547.8931608336416;581.528961541153;624.887520246351;628.3119983617931;644.6293381305675;4114.7119701620595;4474.888127796766;4497.595216430537;4550.997561073117;4584.633229341712;105052;124788;162414;167058;179169.10415447838;107192.99999999844;132171.33914330558;150442;152982.23508882386;154833;83630.5818470916;107567;109519.45240273907;113006;114145;9588.472634005197;9882.901170988198;10147.64483243083;10228.948855255676;10295.433751143459;62350.68824656029;62904.685476572326;63480;67038.32404189934;67686;81249.59375203087;93695;101591;104384;104679;12780.360981951051;13077.542286019943;13173.27546984925;13505.594832155051;13619.455221791017;14950.476733314283;15069.47256846005;15080.622984425037;15256.618584535476;15551.37794488253;11504.769904602028;14022;14196.645083872572;14391.208483533506;14537.563873083824;11214;13707.588772336845;13738.587842364745;13827.86172138306;13830.446782128602;13331.33343332849;13406.128601640861;13642.317884105954;13708.108972916729;14201;11325.377104259345;11349.262297950607;11492.37201041665;11831.46758395857;11877.46551405206;10747.785044299226;11325.490352933974;11466;11648.301101933912;11657.825132622847 12:14:29 INFO - PROCESS | 2006 | __end_tp_report 12:14:29 INFO - PROCESS | 2006 | __start_cc_report 12:14:29 INFO - PROCESS | 2006 | _x_x_mozilla_cycle_collect,1445 12:14:29 INFO - PROCESS | 2006 | __end_cc_report 12:14:29 INFO - PROCESS | 2006 | __startTimestamp1470770069775__endTimestamp 12:14:29 INFO - PROCESS | 2006 | 12:14:29 INFO - PROCESS | 2006 | ------- Summary: start ------- 12:14:29 INFO - PROCESS | 2006 | Number of tests: 6 12:14:29 INFO - PROCESS | 2006 | 12:14:29 INFO - PROCESS | 2006 | [#0] dojo.html Cycles:165 Average:5741.14 Median:5924.99 stddev:645.19 (10.9%) stddev-sans-first:618.44 12:14:29 INFO - PROCESS | 2006 | Values: 3313.8 3343.7 3348.2 3391.5 3414.1 5591.9 5704.2 5736.2 5785.6 5822.7 5705.4 5743.3 5748.9 5754.3 5770.3 4619.8 4839.4 5232.5 5249.8 5299.8 4428.2 5296.0 5305.8 5325.8 5327.5 5230.7 5267.3 5270.3 5274.8 5311.3 5327.7 5340.9 5350.5 5363.5 5367.8 5095.8 5120.4 5173.7 5250.9 5258.7 5694.1 5717.0 5745.2 5764.2 5781.6 6290.6 6291.0 6305.2 6309.0 6314.5 6163.8 6232.1 6253.7 6268.1 6299.7 5883.9 5888.7 5895.6 5922.7 5925.0 6260.4 6271.4 6273.2 6281.7 6281.9 6058.5 6103.1 6125.3 6186.2 6203.9 6303.1 6304.2 6305.1 6310.0 6320.6 6217.8 6262.2 6262.5 6278.7 6286.8 6133.5 6186.0 6209.1 6284.5 6319.1 4983.6 5001.1 5027.8 5030.1 5034.8 4463.4 4531.9 4536.0 4554.1 4571.8 5797.5 5799.5 5846.2 5853.4 5862.9 5213.9 6147.3 6267.7 6268.2 6304.1 4921.2 5637.4 5682.6 5818.0 5821.0 5457.2 5464.3 5480.6 5525.7 5529.8 5655.9 6220.2 6241.7 6307.1 6354.7 5221.9 5230.5 5260.3 6103.3 6111.4 6295.2 6340.3 6353.0 6359.5 6386.2 6171.0 6176.0 6182.3 6190.5 6212.2 6102.3 6105.4 6162.8 6168.4 6172.9 6083.8 6130.6 6145.6 6171.1 6177.6 5207.3 6211.8 6227.0 6230.1 6231.7 5809.4 5857.7 6033.1 6090.5 6097.3 6117.4 6123.7 6128.7 6184.0 6184.5 6034.7 6036.5 6043.7 6047.4 6086.2 12:14:29 INFO - PROCESS | 2006 | 12:14:29 INFO - PROCESS | 2006 | [#1] ext.html Cycles:180 Average:72107.06 Median:39704.00 stddev:163110.29 (410.8%) stddev-sans-first:163479.28 12:14:29 INFO - PROCESS | 2006 | Values: 510.3 518.2 528.4 543.3 550.3 30817.1 41207.8 42549.1 42558.8 45112.3 44452.1 44879.0 44906.8 44919.1 44965.0 9693.1 9876.2 9881.2 9881.4 9882.6 9776.6 9871.6 9879.2 9882.5 9894.0 9845.9 9912.8 9914.4 9935.6 9945.9 9822.4 9883.2 9884.9 9888.3 9888.4 9772.7 9838.2 9839.6 9846.6 9871.5 34071.0 42041.2 42051.2 42054.6 42251.6 3470.4 3534.2 3608.7 3680.2 3738.3 31573.4 32198.5 32496.2 32582.0 32596.3 3305.7 3336.9 3368.0 3387.1 3411.5 453699.0 458468.0 460008.0 460294.0 460539.0 31695.8 31924.8 31940.7 62204.1 62707.7 34879.0 35007.5 35042.0 35085.5 35211.8 14328.4 14509.4 14515.5 14534.6 14546.3 12162.2 12218.5 12219.8 12220.8 12239.8 7856.0 7866.7 7869.9 7957.9 7967.4 3197.7 3224.2 3225.9 3228.5 3263.1 989.6 1005.4 1030.3 1044.9 1120.2 26773.9 31039.4 31165.1 31256.0 31812.7 1005.2 1065.9 1077.6 1126.9 1176.3 13943.2 14244.6 15996.3 16020.0 16704.6 670183.0 700079.0 700312.0 700728.0 701327.0 59711.7 60402.1 60412.0 60472.7 60651.4 1258.7 1376.1 1398.8 1424.1 1433.6 31417.4 31949.4 32165.4 32751.8 33087.2 42734.6 58709.8 59790.4 59874.0 63633.0 639282.0 645078.0 645896.0 646913.0 649320.0 35548.0 37016.9 42834.0 45321.6 46025.8 48428.8 49101.0 49123.0 49216.0 49683.3 30921.8 38615.0 39603.0 40485.7 40882.8 38437.0 39129.6 39477.8 39799.0 41284.6 38604.0 39219.6 39439.8 39659.6 39748.4 33816.7 34098.5 34422.0 35051.0 35129.6 20905.6 24690.1 25582.0 26042.0 26315.6 12:14:29 INFO - PROCESS | 2006 | 12:14:29 INFO - PROCESS | 2006 | [#2] jquery.html Cycles:180 Average:35197.17 Median:21544.18 stddev:100599.26 (466.9%) stddev-sans-first:100847.45 12:14:29 INFO - PROCESS | 2006 | Values: 353.8 370.8 371.2 378.5 401.0 15092.5 15468.1 20573.9 20810.0 20900.4 20514.9 20575.6 21196.0 21202.6 21251.7 5117.8 5747.1 5916.4 6000.4 6010.4 5955.9 6067.1 6079.1 6079.2 6085.3 5779.5 6015.1 6031.6 6089.0 6146.9 6052.5 6110.7 6144.5 6145.5 6150.1 5784.0 5840.9 5920.2 5924.3 5926.8 13101.3 13117.8 13192.5 13291.5 13438.7 2242.8 2256.8 2461.2 2682.5 2994.0 10188.1 10592.7 14192.4 15109.5 16045.7 1824.3 1841.9 1932.2 1941.0 1954.9 115992.0 123199.0 126345.0 126368.1 131177.3 11376.6 11457.2 11579.4 11637.2 11787.1 14563.0 14600.6 14609.4 14612.6 14647.6 8220.3 8341.5 8362.4 8397.9 8497.8 8226.5 8230.6 8231.3 8372.2 8403.2 4508.8 4535.2 4537.5 4542.6 4581.7 1875.7 1896.9 1905.2 1908.2 1916.6 690.4 826.0 882.7 923.5 976.4 15883.2 16774.7 20413.2 21836.7 22471.8 889.7 907.9 957.4 959.6 1001.3 10879.7 11170.7 11198.0 11206.9 11259.9 591871.0 593458.0 597716.0 610422.0 611497.0 105623.0 132931.0 134033.0 134478.0 135141.3 979.3 996.6 1011.7 1018.7 1019.0 18723.8 18825.3 18836.1 18855.6 18907.2 52736.0 55271.0 56398.7 56606.0 57504.7 81089.0 81716.8 83440.0 83768.6 84185.0 7095.3 7219.9 7287.1 7486.3 8249.8 11114.4 11438.8 12070.5 13378.1 13518.7 10423.1 11077.6 11605.2 11639.4 11674.5 8989.9 11044.8 11121.4 11535.3 11627.5 11295.3 11454.6 11485.0 11929.9 11965.3 7338.4 7363.9 7509.7 7607.0 7625.8 11065.4 11201.6 11239.5 11594.9 11619.8 12:14:29 INFO - PROCESS | 2006 | 12:14:29 INFO - PROCESS | 2006 | [#3] mootools.html Cycles:180 Average:5517.13 Median:5055.91 stddev:3089.80 (61.1%) stddev-sans-first:3081.61 12:14:29 INFO - PROCESS | 2006 | Values: 1221.9 1473.0 1520.1 1689.5 1849.7 7645.4 8092.3 8092.6 8093.2 8125.9 7904.0 8182.5 8454.7 8462.5 8566.4 2284.3 2314.2 2314.6 2314.8 2315.7 1950.5 2270.6 2316.1 2323.4 2323.5 2036.7 2205.3 2286.9 2308.1 2330.6 2265.6 2294.3 2296.5 2305.0 2307.8 2302.3 2312.4 2312.6 2313.4 2318.8 8558.7 8568.3 8646.4 8687.7 8692.7 5049.2 5097.6 5229.3 5230.3 5231.2 3411.5 3476.8 3488.6 3494.7 3507.8 979.0 991.2 1002.7 1006.7 1017.4 11281.8 11371.5 11383.3 11406.4 11415.6 4190.2 4413.5 4518.5 4521.6 4528.2 8890.6 8902.9 8910.6 8912.2 8930.0 5129.5 5130.6 5132.6 5137.5 5143.7 4329.7 4479.4 4557.4 4746.2 4792.9 3610.5 3629.1 3732.4 3754.5 3764.5 933.4 1097.6 1113.7 1120.6 1124.2 808.9 881.9 904.8 923.5 966.9 5105.6 5696.6 5898.4 5963.2 6031.5 807.6 956.3 959.5 969.9 1009.6 3458.7 3500.7 3913.8 3970.9 4190.4 10443.0 10548.2 10671.7 10679.7 10740.1 8104.4 10404.2 10570.4 10641.4 10656.5 7886.6 8022.6 8079.7 8126.1 8142.8 5618.4 5771.3 5821.8 5993.5 6005.0 7808.4 9603.0 9748.2 9777.3 9789.1 9965.1 10088.1 10095.3 10097.7 10098.6 6674.2 6795.4 7286.4 7303.2 7490.6 8061.8 8112.6 8288.3 8295.4 8297.1 6330.0 7231.2 7293.5 7326.8 7390.6 7199.1 7258.3 7262.1 7311.8 7333.4 6718.2 6831.7 6908.0 6912.9 6915.7 4875.3 4914.8 4960.8 4990.6 5062.6 4876.6 4884.8 4995.3 5032.2 5042.2 12:14:29 INFO - PROCESS | 2006 | 12:14:29 INFO - PROCESS | 2006 | [#4] prototype.html Cycles:180 Average:4426.07 Median:4928.44 stddev:1365.45 (27.7%) stddev-sans-first:1333.64 12:14:29 INFO - PROCESS | 2006 | Values: 296.8 299.8 309.5 314.4 318.2 4327.3 5206.2 5229.7 5238.9 5254.1 4344.9 4882.5 5069.4 5071.9 5246.9 3872.7 3911.7 3918.0 3931.9 3932.7 3590.8 3719.3 3815.4 4022.3 4037.4 3859.8 3929.6 3948.5 3949.5 3990.3 3219.0 3567.6 3985.5 3994.7 4044.6 3453.6 3468.8 3470.5 3485.6 3506.9 4215.8 4250.8 5115.0 5154.1 5162.5 3837.5 4440.9 4568.8 4597.3 4610.6 4571.7 4693.4 4893.4 5516.4 5525.4 3354.9 3383.4 3650.4 3874.7 3887.7 4938.9 5307.9 5801.1 5812.5 5822.5 3419.2 3637.0 3791.8 3800.8 3802.4 3601.9 3901.7 3909.1 3909.7 3916.0 3775.9 4368.8 4565.2 4589.8 4592.7 4729.1 4857.5 5591.5 5591.6 5649.0 1150.7 1291.7 1296.5 1324.6 1326.0 707.0 820.6 863.6 889.7 897.5 4734.6 4751.8 5184.4 5199.6 5201.4 4333.2 5296.0 5587.9 5619.5 5727.3 4281.0 4557.0 4631.3 4930.0 5191.1 2943.8 2968.5 2979.6 2981.7 2982.0 5048.7 5448.1 5749.8 5756.5 5819.6 5019.4 5744.2 5764.3 5788.5 5815.4 5013.6 5747.5 5758.3 5767.4 5783.4 4679.9 5403.3 5490.0 5582.6 5699.9 5495.6 5557.0 5565.7 5575.3 5602.7 5065.1 5458.3 5708.3 5752.1 5792.7 3247.7 3528.6 3756.5 3788.6 3838.5 5666.3 5705.5 5710.2 5728.5 5729.4 5545.9 5548.2 5566.0 5584.4 5584.9 5253.3 5462.6 5483.5 5567.5 5585.9 4682.8 4896.6 5120.0 5435.8 5443.3 4490.3 4926.9 5477.9 5486.1 5498.7 5360.7 5455.2 5463.2 5464.0 5481.0 12:14:29 INFO - PROCESS | 2006 | 12:14:29 INFO - PROCESS | 2006 | [#5] yui.html Cycles:180 Average:25843.41 Median:22108.11 stddev:41880.42 (189.4%) stddev-sans-first:41955.03 12:14:29 INFO - PROCESS | 2006 | Values: 603.2 636.3 728.2 735.5 816.5 14970.9 16408.6 16414.3 16439.0 16440.3 14620.3 14744.9 14780.0 14783.4 14788.9 673.5 695.8 733.9 843.3 851.2 854.8 855.2 856.1 856.2 862.6 915.8 917.3 917.9 917.9 924.2 711.5 728.1 729.5 730.6 914.8 545.3 663.8 672.5 676.2 680.4 14640.5 14696.2 14712.6 14725.9 14735.1 13741.6 13977.2 14026.4 14061.8 14088.5 12924.0 13050.3 13050.9 13050.9 13120.6 4583.9 4659.1 4660.3 4711.4 4820.9 121981.0 124604.0 129133.0 130259.5 131208.0 11052.9 11202.8 11243.2 11245.8 11358.7 22095.4 22120.8 22123.7 22130.2 22146.4 6614.2 7862.0 7987.6 8005.1 8093.7 4393.5 4404.8 4472.4 4522.6 4638.1 3412.4 3515.7 3517.2 3517.8 3538.3 650.4 655.1 663.3 663.3 664.0 609.8 616.2 632.7 651.2 652.7 8429.3 8944.3 9101.4 9120.4 9214.1 547.9 581.5 624.9 628.3 644.6 4114.7 4474.9 4497.6 4551.0 4584.6 105052.0 124788.0 162414.0 167058.0 179169.1 107193.0 132171.3 150442.0 152982.2 154833.0 83630.6 107567.0 109519.5 113006.0 114145.0 9588.5 9882.9 10147.6 10228.9 10295.4 62350.7 62904.7 63480.0 67038.3 67686.0 81249.6 93695.0 101591.0 104384.0 104679.0 12780.4 13077.5 13173.3 13505.6 13619.5 14950.5 15069.5 15080.6 15256.6 15551.4 11504.8 14022.0 14196.6 14391.2 14537.6 11214.0 13707.6 13738.6 13827.9 13830.4 13331.3 13406.1 13642.3 13708.1 14201.0 11325.4 11349.3 11492.4 11831.5 11877.5 10747.8 11325.5 11466.0 11648.3 11657.8 12:14:29 INFO - PROCESS | 2006 | -------- Summary: end -------- 12:14:29 INFO - PROCESS | 2006 | 12:14:30 INFO - TEST-INFO | 2006: exit 0 12:14:30 INFO - TEST-OK | dromaeo_css | took 1117891ms 12:14:30 INFO - TEST-START | kraken 12:14:30 INFO - operating with platform_type : mac_ 12:14:30 INFO - Initialising browser for kraken test... 12:14:30 INFO - TEST-INFO | started process 2011 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/tmpY_1UrU/profile http://localhost:49372/getInfo.html) 12:14:32 INFO - PROCESS | 2011 | __metrics Screen width/height:1600/1200 12:14:32 INFO - PROCESS | 2011 | colorDepth:24 12:14:32 INFO - PROCESS | 2011 | Browser inner width/height: 1024/689 12:14:32 INFO - PROCESS | 2011 | __metrics 12:14:32 INFO - PROCESS | 2011 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 12:14:32 INFO - PROCESS | 2011 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:14:33 INFO - TEST-INFO | 2011: exit 0 12:14:33 INFO - Browser initialized. 12:14:33 INFO - Running cycle 1/1 for kraken test... 12:14:33 INFO - TEST-INFO | started process 2012 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/tmpY_1UrU/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:14:45 INFO - PROCESS | 2012 | RSS: Main: 243286016 12:14:45 INFO - PROCESS | 2012 | 12:14:47 INFO - PROCESS | 2012 | Cycle 1(1): loaded http://localhost:49372/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49372/tests/kraken/driver.html?testName=audio-beat-detection) 12:14:48 INFO - PROCESS | 2012 | RSS: Main: 293167104 12:14:48 INFO - PROCESS | 2012 | 12:14:51 INFO - PROCESS | 2012 | Cycle 1(1): loaded http://localhost:49372/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49372/tests/kraken/driver.html?testName=audio-dft) 12:14:52 INFO - PROCESS | 2012 | RSS: Main: 298655744 12:14:52 INFO - PROCESS | 2012 | 12:14:55 INFO - PROCESS | 2012 | Cycle 1(1): loaded http://localhost:49372/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49372/tests/kraken/driver.html?testName=audio-fft) 12:14:56 INFO - PROCESS | 2012 | RSS: Main: 393756672 12:14:56 INFO - PROCESS | 2012 | 12:14:58 INFO - PROCESS | 2012 | Cycle 1(1): loaded http://localhost:49372/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49372/tests/kraken/driver.html?testName=audio-oscillator) 12:14:58 INFO - PROCESS | 2012 | RSS: Main: 297201664 12:14:58 INFO - PROCESS | 2012 | 12:15:00 INFO - PROCESS | 2012 | Cycle 1(1): loaded http://localhost:49372/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49372/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:15:01 INFO - PROCESS | 2012 | RSS: Main: 301060096 12:15:01 INFO - PROCESS | 2012 | 12:15:04 INFO - PROCESS | 2012 | Cycle 1(1): loaded http://localhost:49372/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49372/tests/kraken/driver.html?testName=imaging-darkroom) 12:15:04 INFO - PROCESS | 2012 | RSS: Main: 340631552 12:15:04 INFO - PROCESS | 2012 | 12:15:08 INFO - PROCESS | 2012 | Cycle 1(1): loaded http://localhost:49372/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49372/tests/kraken/driver.html?testName=imaging-desaturate) 12:15:08 INFO - PROCESS | 2012 | RSS: Main: 339750912 12:15:08 INFO - PROCESS | 2012 | 12:15:11 INFO - PROCESS | 2012 | Cycle 1(1): loaded http://localhost:49372/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49372/tests/kraken/driver.html?testName=json-parse-financial) 12:15:12 INFO - PROCESS | 2012 | RSS: Main: 339365888 12:15:12 INFO - PROCESS | 2012 | 12:15:13 INFO - PROCESS | 2012 | Cycle 1(1): loaded http://localhost:49372/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49372/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:15:14 INFO - PROCESS | 2012 | RSS: Main: 313851904 12:15:14 INFO - PROCESS | 2012 | 12:15:16 INFO - PROCESS | 2012 | Cycle 1(1): loaded http://localhost:49372/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49372/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:15:17 INFO - PROCESS | 2012 | RSS: Main: 321564672 12:15:17 INFO - PROCESS | 2012 | 12:15:19 INFO - PROCESS | 2012 | Cycle 1(1): loaded http://localhost:49372/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49372/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:15:19 INFO - PROCESS | 2012 | RSS: Main: 323342336 12:15:19 INFO - PROCESS | 2012 | 12:15:22 INFO - PROCESS | 2012 | Cycle 1(1): loaded http://localhost:49372/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49372/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:15:23 INFO - PROCESS | 2012 | RSS: Main: 330190848 12:15:23 INFO - PROCESS | 2012 | 12:15:26 INFO - PROCESS | 2012 | Cycle 1(1): loaded http://localhost:49372/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49372/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:15:26 INFO - PROCESS | 2012 | RSS: Main: 331563008 12:15:26 INFO - PROCESS | 2012 | 12:15:28 INFO - PROCESS | 2012 | Cycle 1(1): loaded http://localhost:49372/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49372/tests/kraken/driver.html?testName=ai-astar) 12:15:28 INFO - PROCESS | 2012 | RSS: Main: 375316480 12:15:28 INFO - PROCESS | 2012 | 12:15:28 INFO - PROCESS | 2012 | __start_tp_report 12:15:28 INFO - PROCESS | 2012 | _x_x_mozilla_page_load 12:15:28 INFO - PROCESS | 2012 | _x_x_mozilla_page_load_details 12:15:28 INFO - PROCESS | 2012 | |i|pagename|runs| 12:15:28 INFO - PROCESS | 2012 | |0;ai-astar;102;113;113;114;112;112;113;113;113;112 12:15:28 INFO - PROCESS | 2012 | |1;audio-beat-detection;142;108;109;167;107;107;126;106;141;111 12:15:28 INFO - PROCESS | 2012 | |2;audio-dft;186;185;184;180;182;197;217;185;181;180 12:15:28 INFO - PROCESS | 2012 | |3;audio-fft;77;76;57;87;58;57;60;63;83;56 12:15:28 INFO - PROCESS | 2012 | |4;audio-oscillator;85;82;94;71;71;67;96;69;67;98 12:15:28 INFO - PROCESS | 2012 | |5;imaging-gaussian-blur;90;131;87;84;87;84;87;85;87;84 12:15:28 INFO - PROCESS | 2012 | |6;imaging-darkroom;141;125;94;94;94;94;94;94;105;155 12:15:28 INFO - PROCESS | 2012 | |7;imaging-desaturate;87;86;104;142;144;83;86;102;139;135 12:15:28 INFO - PROCESS | 2012 | |8;json-parse-financial;54;51;51;53;52;53;52;52;53;52 12:15:28 INFO - PROCESS | 2012 | |9;json-stringify-tinderbox;67;68;77;77;74;72;70;70;70;70 12:15:28 INFO - PROCESS | 2012 | |10;stanford-crypto-aes;82;82;85;83;86;84;81;87;85;80 12:15:28 INFO - PROCESS | 2012 | |11;stanford-crypto-ccm;139;137;140;148;137;135;137;135;150;136 12:15:28 INFO - PROCESS | 2012 | |12;stanford-crypto-pbkdf2;164;170;163;168;166;164;165;165;164;162 12:15:28 INFO - PROCESS | 2012 | |13;stanford-crypto-sha256-iterative;66;67;66;68;66;65;65;67;66;67 12:15:28 INFO - PROCESS | 2012 | __end_tp_report 12:15:28 INFO - PROCESS | 2012 | __start_cc_report 12:15:28 INFO - PROCESS | 2012 | _x_x_mozilla_cycle_collect,2091 12:15:28 INFO - PROCESS | 2012 | __end_cc_report 12:15:28 INFO - PROCESS | 2012 | __startTimestamp1470770128855__endTimestamp 12:15:28 INFO - PROCESS | 2012 | 12:15:28 INFO - PROCESS | 2012 | ------- Summary: start ------- 12:15:28 INFO - PROCESS | 2012 | Number of tests: 14 12:15:28 INFO - PROCESS | 2012 | 12:15:28 INFO - PROCESS | 2012 | [#0] ai-astar Cycles:10 Average:111.70 Median:113.00 stddev:3.47 (3.1%) stddev-sans-first:0.67 12:15:28 INFO - PROCESS | 2012 | Values: 102.0 113.0 113.0 114.0 112.0 112.0 113.0 113.0 113.0 112.0 12:15:28 INFO - PROCESS | 2012 | 12:15:28 INFO - PROCESS | 2012 | [#1] audio-beat-detection Cycles:10 Average:122.40 Median:118.50 stddev:21.06 (17.8%) stddev-sans-first:21.11 12:15:28 INFO - PROCESS | 2012 | Values: 142.0 108.0 109.0 167.0 107.0 107.0 126.0 106.0 141.0 111.0 12:15:28 INFO - PROCESS | 2012 | 12:15:28 INFO - PROCESS | 2012 | [#2] audio-dft Cycles:10 Average:187.70 Median:185.00 stddev:11.41 (6.2%) stddev-sans-first:12.09 12:15:28 INFO - PROCESS | 2012 | Values: 186.0 185.0 184.0 180.0 182.0 197.0 217.0 185.0 181.0 180.0 12:15:28 INFO - PROCESS | 2012 | 12:15:28 INFO - PROCESS | 2012 | [#3] audio-fft Cycles:10 Average:67.40 Median:69.50 stddev:12.03 (17.3%) stddev-sans-first:12.25 12:15:28 INFO - PROCESS | 2012 | Values: 77.0 76.0 57.0 87.0 58.0 57.0 60.0 63.0 83.0 56.0 12:15:28 INFO - PROCESS | 2012 | 12:15:28 INFO - PROCESS | 2012 | [#4] audio-oscillator Cycles:10 Average:80.00 Median:83.50 stddev:12.59 (15.1%) stddev-sans-first:13.22 12:15:28 INFO - PROCESS | 2012 | Values: 85.0 82.0 94.0 71.0 71.0 67.0 96.0 69.0 67.0 98.0 12:15:28 INFO - PROCESS | 2012 | 12:15:28 INFO - PROCESS | 2012 | [#5] imaging-gaussian-blur Cycles:10 Average:90.60 Median:87.00 stddev:14.32 (16.5%) stddev-sans-first:15.19 12:15:28 INFO - PROCESS | 2012 | Values: 90.0 131.0 87.0 84.0 87.0 84.0 87.0 85.0 87.0 84.0 12:15:28 INFO - PROCESS | 2012 | 12:15:28 INFO - PROCESS | 2012 | [#6] imaging-darkroom Cycles:10 Average:109.00 Median:94.00 stddev:23.00 (24.5%) stddev-sans-first:21.28 12:15:28 INFO - PROCESS | 2012 | Values: 141.0 125.0 94.0 94.0 94.0 94.0 94.0 94.0 105.0 155.0 12:15:28 INFO - PROCESS | 2012 | 12:15:28 INFO - PROCESS | 2012 | [#7] imaging-desaturate Cycles:10 Average:110.80 Median:113.50 stddev:26.14 (23.0%) stddev-sans-first:26.27 12:15:28 INFO - PROCESS | 2012 | Values: 87.0 86.0 104.0 142.0 144.0 83.0 86.0 102.0 139.0 135.0 12:15:28 INFO - PROCESS | 2012 | 12:15:28 INFO - PROCESS | 2012 | [#8] json-parse-financial Cycles:10 Average:52.30 Median:52.50 stddev:0.95 (1.8%) stddev-sans-first:0.78 12:15:28 INFO - PROCESS | 2012 | Values: 54.0 51.0 51.0 53.0 52.0 53.0 52.0 52.0 53.0 52.0 12:15:28 INFO - PROCESS | 2012 | 12:15:28 INFO - PROCESS | 2012 | [#9] json-stringify-tinderbox Cycles:10 Average:71.50 Median:71.00 stddev:3.47 (4.9%) stddev-sans-first:3.28 12:15:28 INFO - PROCESS | 2012 | Values: 67.0 68.0 77.0 77.0 74.0 72.0 70.0 70.0 70.0 70.0 12:15:28 INFO - PROCESS | 2012 | 12:15:28 INFO - PROCESS | 2012 | [#10] stanford-crypto-aes Cycles:10 Average:83.50 Median:84.50 stddev:2.27 (2.7%) stddev-sans-first:2.35 12:15:28 INFO - PROCESS | 2012 | Values: 82.0 82.0 85.0 83.0 86.0 84.0 81.0 87.0 85.0 80.0 12:15:28 INFO - PROCESS | 2012 | 12:15:28 INFO - PROCESS | 2012 | [#11] stanford-crypto-ccm Cycles:10 Average:139.40 Median:138.00 stddev:5.32 (3.9%) stddev-sans-first:5.64 12:15:28 INFO - PROCESS | 2012 | Values: 139.0 137.0 140.0 148.0 137.0 135.0 137.0 135.0 150.0 136.0 12:15:28 INFO - PROCESS | 2012 | 12:15:28 INFO - PROCESS | 2012 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:165.10 Median:165.00 stddev:2.38 (1.4%) stddev-sans-first:2.49 12:15:28 INFO - PROCESS | 2012 | Values: 164.0 170.0 163.0 168.0 166.0 164.0 165.0 165.0 164.0 162.0 12:15:28 INFO - PROCESS | 2012 | 12:15:28 INFO - PROCESS | 2012 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.30 Median:66.50 stddev:0.95 (1.4%) stddev-sans-first:1.00 12:15:28 INFO - PROCESS | 2012 | Values: 66.0 67.0 66.0 68.0 66.0 65.0 65.0 67.0 66.0 67.0 12:15:28 INFO - PROCESS | 2012 | -------- Summary: end -------- 12:15:28 INFO - PROCESS | 2012 | 12:15:29 INFO - TEST-INFO | 2012: exit 0 12:15:29 INFO - TEST-OK | kraken | took 59292ms 12:15:29 INFO - SUITE-END | took 1177s 12:15:30 INFO - Completed test suite (00:19:37) 12:15:30 INFO - javascript benchmark 12:15:30 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3313.8070294693907, 3343.7325013998884, 3348.179695974485, 3391.4573668213093, 3414.0611331883742, 5591.916121258185, 5704.229928959589, 5736.196932429463, 5785.595008349412, 5822.737976791044, 5705.372409035002, 5743.339515955656, 5748.942510574893, 5754.280714910637, 5770.278715160605, 4619.838305659303, 4839.419269687624, 5232.529072383485, 5249.763760630781, 5299.814506492274, 4428.247197976336, 5296.0, 5305.840824775263, 5325.7603407846545, 5327.493888080626, 5230.712310822903, 5267.26258323835, 5270.341207349082, 5274.841754747345, 5311.256424100629, 5327.706976116331, 5340.893182136336, 5350.491703288181, 5363.54409875161, 5367.785288588452, 5095.796168153306, 5120.411152717411, 5173.689578625294, 5250.8687282817855, 5258.684478931238, 5694.117411801178, 5717.028105222123, 5745.224394706703, 5764.221830052931, 5781.624194427391, 6290.559660823744, 6290.9685451572905, 6305.243370795488, 6309.0, 6314.494840412802, 6163.8150855474405, 6232.127502149703, 6253.749850005995, 6268.091126786636, 6299.748010079591, 5883.882322353529, 5888.735006924699, 5895.557833162487, 5922.674252916045, 5924.992751232301, 6260.373962603703, 6271.43557079865, 6273.153124328157, 6281.654509002049, 6281.905771413432, 6058.545609079249, 6103.084537319438, 6125.326214116443, 6186.226721659793, 6203.906941395882, 6303.149074874925, 6304.18045654062, 6305.117283580303, 6310.0, 6320.55756097078, 6217.751289948352, 6262.1546091278005, 6262.530310226751, 6278.748850046039, 6286.842828929313, 6133.51829027926, 6186.041163619646, 6209.0996805462955, 6284.528660350492, 6319.0837328587095, 4983.626228032839, 5001.124803159432, 5027.824026159067, 5030.0694371541385, 5034.79860805571, 4463.419755431838, 4531.886702832456, 4536.0, 4554.111948170142, 4571.771411429415, 5797.536197104221, 5799.536037117021, 5846.1523079153285, 5853.414658534112, 5862.853428664317, 5213.921791173136, 6147.323794382614, 6267.6866156692895, 6268.153799237045, 6304.148939893055, 4921.212605983025, 5637.43625637433, 5682.602217844711, 5818.0, 5821.0, 5457.208704737791, 5464.3442786865835, 5480.643758155787, 5525.696086715269, 5529.778808847682, 5655.943440565542, 6220.222472190976, 6241.656708881055, 6307.085472606538, 6354.650494222862, 5221.869453263699, 5230.476952304739, 5260.342457192851, 6103.337669688931, 6111.37903775109, 6295.150154729236, 6340.302566717565, 6353.047042943595, 6359.523035772429, 6386.16979792624, 6170.969145154246, 6175.96912015437, 6182.319944805978, 6190.535709821871, 6212.192414986203, 6102.2771839767565, 6105.368770830132, 6162.815115546541, 6168.352323006199, 6172.876542469216, 6083.802176498202, 6130.551011451029, 6145.617236121837, 6171.13604095418, 6177.62934223948, 5207.3490813648295, 6211.81364559064, 6227.034809604518, 6230.06549017651, 6231.657258850807, 5809.419058094157, 5857.736401861841, 6033.064874944391, 6090.512758979359, 6097.2683278006925, 6117.357677443804, 6123.679189354865, 6128.717018009172, 6184.0, 6184.474319682698, 6034.698265086816, 6036.547258955684, 6043.697815109139, 6047.425494578008, 6086.239220097488], "value": 5701.070058893452, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [510.27540891933455, 518.170926517572, 528.3633221967532, 543.2584522127297, 550.342340902621, 30817.075487735347, 41207.79396103019, 42549.14901701968, 42558.787206064, 45112.3233151503, 44452.110957780904, 44879.0, 44906.77546612271, 44919.10161796762, 44965.0, 9693.12761851435, 9876.222279989599, 9881.20950323976, 9881.407115573053, 9882.604695812195, 9776.560054797552, 9871.555779989918, 9879.20966322696, 9882.456464894463, 9893.950530247375, 9845.852312215287, 9912.752181195492, 9914.405135691846, 9935.552900119512, 9945.900540994606, 9822.361546499455, 9883.209343252558, 9884.90115098847, 9888.25838062141, 9888.357256778358, 9772.657956971472, 9838.163756080741, 9839.55721992505, 9846.556904939294, 9871.457069861155, 34071.0, 42041.15917681629, 42051.158976820596, 42054.57945420537, 42251.57748422538, 3470.3753324401596, 3534.2224710563637, 3608.729345299113, 3680.208755117636, 3738.3271011218244, 31573.368532629218, 32198.517022244687, 32496.18759531007, 32582.0, 32596.348073038644, 3305.6529064448127, 3336.916577085568, 3368.006438100766, 3387.1362802485455, 3411.5053317268857, 453699.0, 458468.0, 460008.0, 460294.0, 460539.0, 31695.841520792248, 31924.840375797972, 31940.680593194236, 62204.06693899595, 62707.6864615674, 34879.0, 35007.4748878767, 35042.0, 35085.47371789374, 35211.82394088013, 14328.355224014944, 14509.419623215164, 14515.491957781427, 14534.563963081124, 14546.345414456164, 12162.209456385306, 12218.450169742206, 12219.816702749466, 12220.75558488843, 12239.755204895851, 7856.017997750281, 7866.72466463671, 7869.921300786918, 7957.920420795834, 7967.442279040528, 3197.6802319768303, 3224.1778346521487, 3225.8870939517005, 3228.5157226416227, 3263.0863358259726, 989.6288891665625, 1005.3666190300064, 1030.2633616963758, 1044.9320794148357, 1120.2046546951592, 26773.866130669223, 31039.379212415624, 31165.065048048597, 31256.0, 31812.681873180973, 1005.2008653120787, 1065.8667666541683, 1077.6012875236213, 1126.8704099028553, 1176.335370515656, 13943.233122178377, 14244.643883902985, 15996.280167392262, 16020.038797671943, 16704.58238544022, 670183.0, 700079.0, 700312.0, 700728.0, 701327.0, 59711.701441492514, 60402.0939685905, 60412.0, 60472.69763651153, 60651.393486064575, 1258.6853286678331, 1376.078027721429, 1398.797174409705, 1424.0672359604475, 1433.5555977646964, 31417.37165256728, 31949.36101277915, 32165.356692865542, 32751.836240818644, 33087.172820679676, 42734.5726542743, 58709.82580348454, 59790.40209598022, 59874.0, 63633.0, 639282.0, 645078.0, 645896.0, 646913.0, 649320.0, 35548.0, 37016.889493314164, 42834.0, 45321.64035078953, 46025.769871151766, 48428.789280268276, 49101.0, 49123.0, 49216.0, 49683.254751178036, 30921.8453907729, 38615.0, 39603.0, 40485.72522995334, 40882.79558602188, 38437.0, 39129.6087039126, 39477.802610986764, 39799.0, 41284.58715412927, 38604.0, 39219.60780392159, 39439.80280098696, 39659.60340396674, 39748.40377394284, 33816.661833382335, 34098.48852267268, 34422.0, 35051.0, 35129.64870351366, 20905.581888361845, 24690.13584524533, 25582.0, 26042.0, 26315.605265920643], "value": 19240.408012508662, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [353.8177838413216, 370.84239198340697, 371.1759893037458, 378.5400738103204, 400.98396064157436, 15092.47176348828, 15468.071915685052, 20573.897130514364, 20810.0, 20900.37298881034, 20514.89742551289, 20575.588488230263, 21196.0, 21202.575948481022, 21251.68122478164, 5117.820876269331, 5747.137929310606, 5916.3787802280785, 6000.429959153896, 6010.398960103977, 5955.910661340084, 6067.059605761114, 6079.118527813464, 6079.20970273866, 6085.300190478085, 5779.479846813786, 6015.0676645120075, 6031.638101713911, 6089.0, 6146.877062458748, 6052.456623561008, 6110.694465276741, 6144.5084393248435, 6145.508359331265, 6150.077488376757, 5784.045632470637, 5840.883182336372, 5920.200772895647, 5924.348321684612, 5926.822195334147, 13101.279429631366, 13117.803232951514, 13192.472301107944, 13291.468341266338, 13438.731225375535, 2242.843000989931, 2256.8194544436406, 2461.2247142150163, 2682.4500977299804, 2994.0, 10188.083072523508, 10592.68221953335, 14192.432302707879, 15109.54671359861, 16045.679086418206, 1824.3341180469165, 1841.9079046047643, 1932.1981377728366, 1941.0, 1954.9120289587004, 115992.0, 123199.0, 126345.0, 126368.1044784329, 131177.34411327977, 11376.601818936297, 11457.197996140358, 11579.363135027486, 11637.243579167327, 11787.057035437145, 14563.0, 14600.634984125481, 14609.415623374945, 14612.561623151323, 14647.560573182822, 8220.342372610177, 8341.45780524264, 8362.372822038371, 8397.874031889527, 8497.830043399097, 8226.506409615322, 8230.62962166704, 8231.300339471212, 8372.204640559137, 8403.24370806618, 4508.752018638941, 4535.206338890681, 4537.478190008125, 4542.568455996675, 4581.65637577183, 1875.6998880179378, 1896.8956707381226, 1905.180772267938, 1908.179482822372, 1916.559191385989, 690.4234963805178, 825.9752207433787, 882.7440042387764, 923.4643906534194, 976.4190306767462, 15883.209349633922, 16774.664506709796, 20413.183472660927, 21836.672449913265, 22471.775282247294, 889.7197382824389, 907.9092090790868, 957.3777044920718, 959.6449313753816, 1001.2640709078821, 10879.728006799893, 11170.664880053611, 11197.992180703775, 11206.943965280121, 11259.887401125883, 591871.040644794, 593458.0327098337, 597716.0, 610422.0, 611497.0, 105623.0, 132931.0, 134033.0, 134478.0, 135141.3242933779, 979.3340528440586, 996.6212839121088, 1011.6964910526813, 1018.7300365403174, 1019.0471908765328, 18723.812761872206, 18825.34111306098, 18836.058197090366, 18855.605990921766, 18907.243710251987, 52736.0, 55271.0, 56398.71800641135, 56606.0, 57504.71247643735, 81089.0, 81716.77424838513, 83440.0, 83768.58115709382, 84185.0, 7095.254998225112, 7219.8556028880175, 7287.103959045334, 7486.326230639269, 8249.752507424786, 11114.444277785917, 11438.767655967345, 12070.517179312728, 13378.063535552417, 13518.729625407634, 10423.114035307084, 11077.556897724324, 11605.245659032136, 11639.359835208807, 11674.474648641002, 8989.876265466817, 11044.834327485254, 11121.443927803739, 11535.250208736405, 11627.476763545492, 11295.265807722471, 11454.599089031844, 11484.966353028267, 11929.940350298193, 11965.282083075042, 7338.412926965937, 7363.889541656772, 7509.7371591994015, 7606.9619651901385, 7625.809354766176, 11065.446727663424, 11201.60794372193, 11239.494222759831, 11594.88405115938, 11619.767604648028], "value": 9494.719399867125, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1221.8778122187778, 1472.9779053314198, 1520.0575643101276, 1689.5100420877945, 1849.6670599292122, 7645.388368930486, 8092.312153466963, 8092.554909479976, 8093.231143041402, 8125.878111828328, 7904.0, 8182.549959752226, 8454.704085357014, 8462.492250464977, 8566.357523185754, 2284.3375421127894, 2314.1784666443423, 2314.560233555619, 2314.837961342707, 2315.6526521021897, 1950.4538729155859, 2270.579942710596, 2316.073570571776, 2323.372689373868, 2323.5352929414184, 2036.6639504481743, 2205.272260154153, 2286.9085236590518, 2308.134449581407, 2330.603797354454, 2265.648824432216, 2294.27730264966, 2296.5062511560095, 2305.0318866076286, 2307.7692230776956, 2302.3208153594564, 2312.410335364488, 2312.595295823241, 2313.363824948136, 2318.8492747971327, 8558.743237702878, 8568.314534837198, 8646.394752367336, 8687.739367818913, 8692.652293908299, 5049.166887463564, 5097.643164978453, 5229.294045303874, 5230.293910322096, 5231.215317702375, 3411.5053317268857, 3476.8261586920553, 3488.6162522122545, 3494.668006539375, 3507.789532628025, 978.9755256118583, 991.2268430624125, 1002.684154491333, 1006.6979906028163, 1017.3590637898151, 11281.774364512663, 11371.488283027284, 11383.317000979885, 11406.42967851604, 11415.600453984154, 4190.20386126635, 4413.470383553994, 4518.457785065747, 4521.615662668644, 4528.162289976365, 8890.644374225089, 8902.86645700315, 8910.55447227636, 8912.242459390895, 8929.955350223338, 5129.512696293846, 5130.589552835764, 5132.615053870974, 5137.51193636604, 5143.742812859342, 4329.740215587012, 4479.432198730484, 4557.407537020233, 4746.2168742157155, 4792.880177995578, 3610.5306310180035, 3629.0927268182954, 3732.4401339799247, 3754.511913451234, 3764.5106136202667, 933.3746389918771, 1097.632293181793, 1113.6659002299277, 1120.6301920366259, 1124.173732306754, 808.871624084399, 881.9206271435602, 904.8235594059227, 923.5105394141116, 966.9468179250209, 5105.642605017613, 5696.629719068247, 5898.4101589840675, 5963.165156878041, 6031.547633927473, 807.5840941914919, 956.2780101023683, 959.5058544849409, 969.8836139663144, 1009.6264382178641, 3458.671426214556, 3500.68493835556, 3913.8238779255003, 3970.909962738384, 4190.413342132104, 10443.007914248134, 10548.208884333706, 10671.733206669895, 10679.679609611723, 10740.140788736882, 8104.39217058723, 10404.219683523766, 10570.418626975435, 10641.361518308926, 10656.520456579317, 7886.605669716606, 8022.638981245858, 8079.717209897625, 8126.146754590801, 8142.837143257102, 5618.353889302783, 5771.307443106686, 5821.79623713168, 5993.460588547052, 6005.0, 7808.375329973702, 9602.95198524003, 9748.22014238845, 9777.315587908779, 9789.070038346346, 9965.10314071737, 10088.142507886618, 10095.343802652804, 10097.747556311151, 10098.646547371101, 6674.16572928384, 6795.38841504267, 7286.417086633162, 7303.233160518282, 7490.550566966, 8061.758147255592, 8112.594370281345, 8288.254057134645, 8295.377846661646, 8297.087320394872, 6330.0, 7231.204567497676, 7293.452991025588, 7326.780196594111, 7390.556566606021, 7199.1001124859395, 7258.346748792634, 7262.092238470192, 7311.780646580611, 7333.376662983706, 6718.160229971254, 6831.658417079226, 6908.032875397348, 6912.861742765217, 6915.723371065101, 4875.317455556154, 4914.803407863646, 4960.801567937242, 4990.600751939909, 5062.645614806928, 4876.561109500162, 4884.82903098404, 4995.300657907968, 5032.194848824171, 5042.235217673785], "value": 4428.524088852752, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [296.8130078050829, 299.7691777331454, 309.5326057652945, 314.36655139893134, 318.1727508477958, 4327.285997810362, 5206.177837756783, 5229.660072095311, 5238.86902827429, 5254.108520932461, 4344.913101737963, 4882.487338829416, 5069.366329208849, 5071.949280507194, 5246.924380501998, 3872.6514613684762, 3911.6675082618012, 3917.9804100979454, 3931.8820435386983, 3932.705047121463, 3590.838412271441, 3719.3491139050693, 3815.4086116651965, 4022.2558826617023, 4037.3742069979053, 3859.787711675857, 3929.5677475477673, 3948.5261768587666, 3949.526056873179, 3990.3016972029923, 3219.0, 3567.554055743032, 3985.521737391517, 3994.7403418777976, 4044.5753195914444, 3453.568303962005, 3468.757186996911, 3470.548828652284, 3485.6165821759587, 3506.929861402783, 4215.831366745327, 4250.76834661802, 5114.977004599058, 5154.149565321717, 5162.483751624845, 3837.501124853779, 4440.911181776379, 4568.817247310104, 4597.3333866589155, 4610.56199661035, 4571.725696458223, 4693.389859318301, 4893.363862697862, 5516.420775818521, 5525.364583072917, 3354.9161270968175, 3383.4079036168573, 3650.3976843821, 3874.670652994499, 3887.669548088416, 4938.876528086791, 5307.946920530784, 5801.071828507418, 5812.500624731364, 5822.475977162034, 3419.247765491588, 3636.9818150909077, 3791.753536020205, 3800.8289626966853, 3802.429635554689, 3601.873934412283, 3901.6929328674646, 3909.139989202371, 3909.6872250219913, 3915.960840391617, 3775.9244815104094, 4368.847090351823, 4565.20108980927, 4589.816407343669, 4592.678512504092, 4729.115239703778, 4857.4825412366135, 5591.539722522078, 5591.580631452657, 5648.971755141198, 1150.6548035589458, 1291.7222797098668, 1296.5462088269219, 1324.6224825924564, 1325.9524975269621, 706.9964650176819, 820.5774026376421, 863.5509535041869, 889.7063968890251, 897.4839467306325, 4734.55021772931, 4751.809927602857, 5184.429712731597, 5199.584033277329, 5201.375834899836, 4333.1766964276685, 5295.973520132452, 5587.870792356293, 5619.522340601095, 5727.255456790591, 4281.01536646573, 4557.043020965634, 4631.328457373729, 4929.950700492949, 5191.131192770599, 2943.7792165587666, 2968.4656761782653, 2979.5679626454044, 2981.746551543143, 2981.9552706709414, 5048.671836330626, 5448.126614342867, 5749.792543565898, 5756.48191662744, 5819.592628516048, 5019.364833462461, 5744.214056182748, 5764.337101233328, 5788.450097240755, 5815.447532484407, 5013.5989120870245, 5747.5114615257335, 5758.2514273144225, 5767.394423585547, 5783.392743761844, 4679.906401872012, 5403.297571315704, 5489.972550137383, 5582.6043489127715, 5699.89104031511, 5495.560355171657, 5556.99974004683, 5565.719884426524, 5575.303087114111, 5602.719864006702, 5065.113605119016, 5458.317710286215, 5708.257926469532, 5752.066446112596, 5792.653975140075, 3247.675232476828, 3528.558930133733, 3756.549214094326, 3788.6021967692996, 3838.462615233925, 5666.263385759825, 5705.543556515552, 5710.2291190690385, 5728.513076388554, 5729.427057294237, 5545.890821835568, 5548.199483353916, 5566.0, 5584.38052964652, 5584.86037849057, 5253.2701781735395, 5462.590305727166, 5483.4516548344845, 5567.464659940886, 5585.888282234414, 4682.822487543309, 4896.632752543503, 5119.97600479898, 5435.83692489226, 5443.32575511536, 4490.326451032372, 4926.926096108633, 5477.917831232615, 5486.0774546199655, 5498.725063746877, 5360.68663177524, 5455.236266922713, 5463.235147079492, 5464.0, 5480.972595136999], "value": 3992.315567770827, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [603.1585937617022, 636.3382082634058, 728.1771598094155, 735.5219107580073, 816.4570560577216, 14970.850291497081, 16408.58978525536, 16414.261358238877, 16439.01365918046, 16440.342386304532, 14620.268986550684, 14744.852551474482, 14780.0, 14783.408663653441, 14788.852111478882, 673.4545018534977, 695.8190870373688, 733.8532293541286, 843.3295530053591, 851.1658574596898, 854.8076682746395, 855.2003876375578, 856.0711627883722, 856.1695155698962, 862.5988915154452, 915.7802127489388, 917.312015988009, 917.921976631987, 917.9311551633621, 924.1590152960807, 711.537500624593, 728.1444302944072, 729.4529103172621, 730.6419854271369, 914.7941713114529, 545.2693390856232, 663.7709990053423, 672.5325898500544, 676.2324761395802, 680.404645934807, 14640.487582934653, 14696.191709455976, 14712.55862324132, 14725.895557833206, 14735.115893046452, 13741.587752367444, 13977.161370317814, 14026.368813403422, 14061.78907316391, 14088.506902258372, 12924.0, 13050.347482625832, 13050.934745326213, 13050.934745326307, 13120.60638180856, 4583.9083218335445, 4659.091477161955, 4660.324252983332, 4711.411073615798, 4820.927686084677, 121981.0, 124604.0, 129133.0, 130259.48702564834, 131208.0, 11052.889471105185, 11202.831957520644, 11243.212975091665, 11245.83131253032, 11358.716032099099, 22095.44761380978, 22120.778792212193, 22123.668144977837, 22130.225442109448, 22146.446338841335, 6614.177945750556, 7862.0, 7987.600619968978, 8005.119436861941, 8093.676252949934, 4393.538678438718, 4404.845830395985, 4472.396226509444, 4522.5929666330185, 4638.072385522909, 3412.4369479036177, 3515.6835884770494, 3517.1558825881602, 3517.786363704518, 3538.2569660371096, 650.440621065883, 655.1417642887737, 663.2670898657011, 663.2704025571833, 663.9568428052161, 609.8444896551351, 616.1589430427434, 632.6963057732314, 651.1860174781523, 652.7030201258416, 8429.283510901641, 8944.284457243404, 9101.408408453563, 9120.361574689841, 9214.078592140731, 547.8931608336416, 581.528961541153, 624.887520246351, 628.3119983617931, 644.6293381305675, 4114.7119701620595, 4474.888127796766, 4497.595216430537, 4550.997561073117, 4584.633229341712, 105052.0, 124788.0, 162414.0, 167058.0, 179169.10415447838, 107192.99999999844, 132171.33914330558, 150442.0, 152982.23508882386, 154833.0, 83630.5818470916, 107567.0, 109519.45240273907, 113006.0, 114145.0, 9588.472634005197, 9882.901170988198, 10147.64483243083, 10228.948855255676, 10295.433751143459, 62350.68824656029, 62904.685476572326, 63480.0, 67038.32404189934, 67686.0, 81249.59375203087, 93695.0, 101591.0, 104384.0, 104679.0, 12780.360981951051, 13077.542286019943, 13173.27546984925, 13505.594832155051, 13619.455221791017, 14950.476733314283, 15069.47256846005, 15080.622984425037, 15256.618584535476, 15551.37794488253, 11504.769904602028, 14022.0, 14196.645083872572, 14391.208483533506, 14537.563873083824, 11214.0, 13707.588772336845, 13738.587842364745, 13827.86172138306, 13830.446782128602, 13331.33343332849, 13406.128601640861, 13642.317884105954, 13708.108972916729, 14201.0, 11325.377104259345, 11349.262297950607, 11492.37201041665, 11831.46758395857, 11877.46551405206, 10747.785044299226, 11325.490352933974, 11466.0, 11648.301101933912, 11657.825132622847], "value": 7912.106553782502, "unit": "score"}], "name": "dromaeo_css", "value": 7254.029186092444, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 113.0, 113.0, 114.0, 112.0, 112.0, 113.0, 113.0, 113.0, 112.0], "value": 111.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 108.0, 109.0, 167.0, 107.0, 107.0, 126.0, 106.0, 141.0, 111.0], "value": 122.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [186.0, 185.0, 184.0, 180.0, 182.0, 197.0, 217.0, 185.0, 181.0, 180.0], "value": 187.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 76.0, 57.0, 87.0, 58.0, 57.0, 60.0, 63.0, 83.0, 56.0], "value": 67.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 82.0, 94.0, 71.0, 71.0, 67.0, 96.0, 69.0, 67.0, 98.0], "value": 80.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 131.0, 87.0, 84.0, 87.0, 84.0, 87.0, 85.0, 87.0, 84.0], "value": 90.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 125.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 105.0, 155.0], "value": 109.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 86.0, 104.0, 142.0, 144.0, 83.0, 86.0, 102.0, 139.0, 135.0], "value": 110.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 51.0, 51.0, 53.0, 52.0, 53.0, 52.0, 52.0, 53.0, 52.0], "value": 52.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 77.0, 77.0, 74.0, 72.0, 70.0, 70.0, 70.0, 70.0], "value": 71.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 85.0, 83.0, 86.0, 84.0, 81.0, 87.0, 85.0, 80.0], "value": 83.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 137.0, 140.0, 148.0, 137.0, 135.0, 137.0, 135.0, 150.0, 136.0], "value": 139.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 170.0, 163.0, 168.0, 166.0, 164.0, 165.0, 165.0, 164.0, 162.0], "value": 165.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 66.0, 68.0, 66.0, 65.0, 65.0, 67.0, 66.0, 67.0], "value": 66.3, "unit": "score"}], "name": "kraken", "value": 1457.7, "alertThreshold": 2.0}]} 12:15:30 INFO - Return code: 0 12:15:30 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 12:15:30 INFO - # TBPL SUCCESS # 12:15:30 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 12:15:30 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 12:15:30 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 12:15:30 INFO - 2016-08-09 12:15:30.187 screenresolution[2016:279242] starting screenresolution argv=screenresolution get 12:15:30 INFO - 2016-08-09 12:15:30.190 screenresolution[2016:279242] Display 0: 1600x1200x32@60 12:15:30 INFO - 2016-08-09 12:15:30.196 screenresolution[2017:279245] starting screenresolution argv=screenresolution list 12:15:30 INFO - Available Modes on Display 0 12:15:30 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 12:15:30 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 12:15:30 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 12:15:30 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 12:15:30 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 12:15:30 INFO - Intel Iris: 12:15:30 INFO - Chipset Model: Intel Iris 12:15:30 INFO - Type: GPU 12:15:30 INFO - Bus: Built-In 12:15:30 INFO - VRAM (Dynamic, Max): 1536 MB 12:15:30 INFO - Vendor: Intel (0x8086) 12:15:30 INFO - Device ID: 0x0a2e 12:15:30 INFO - Revision ID: 0x0009 12:15:30 INFO - Displays: 12:15:30 INFO - Display: 12:15:30 INFO - Resolution: 1600 x 1200 @ 60 Hz 12:15:30 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 12:15:30 INFO - Display Serial Number: 1600x1200 60 12:15:30 INFO - Main Display: Yes 12:15:30 INFO - Mirror: Off 12:15:30 INFO - Online: Yes 12:15:30 INFO - Rotation: Supported 12:15:30 INFO - Return code: 0 12:15:30 INFO - Running post-action listener: _resource_record_post_action 12:15:30 INFO - [mozharness: 2016-08-09 19:15:30.442310Z] Finished run-tests step (success) 12:15:30 INFO - Running post-run listener: _resource_record_post_run 12:15:30 INFO - Total resource usage - Wall time: 1212s; CPU: 53.0%; Read bytes: 1645568; Write bytes: 701166592; Read time: 23; Write time: 1939 12:15:30 INFO - TinderboxPrint: CPU usage
53.5% 12:15:30 INFO - TinderboxPrint: I/O read bytes / time
1,645,568 / 23 12:15:30 INFO - TinderboxPrint: I/O write bytes / time
701,166,592 / 1,939 12:15:30 INFO - TinderboxPrint: CPU idle
2,255.2 (46.5%) 12:15:30 INFO - TinderboxPrint: CPU system
972.5 (20.1%) 12:15:30 INFO - TinderboxPrint: CPU user
1,621.9 (33.4%) 12:15:30 INFO - TinderboxPrint: Swap in / out
420,757,504 / 0 12:15:30 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 400876032; Write bytes: 395470848; Read time: 29733; Write time: 806 12:15:30 INFO - run-tests - Wall time: 1178s; CPU: 53.0%; Read bytes: 1530880; Write bytes: 293858304; Read time: 21; Write time: 1098 12:15:30 INFO - Running post-run listener: _upload_blobber_files 12:15:30 INFO - Blob upload gear active. 12:15:30 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:15:30 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 12:15:30 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', 'Autoland', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 12:15:30 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 Autoland -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 12:15:31 INFO - (blobuploader) - INFO - Open directory for files ... 12:15:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 12:15:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:15:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:15:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 12:15:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:15:32 INFO - (blobuploader) - INFO - Done attempting. 12:15:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 12:15:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:15:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:15:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 12:15:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:15:33 INFO - (blobuploader) - INFO - Done attempting. 12:15:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 12:15:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:15:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:15:35 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 12:15:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:15:35 INFO - (blobuploader) - INFO - Done attempting. 12:15:35 INFO - (blobuploader) - INFO - Iteration through files over. 12:15:35 INFO - Return code: 0 12:15:35 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:15:35 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:15:35 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/c2fc94bb4bf3e9325c604c392d41e924582d902c3da7085c46354dd8b989a637ce769c8e0ba6096c82d482dc32c8bf50efe7ac912ff449709343b78c00e95cb2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/d0b79c0e2391cb8a902acabf9caf9cef76f0218c6cc52ab089ddbbe85844390ed357a986e2d6594dadf3f733d10329ac0009c7b130d28d0acd3c790ed311f3cc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/5120f006689e752d7998a37b2400101735c419efae9f7e9905103f2b981f6c51281a71cf1ce9b85d028d966dc668b3cc7aa030afb180053c1806b196ada9a15d"} 12:15:35 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:15:35 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:15:35 INFO - Contents: 12:15:35 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/c2fc94bb4bf3e9325c604c392d41e924582d902c3da7085c46354dd8b989a637ce769c8e0ba6096c82d482dc32c8bf50efe7ac912ff449709343b78c00e95cb2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/d0b79c0e2391cb8a902acabf9caf9cef76f0218c6cc52ab089ddbbe85844390ed357a986e2d6594dadf3f733d10329ac0009c7b130d28d0acd3c790ed311f3cc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/5120f006689e752d7998a37b2400101735c419efae9f7e9905103f2b981f6c51281a71cf1ce9b85d028d966dc668b3cc7aa030afb180053c1806b196ada9a15d"} 12:15:35 INFO - Running post-run listener: copy_logs_to_upload_dir 12:15:35 INFO - Copying logs to upload dir... 12:15:35 INFO - mkdir: /builds/slave/test/build/upload/logs 12:15:35 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1262.853757 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2016-08-09 12:15:35.951340) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-09 12:15:35.954997) ========= 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.u0PW9wkOWx/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.ETnL0WfxrY/Listeners TMPDIR=/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/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_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/c2fc94bb4bf3e9325c604c392d41e924582d902c3da7085c46354dd8b989a637ce769c8e0ba6096c82d482dc32c8bf50efe7ac912ff449709343b78c00e95cb2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/d0b79c0e2391cb8a902acabf9caf9cef76f0218c6cc52ab089ddbbe85844390ed357a986e2d6594dadf3f733d10329ac0009c7b130d28d0acd3c790ed311f3cc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/5120f006689e752d7998a37b2400101735c419efae9f7e9905103f2b981f6c51281a71cf1ce9b85d028d966dc668b3cc7aa030afb180053c1806b196ada9a15d"} build_url:https://queue.taskcluster.net/v1/task/QMxP0Sx4R86BMwt6vqWRBg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011270 build_url: 'https://queue.taskcluster.net/v1/task/QMxP0Sx4R86BMwt6vqWRBg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/c2fc94bb4bf3e9325c604c392d41e924582d902c3da7085c46354dd8b989a637ce769c8e0ba6096c82d482dc32c8bf50efe7ac912ff449709343b78c00e95cb2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/d0b79c0e2391cb8a902acabf9caf9cef76f0218c6cc52ab089ddbbe85844390ed357a986e2d6594dadf3f733d10329ac0009c7b130d28d0acd3c790ed311f3cc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/5120f006689e752d7998a37b2400101735c419efae9f7e9905103f2b981f6c51281a71cf1ce9b85d028d966dc668b3cc7aa030afb180053c1806b196ada9a15d"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-09 12:15:35.988182) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-09 12:15:35.988513) ========= 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.u0PW9wkOWx/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.ETnL0WfxrY/Listeners TMPDIR=/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/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.005218 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-09 12:15:36.037343) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-09 12:15:36.037671) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-09 12:15:36.038005) ========= ========= Total master_lag: 1.90 =========