builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0129 starttime: 1461757028.29 results: success (0) buildid: 20160427025907 builduid: 946947c12dd542b49bd94d42b335f8ba revision: ab0044bfa1df858919797bcd6a9aef76a668cd4a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-27 04:37:08.293126) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-27 04:37:08.293595) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-27 04:37:08.293894) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-27 04:37:08.314429) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-27 04:37:08.314798) ========= 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.e6Erri8krh/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.YdS1dYY70A/Listeners TMPDIR=/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/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-04-27 04:37:08-- 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% 5.44M=0.002s 2016-04-27 04:37:08 (5.44 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.079845 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-27 04:37:08.412507) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-27 04:37:08.412844) ========= 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.e6Erri8krh/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.YdS1dYY70A/Listeners TMPDIR=/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/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.018746 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-27 04:37:08.461896) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-04-27 04:37:08.462263) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev ab0044bfa1df858919797bcd6a9aef76a668cd4a --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev ab0044bfa1df858919797bcd6a9aef76a668cd4a --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.e6Erri8krh/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.YdS1dYY70A/Listeners TMPDIR=/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/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-04-27 04:37:08,531 truncating revision to first 12 chars 2016-04-27 04:37:08,531 Setting DEBUG logging. 2016-04-27 04:37:08,531 attempt 1/10 2016-04-27 04:37:08,531 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/ab0044bfa1df?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-27 04:37:10,280 unpacking tar archive at: mozilla-central-ab0044bfa1df/testing/mozharness/ program finished with exit code 0 elapsedTime=1.992951 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-04-27 04:37:10.473562) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-27 04:37:10.474140) ========= script_repo_revision: ab0044bfa1df858919797bcd6a9aef76a668cd4a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-27 04:37:10.474775) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-27 04:37:10.475198) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-27 04:37:10.491979) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 15 secs) (at 2016-04-27 04:37:10.492520) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.e6Erri8krh/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.YdS1dYY70A/Listeners TMPDIR=/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/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 04:37:10 INFO - MultiFileLogger online at 20160427 04:37:10 in /builds/slave/test 04:37:10 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 04:37:10 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:37:10 INFO - {'append_to_log': False, 04:37:10 INFO - 'base_work_dir': '/builds/slave/test', 04:37:10 INFO - 'blob_upload_branch': 'Firefox', 04:37:10 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:37:10 INFO - 'branch': 'Firefox', 04:37:10 INFO - 'buildbot_json_path': 'buildprops.json', 04:37:10 INFO - 'config_files': ('talos/mac_config.py',), 04:37:10 INFO - 'default_actions': ('clobber', 04:37:10 INFO - 'read-buildbot-config', 04:37:10 INFO - 'download-and-extract', 04:37:10 INFO - 'populate-webroot', 04:37:10 INFO - 'create-virtualenv', 04:37:10 INFO - 'install', 04:37:10 INFO - 'run-tests'), 04:37:10 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:37:10 INFO - 'download_minidump_stackwalk': True, 04:37:10 INFO - 'download_symbols': 'ondemand', 04:37:10 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:37:10 INFO - 'tooltool.py': '/tools/tooltool.py', 04:37:10 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:37:10 INFO - '/tools/misc-python/virtualenv.py')}, 04:37:10 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:37:10 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:37:10 INFO - 'installer_path': 'installer.exe', 04:37:10 INFO - 'log_level': 'info', 04:37:10 INFO - 'log_name': 'talos', 04:37:10 INFO - 'log_to_console': True, 04:37:10 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 04:37:10 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 04:37:10 INFO - 'opt_config_files': (), 04:37:10 INFO - 'pip_index': False, 04:37:10 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:37:10 INFO - 'cmd': ('bash', 04:37:10 INFO - '-c', 04:37:10 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:37:10 INFO - 'enabled': True, 04:37:10 INFO - 'halt_on_failure': False, 04:37:10 INFO - 'name': 'check_screen_resolution'},), 04:37:10 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:37:10 INFO - 'cmd': ('bash', 04:37:10 INFO - '-c', 04:37:10 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:37:10 INFO - 'enabled': True, 04:37:10 INFO - 'halt_on_failure': False, 04:37:10 INFO - 'name': 'check_screen_resolution'},), 04:37:10 INFO - 'run_cmd_checks_enabled': True, 04:37:10 INFO - 'sps_profile': False, 04:37:10 INFO - 'sps_profile_interval': 0, 04:37:10 INFO - 'suite': 'dromaeojs-e10s', 04:37:10 INFO - 'system_bits': '32', 04:37:10 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:37:10 INFO - 'title': 't-yosemite-r7-0129', 04:37:10 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:37:10 INFO - 'use_talos_json': True, 04:37:10 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:37:10 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:37:10 INFO - 'work_dir': 'build'} 04:37:10 INFO - ##### 04:37:10 INFO - ##### Running clobber step. 04:37:10 INFO - ##### 04:37:10 INFO - Running pre-action listener: _resource_record_pre_action 04:37:10 INFO - Running main action method: clobber 04:37:10 INFO - rmtree: /builds/slave/test/build 04:37:10 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:37:12 INFO - Running post-action listener: _resource_record_post_action 04:37:12 INFO - ##### 04:37:12 INFO - ##### Running read-buildbot-config step. 04:37:12 INFO - ##### 04:37:12 INFO - Running pre-action listener: _resource_record_pre_action 04:37:12 INFO - Running main action method: read_buildbot_config 04:37:12 INFO - Using buildbot properties: 04:37:12 INFO - { 04:37:12 INFO - "project": "", 04:37:12 INFO - "product": "firefox", 04:37:12 INFO - "script_repo_revision": "production", 04:37:12 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 04:37:12 INFO - "repository": "", 04:37:12 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 04:37:12 INFO - "buildid": "20160427025907", 04:37:12 INFO - "pgo_build": "False", 04:37:12 INFO - "basedir": "/builds/slave/test", 04:37:12 INFO - "buildnumber": 214, 04:37:12 INFO - "slavename": "t-yosemite-r7-0129", 04:37:12 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 04:37:12 INFO - "platform": "yosemite_r7", 04:37:12 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 04:37:12 INFO - "branch": "mozilla-central", 04:37:12 INFO - "repo_path": "mozilla-central", 04:37:12 INFO - "revision": "ab0044bfa1df858919797bcd6a9aef76a668cd4a", 04:37:12 INFO - "stage_platform": "macosx64", 04:37:12 INFO - "builduid": "946947c12dd542b49bd94d42b335f8ba", 04:37:12 INFO - "slavebuilddir": "test" 04:37:12 INFO - } 04:37:12 INFO - Found installer url https://queue.taskcluster.net/v1/task/b2PQxyzfRb2H8sxK4MAqnA/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg. 04:37:12 INFO - Running post-action listener: _resource_record_post_action 04:37:12 INFO - ##### 04:37:12 INFO - ##### Running download-and-extract step. 04:37:12 INFO - ##### 04:37:12 INFO - Running pre-action listener: _resource_record_pre_action 04:37:12 INFO - Running main action method: download_and_extract 04:37:12 INFO - mkdir: /builds/slave/test/build/tests 04:37: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:37:12 INFO - https://queue.taskcluster.net/v1/task/b2PQxyzfRb2H8sxK4MAqnA/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 04:37:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b2PQxyzfRb2H8sxK4MAqnA/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json 04:37:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b2PQxyzfRb2H8sxK4MAqnA/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json 04:37:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b2PQxyzfRb2H8sxK4MAqnA/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.mac.test_packages.json 04:37:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b2PQxyzfRb2H8sxK4MAqnA/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.mac.test_packages.json'}, attempt #1 04:37:13 INFO - Downloaded 1199 bytes. 04:37:13 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.mac.test_packages.json 04:37:13 INFO - Using the following test package requirements: 04:37:13 INFO - {u'common': [u'firefox-49.0a1.en-US.mac.common.tests.zip'], 04:37:13 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 04:37:13 INFO - u'firefox-49.0a1.en-US.mac.cppunittest.tests.zip'], 04:37:13 INFO - u'gtest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 04:37:13 INFO - u'firefox-49.0a1.en-US.mac.gtest.tests.zip'], 04:37:13 INFO - u'jittest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 04:37:13 INFO - u'jsshell-mac.zip'], 04:37:13 INFO - u'mochitest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 04:37:13 INFO - u'firefox-49.0a1.en-US.mac.mochitest.tests.zip'], 04:37:13 INFO - u'mozbase': [u'firefox-49.0a1.en-US.mac.common.tests.zip'], 04:37:13 INFO - u'reftest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 04:37:13 INFO - u'firefox-49.0a1.en-US.mac.reftest.tests.zip'], 04:37:13 INFO - u'talos': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 04:37:13 INFO - u'firefox-49.0a1.en-US.mac.talos.tests.zip'], 04:37:13 INFO - u'web-platform': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 04:37:13 INFO - u'firefox-49.0a1.en-US.mac.web-platform.tests.zip'], 04:37:13 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 04:37:13 INFO - u'firefox-49.0a1.en-US.mac.xpcshell.tests.zip']} 04:37:13 INFO - Downloading packages: [u'firefox-49.0a1.en-US.mac.common.tests.zip'] for test suite category: common 04:37:13 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:37:13 INFO - https://queue.taskcluster.net/v1/task/b2PQxyzfRb2H8sxK4MAqnA/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 04:37:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b2PQxyzfRb2H8sxK4MAqnA/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 04:37:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b2PQxyzfRb2H8sxK4MAqnA/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 04:37:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b2PQxyzfRb2H8sxK4MAqnA/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip 04:37:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b2PQxyzfRb2H8sxK4MAqnA/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:37:15 INFO - Downloaded 18117239 bytes. 04:37:15 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:37:15 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 04:37:19 INFO - Return code: 0 04:37:19 INFO - Downloading packages: [u'firefox-49.0a1.en-US.mac.common.tests.zip', u'firefox-49.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 04:37:19 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:37:19 INFO - https://queue.taskcluster.net/v1/task/b2PQxyzfRb2H8sxK4MAqnA/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 04:37:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b2PQxyzfRb2H8sxK4MAqnA/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 04:37:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b2PQxyzfRb2H8sxK4MAqnA/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 04:37:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b2PQxyzfRb2H8sxK4MAqnA/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip 04:37:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b2PQxyzfRb2H8sxK4MAqnA/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:37:20 INFO - Downloaded 18117239 bytes. 04:37:20 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:37:20 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 04:37:23 INFO - Return code: 0 04:37:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:37:23 INFO - https://queue.taskcluster.net/v1/task/b2PQxyzfRb2H8sxK4MAqnA/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 04:37:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b2PQxyzfRb2H8sxK4MAqnA/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip 04:37:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b2PQxyzfRb2H8sxK4MAqnA/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip 04:37:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b2PQxyzfRb2H8sxK4MAqnA/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.mac.talos.tests.zip 04:37:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b2PQxyzfRb2H8sxK4MAqnA/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.talos.tests.zip'}, attempt #1 04:37:25 INFO - Downloaded 10840145 bytes. 04:37:25 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:37:25 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 04:37:25 INFO - Return code: 0 04:37:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:37:25 INFO - https://queue.taskcluster.net/v1/task/b2PQxyzfRb2H8sxK4MAqnA/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 04:37:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b2PQxyzfRb2H8sxK4MAqnA/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 04:37:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b2PQxyzfRb2H8sxK4MAqnA/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 04:37:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b2PQxyzfRb2H8sxK4MAqnA/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-49.0a1.en-US.mac.dmg 04:37:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b2PQxyzfRb2H8sxK4MAqnA/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.mac.dmg'}, attempt #1 04:37:37 INFO - Downloaded 110201100 bytes. 04:37:37 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/b2PQxyzfRb2H8sxK4MAqnA/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 04:37:37 INFO - mkdir: /builds/slave/test/properties 04:37:37 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:37:37 INFO - Writing to file /builds/slave/test/properties/build_url 04:37:37 INFO - Contents: 04:37:37 INFO - build_url:https://queue.taskcluster.net/v1/task/b2PQxyzfRb2H8sxK4MAqnA/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 04:37:38 INFO - Running post-action listener: _resource_record_post_action 04:37:38 INFO - Running post-action listener: set_extra_try_arguments 04:37:38 INFO - ##### 04:37:38 INFO - ##### Running populate-webroot step. 04:37:38 INFO - ##### 04:37:38 INFO - Running pre-action listener: _resource_record_pre_action 04:37:38 INFO - Running main action method: populate_webroot 04:37:38 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:37:38 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:37:38 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:37:38 INFO - '--tppagecycles', 04:37:38 INFO - '7'], 04:37:38 INFO - 'tests': ['tsvgm']}}, 04:37:38 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:37:38 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:37:38 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:37:38 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:37:38 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:37:38 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:37:38 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:37:38 INFO - 'talos_options': ['--disable-e10s'], 04:37:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:37:38 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:37:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:37:38 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:37:38 INFO - 'talos_options': ['--disable-e10s'], 04:37:38 INFO - 'tests': ['damp', 'tps']}, 04:37:38 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:37:38 INFO - 'tests': ['damp', 'tps']}, 04:37:38 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:37:38 INFO - 'tests': ['dromaeo_dom']}, 04:37:38 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:37:38 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:37:38 INFO - 'tests': ['a11yr', 04:37:38 INFO - 'ts_paint', 04:37:38 INFO - 'tpaint', 04:37:38 INFO - 'sessionrestore', 04:37:38 INFO - 'sessionrestore_no_auto_restore', 04:37:38 INFO - 'tabpaint']}, 04:37:38 INFO - 'other-e10s': {'tests': ['a11yr', 04:37:38 INFO - 'ts_paint', 04:37:38 INFO - 'tpaint', 04:37:38 INFO - 'sessionrestore', 04:37:38 INFO - 'sessionrestore_no_auto_restore', 04:37:38 INFO - 'tabpaint']}, 04:37:38 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:37:38 INFO - 'ts_paint', 04:37:38 INFO - 'tpaint', 04:37:38 INFO - 'sessionrestore', 04:37:38 INFO - 'sessionrestore_no_auto_restore', 04:37:38 INFO - 'tabpaint']}, 04:37:38 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:37:38 INFO - 'ts_paint', 04:37:38 INFO - 'tpaint', 04:37:38 INFO - 'sessionrestore', 04:37:38 INFO - 'sessionrestore_no_auto_restore', 04:37:38 INFO - 'tabpaint']}, 04:37:38 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:37:38 INFO - 'tests': ['a11yr', 04:37:38 INFO - 'ts_paint', 04:37:38 INFO - 'tpaint', 04:37:38 INFO - 'sessionrestore', 04:37:38 INFO - 'sessionrestore_no_auto_restore', 04:37:38 INFO - 'tabpaint']}, 04:37:38 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:37:38 INFO - 'tests': ['a11yr', 04:37:38 INFO - 'ts_paint', 04:37:38 INFO - 'tpaint', 04:37:38 INFO - 'sessionrestore', 04:37:38 INFO - 'sessionrestore_no_auto_restore', 04:37:38 INFO - 'tabpaint']}, 04:37:38 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:37:38 INFO - 'tests': ['tsvgx', 04:37:38 INFO - 'tsvgr_opacity', 04:37:38 INFO - 'tart', 04:37:38 INFO - 'tscrollx', 04:37:38 INFO - 'cart']}, 04:37:38 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:37:38 INFO - 'tsvgr_opacity', 04:37:38 INFO - 'tart', 04:37:38 INFO - 'tscrollx', 04:37:38 INFO - 'cart']}, 04:37:38 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:37:38 INFO - 'talos_options': ['--disable-e10s'], 04:37:38 INFO - 'tests': ['tp5o']}, 04:37:38 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:37:38 INFO - 'tests': ['tp5o']}, 04:37:38 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:37:38 INFO - 'talos_options': ['--disable-e10s', 04:37:38 INFO - '--xperf_path', 04:37:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:37:38 INFO - 'tests': ['tp5n']}, 04:37:38 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:37:38 INFO - 'talos_options': ['--xperf_path', 04:37:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:37:38 INFO - 'tests': ['tp5n']}}, 04:37:38 INFO - 'talos.zip': {'path': '', 04:37:38 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:37:38 INFO - Running post-action listener: _resource_record_post_action 04:37:38 INFO - ##### 04:37:38 INFO - ##### Running create-virtualenv step. 04:37:38 INFO - ##### 04:37:38 INFO - Running pre-action listener: _resource_record_pre_action 04:37:38 INFO - Running main action method: create_virtualenv 04:37:38 INFO - Creating virtualenv /builds/slave/test/build/venv 04:37:38 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 04:37:38 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:37:38 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:37:38 INFO - Using real prefix '/tools/python27' 04:37:38 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:37:39 INFO - Installing distribute.............................................................................................................................................................................................done. 04:37:42 INFO - Installing pip.................done. 04:37:42 INFO - Return code: 0 04:37:42 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:37: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:37:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:37:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:37: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:37:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:37:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:37:42 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 0x10e981a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e991420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb5b3477560>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e820e00>, '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 0x10e689db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e81bb20>, '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.e6Erri8krh/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.YdS1dYY70A/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/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 04:37:42 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 04:37:42 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 04:37:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.e6Erri8krh/Render', 04:37:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:37:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:37:42 INFO - 'HOME': '/Users/cltbld', 04:37:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:37:42 INFO - 'LOGNAME': 'cltbld', 04:37:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:37:42 INFO - 'MOZ_NO_REMOTE': '1', 04:37:42 INFO - 'NO_EM_RESTART': '1', 04:37:42 INFO - 'PAGER': '/bin/cat', 04:37:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:37:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:37:42 INFO - 'PWD': '/builds/slave/test', 04:37:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:37:42 INFO - 'SHELL': '/bin/bash', 04:37:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YdS1dYY70A/Listeners', 04:37:42 INFO - 'TMPDIR': '/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/', 04:37:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:37:42 INFO - 'USER': 'cltbld', 04:37:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:37:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:37:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:37:42 INFO - 'XPC_FLAGS': '0x0', 04:37:42 INFO - 'XPC_SERVICE_NAME': '0', 04:37:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:37:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:37:42 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 04:37:42 INFO - Cleaning up... 04:37:42 INFO - Return code: 0 04:37:42 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 04:37: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:37:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:37:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:37: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:37:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:37:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:37:42 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>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e981a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e991420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb5b3477560>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e820e00>, '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 0x10e689db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e81bb20>, '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.e6Erri8krh/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.YdS1dYY70A/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/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 04:37:42 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>=0.7.1'] in /builds/slave/test/build 04:37:42 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>=0.7.1 04:37:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.e6Erri8krh/Render', 04:37:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:37:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:37:42 INFO - 'HOME': '/Users/cltbld', 04:37:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:37:42 INFO - 'LOGNAME': 'cltbld', 04:37:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:37:42 INFO - 'MOZ_NO_REMOTE': '1', 04:37:42 INFO - 'NO_EM_RESTART': '1', 04:37:42 INFO - 'PAGER': '/bin/cat', 04:37:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:37:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:37:42 INFO - 'PWD': '/builds/slave/test', 04:37:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:37:42 INFO - 'SHELL': '/bin/bash', 04:37:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YdS1dYY70A/Listeners', 04:37:42 INFO - 'TMPDIR': '/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/', 04:37:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:37:42 INFO - 'USER': 'cltbld', 04:37:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:37:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:37:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:37:42 INFO - 'XPC_FLAGS': '0x0', 04:37:42 INFO - 'XPC_SERVICE_NAME': '0', 04:37:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:37:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:37:42 INFO - Downloading/unpacking psutil>=0.7.1 04:37:42 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 04:37:42 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 04:37:42 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 04:37:42 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 04:37:42 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 04:37:42 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 04:37:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:37:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:37:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:37:46 INFO - Installing collected packages: psutil 04:37:46 INFO - Running setup.py install for psutil 04:37:46 INFO - building 'psutil._psutil_osx' extension 04:37:46 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 04:37:46 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 04:37:46 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 04:37:46 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 04:37:46 INFO - building 'psutil._psutil_posix' extension 04:37:46 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 04:37:46 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 04:37:46 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 04:37:46 INFO - ^ 04:37:46 INFO - 1 warning generated. 04:37:46 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 04:37:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:37:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:37:46 INFO - Successfully installed psutil 04:37:46 INFO - Cleaning up... 04:37:46 INFO - Return code: 0 04:37:46 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 04:37:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:37:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:37:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:37:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:37:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:37:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:37:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e981a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e991420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb5b3477560>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e820e00>, '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 0x10e689db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e81bb20>, '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.e6Erri8krh/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.YdS1dYY70A/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/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 04:37:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 04:37:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 04:37:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.e6Erri8krh/Render', 04:37:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:37:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:37:46 INFO - 'HOME': '/Users/cltbld', 04:37:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:37:46 INFO - 'LOGNAME': 'cltbld', 04:37:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:37:46 INFO - 'MOZ_NO_REMOTE': '1', 04:37:46 INFO - 'NO_EM_RESTART': '1', 04:37:46 INFO - 'PAGER': '/bin/cat', 04:37:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:37:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:37:46 INFO - 'PWD': '/builds/slave/test', 04:37:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:37:46 INFO - 'SHELL': '/bin/bash', 04:37:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YdS1dYY70A/Listeners', 04:37:46 INFO - 'TMPDIR': '/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/', 04:37:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:37:46 INFO - 'USER': 'cltbld', 04:37:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:37:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:37:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:37:46 INFO - 'XPC_FLAGS': '0x0', 04:37:46 INFO - 'XPC_SERVICE_NAME': '0', 04:37:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:37:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:37:47 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:37:47 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 04:37:47 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 04:37:47 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 04:37:47 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 04:37:47 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 04:37:47 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 04:37:49 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:37:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:37:49 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 04:37:49 INFO - Installing collected packages: mozsystemmonitor 04:37:49 INFO - Running setup.py install for mozsystemmonitor 04:37:49 INFO - Successfully installed mozsystemmonitor 04:37:49 INFO - Cleaning up... 04:37:49 INFO - Return code: 0 04:37:49 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:37:49 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:37:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:37:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:37:49 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:37:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:37:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:37:49 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 0x10e981a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e991420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb5b3477560>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e820e00>, '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 0x10e689db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e81bb20>, '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.e6Erri8krh/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.YdS1dYY70A/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/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 04:37:49 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 04:37:49 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 04:37:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.e6Erri8krh/Render', 04:37:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:37:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:37:49 INFO - 'HOME': '/Users/cltbld', 04:37:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:37:49 INFO - 'LOGNAME': 'cltbld', 04:37:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:37:49 INFO - 'MOZ_NO_REMOTE': '1', 04:37:49 INFO - 'NO_EM_RESTART': '1', 04:37:49 INFO - 'PAGER': '/bin/cat', 04:37:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:37:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:37:49 INFO - 'PWD': '/builds/slave/test', 04:37:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:37:49 INFO - 'SHELL': '/bin/bash', 04:37:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YdS1dYY70A/Listeners', 04:37:49 INFO - 'TMPDIR': '/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/', 04:37:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:37:49 INFO - 'USER': 'cltbld', 04:37:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:37:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:37:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:37:49 INFO - 'XPC_FLAGS': '0x0', 04:37:49 INFO - 'XPC_SERVICE_NAME': '0', 04:37:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:37:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:37:50 INFO - Downloading/unpacking blobuploader==1.2.4 04:37:50 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 04:37:50 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 04:37:50 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 04:37:50 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 04:37:50 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 04:37:50 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 04:37:52 INFO - Downloading blobuploader-1.2.4.tar.gz 04:37:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:37:52 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:37: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 04:37: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 04:37: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 04:37: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 04:37: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 04:37: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 04:37:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:37:53 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:37:53 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 04:37:53 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 04:37:53 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 04:37:53 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 04:37:53 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 04:37:53 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 04:37:53 INFO - Downloading docopt-0.6.1.tar.gz 04:37:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:37:53 INFO - Installing collected packages: blobuploader, requests, docopt 04:37:53 INFO - Running setup.py install for blobuploader 04:37:53 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:37:53 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:37:53 INFO - Running setup.py install for requests 04:37:54 INFO - Running setup.py install for docopt 04:37:54 INFO - Successfully installed blobuploader requests docopt 04:37:54 INFO - Cleaning up... 04:37:54 INFO - Return code: 0 04:37:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:37:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:37:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:37:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:37:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:37:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:37:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:37:54 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 0x10e981a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e991420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb5b3477560>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e820e00>, '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 0x10e689db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e81bb20>, '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.e6Erri8krh/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.YdS1dYY70A/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/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 04:37:54 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 04:37:54 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 04:37:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.e6Erri8krh/Render', 04:37:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:37:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:37:54 INFO - 'HOME': '/Users/cltbld', 04:37:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:37:54 INFO - 'LOGNAME': 'cltbld', 04:37:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:37:54 INFO - 'MOZ_NO_REMOTE': '1', 04:37:54 INFO - 'NO_EM_RESTART': '1', 04:37:54 INFO - 'PAGER': '/bin/cat', 04:37:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:37:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:37:54 INFO - 'PWD': '/builds/slave/test', 04:37:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:37:54 INFO - 'SHELL': '/bin/bash', 04:37:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YdS1dYY70A/Listeners', 04:37:54 INFO - 'TMPDIR': '/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/', 04:37:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:37:54 INFO - 'USER': 'cltbld', 04:37:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:37:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:37:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:37:54 INFO - 'XPC_FLAGS': '0x0', 04:37:54 INFO - 'XPC_SERVICE_NAME': '0', 04:37:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:37:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:37:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:37:54 INFO - Running setup.py (path:/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/pip-UaHVVg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:37:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:37:54 INFO - Running setup.py (path:/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/pip-Kar8Z2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:37:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:37:55 INFO - Running setup.py (path:/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/pip-aqogyB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:37:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:37:55 INFO - Running setup.py (path:/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/pip-PZcgYb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:37:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:37:55 INFO - Running setup.py (path:/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/pip-vczs4w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:37:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:37:55 INFO - Running setup.py (path:/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/pip-bSFG1m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:37:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:37:55 INFO - Running setup.py (path:/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/pip-dcwPds-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:37:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:37:55 INFO - Running setup.py (path:/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/pip-_gbre7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:37:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:37:55 INFO - Running setup.py (path:/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/pip-qbboMS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:37:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:37:55 INFO - Running setup.py (path:/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/pip-uHXCMl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:37:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:37:55 INFO - Running setup.py (path:/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/pip-b0WoFh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:37:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:37:55 INFO - Running setup.py (path:/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/pip-Zib69H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:37:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:37:56 INFO - Running setup.py (path:/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/pip-7EXROr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:37:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:37:56 INFO - Running setup.py (path:/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/pip-FztL80-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:37:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:37:56 INFO - Running setup.py (path:/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/pip-c7ARa8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:37:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:37:56 INFO - Running setup.py (path:/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/pip-W8Rqfs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:37:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:37:56 INFO - Running setup.py (path:/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/pip-WyDhLr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:37:56 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:37:56 INFO - Running setup.py install for manifestparser 04:37:56 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:37:56 INFO - Running setup.py install for mozcrash 04:37:56 INFO - Running setup.py install for mozdebug 04:37:56 INFO - Running setup.py install for mozdevice 04:37:57 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:37:57 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:37:57 INFO - Running setup.py install for mozfile 04:37:57 INFO - Running setup.py install for mozhttpd 04:37:57 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:37:57 INFO - Running setup.py install for mozinfo 04:37:57 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:37:57 INFO - Running setup.py install for mozInstall 04:37:57 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:37:57 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:37:57 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:37:57 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:37:57 INFO - Running setup.py install for mozleak 04:37:57 INFO - Running setup.py install for mozlog 04:37:58 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:37:58 INFO - Running setup.py install for moznetwork 04:37:58 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:37:58 INFO - Running setup.py install for mozprocess 04:37:58 INFO - Running setup.py install for mozprofile 04:37:58 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:37:58 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:37:58 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:37:58 INFO - Running setup.py install for mozrunner 04:37:58 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:37:58 INFO - Running setup.py install for mozscreenshot 04:37:58 INFO - Running setup.py install for moztest 04:37:58 INFO - Running setup.py install for mozversion 04:37:59 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:37:59 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:37:59 INFO - Cleaning up... 04:37:59 INFO - Return code: 0 04:37:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:37:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:37:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:37:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:37:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:37:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:37:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:37:59 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 0x10e981a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e991420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb5b3477560>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e820e00>, '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 0x10e689db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e81bb20>, '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.e6Erri8krh/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.YdS1dYY70A/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/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 04:37:59 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 04:37:59 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 04:37:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.e6Erri8krh/Render', 04:37:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:37:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:37:59 INFO - 'HOME': '/Users/cltbld', 04:37:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:37:59 INFO - 'LOGNAME': 'cltbld', 04:37:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:37:59 INFO - 'MOZ_NO_REMOTE': '1', 04:37:59 INFO - 'NO_EM_RESTART': '1', 04:37:59 INFO - 'PAGER': '/bin/cat', 04:37:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:37:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:37:59 INFO - 'PWD': '/builds/slave/test', 04:37:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:37:59 INFO - 'SHELL': '/bin/bash', 04:37:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YdS1dYY70A/Listeners', 04:37:59 INFO - 'TMPDIR': '/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/', 04:37:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:37:59 INFO - 'USER': 'cltbld', 04:37:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:37:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:37:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:37:59 INFO - 'XPC_FLAGS': '0x0', 04:37:59 INFO - 'XPC_SERVICE_NAME': '0', 04:37:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:37:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:37:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:37:59 INFO - Running setup.py (path:/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/pip-ARr3g0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:37:59 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)) 04:37:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:37:59 INFO - Running setup.py (path:/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/pip-hP7ShW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:37:59 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)) 04:37:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:37:59 INFO - Running setup.py (path:/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/pip-q4pXxq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:37:59 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)) 04:37:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:37:59 INFO - Running setup.py (path:/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/pip-6MYBMY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:37:59 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)) 04:37:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:37:59 INFO - Running setup.py (path:/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/pip-QvwQVu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:37:59 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)) 04:37:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:37:59 INFO - Running setup.py (path:/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/pip-wFAHil-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:38:00 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)) 04:38:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:38:00 INFO - Running setup.py (path:/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/pip-9HTg3D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:38:00 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)) 04:38:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:38:00 INFO - Running setup.py (path:/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/pip-vyVZNt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:38:00 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)) 04:38:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:38:00 INFO - Running setup.py (path:/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/pip-bLsKRa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:38:00 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)) 04:38:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:38:00 INFO - Running setup.py (path:/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/pip-eace41-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:38:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 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)) 04:38:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:38:00 INFO - Running setup.py (path:/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/pip-E1oFRa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:38:00 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)) 04:38:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:38:00 INFO - Running setup.py (path:/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/pip-MEyfgB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:38:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 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)) 04:38:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:38:00 INFO - Running setup.py (path:/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/pip-hKC2bH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:38:00 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)) 04:38:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:38:00 INFO - Running setup.py (path:/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/pip-g9TCQA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:38:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 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)) 04:38:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:38:00 INFO - Running setup.py (path:/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/pip-cDt2sR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:38:01 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)) 04:38:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:38:01 INFO - Running setup.py (path:/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/pip-w9_eyZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:38:01 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)) 04:38:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:38:01 INFO - Running setup.py (path:/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/pip-IdB7hG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:38:01 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)) 04:38:01 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)) 04:38:01 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)) 04:38:01 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)) 04:38:01 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)) 04:38:01 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)) 04:38:01 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:38: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 04:38: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 04:38: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 04:38: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 04:38: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 04:38: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 04:38:03 INFO - Downloading blessings-1.6.tar.gz 04:38:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:38:03 INFO - Installing collected packages: blessings 04:38:03 INFO - Running setup.py install for blessings 04:38:03 INFO - Successfully installed blessings 04:38:03 INFO - Cleaning up... 04:38:04 INFO - Return code: 0 04:38:04 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:38:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:38:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:38:04 INFO - Reading from file tmpfile_stdout 04:38:04 INFO - Current package versions: 04:38:04 INFO - blessings == 1.6 04:38:04 INFO - blobuploader == 1.2.4 04:38:04 INFO - docopt == 0.6.1 04:38:04 INFO - manifestparser == 1.1 04:38:04 INFO - mozInstall == 1.12 04:38:04 INFO - mozcrash == 0.17 04:38:04 INFO - mozdebug == 0.1 04:38:04 INFO - mozdevice == 0.48 04:38:04 INFO - mozfile == 1.2 04:38:04 INFO - mozhttpd == 0.7 04:38:04 INFO - mozinfo == 0.9 04:38:04 INFO - mozleak == 0.1 04:38:04 INFO - mozlog == 3.1 04:38:04 INFO - moznetwork == 0.27 04:38:04 INFO - mozprocess == 0.22 04:38:04 INFO - mozprofile == 0.28 04:38:04 INFO - mozrunner == 6.11 04:38:04 INFO - mozscreenshot == 0.1 04:38:04 INFO - mozsystemmonitor == 0.0 04:38:04 INFO - moztest == 0.7 04:38:04 INFO - mozversion == 1.4 04:38:04 INFO - psutil == 3.1.1 04:38:04 INFO - requests == 1.2.3 04:38:04 INFO - wsgiref == 0.1.2 04:38:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:38:04 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:38:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:38:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:38:04 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:38:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:38:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:38:04 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 0x10e981a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e991420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb5b3477560>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e820e00>, '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 0x10e689db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e81bb20>, '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.e6Erri8krh/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.YdS1dYY70A/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/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 04:38:04 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 04:38:04 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 04:38:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.e6Erri8krh/Render', 04:38:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:38:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:38:04 INFO - 'HOME': '/Users/cltbld', 04:38:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:38:04 INFO - 'LOGNAME': 'cltbld', 04:38:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:38:04 INFO - 'MOZ_NO_REMOTE': '1', 04:38:04 INFO - 'NO_EM_RESTART': '1', 04:38:04 INFO - 'PAGER': '/bin/cat', 04:38:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:38:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:38:04 INFO - 'PWD': '/builds/slave/test', 04:38:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:38:04 INFO - 'SHELL': '/bin/bash', 04:38:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YdS1dYY70A/Listeners', 04:38:04 INFO - 'TMPDIR': '/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/', 04:38:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:38:04 INFO - 'USER': 'cltbld', 04:38:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:38:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:38:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:38:04 INFO - 'XPC_FLAGS': '0x0', 04:38:04 INFO - 'XPC_SERVICE_NAME': '0', 04:38:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:38:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:38:04 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)) 04:38:04 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)) 04:38:04 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)) 04:38:04 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)) 04:38:04 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)) 04:38:04 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)) 04:38:04 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)) 04:38:04 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)) 04:38:04 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)) 04:38:04 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)) 04:38:04 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)) 04:38:04 INFO - Cleaning up... 04:38:04 INFO - Return code: 0 04:38:04 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:38:04 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:38:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:38:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:38:04 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:38:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:38:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:38:04 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 0x10e981a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e991420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb5b3477560>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e820e00>, '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 0x10e689db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e81bb20>, '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.e6Erri8krh/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.YdS1dYY70A/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/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 04:38:04 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 04:38:04 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 04:38:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.e6Erri8krh/Render', 04:38:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:38:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:38:04 INFO - 'HOME': '/Users/cltbld', 04:38:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:38:04 INFO - 'LOGNAME': 'cltbld', 04:38:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:38:04 INFO - 'MOZ_NO_REMOTE': '1', 04:38:04 INFO - 'NO_EM_RESTART': '1', 04:38:04 INFO - 'PAGER': '/bin/cat', 04:38:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:38:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:38:04 INFO - 'PWD': '/builds/slave/test', 04:38:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:38:04 INFO - 'SHELL': '/bin/bash', 04:38:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YdS1dYY70A/Listeners', 04:38:04 INFO - 'TMPDIR': '/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/', 04:38:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:38:04 INFO - 'USER': 'cltbld', 04:38:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:38:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:38:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:38:04 INFO - 'XPC_FLAGS': '0x0', 04:38:04 INFO - 'XPC_SERVICE_NAME': '0', 04:38:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:38:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:38:04 INFO - Downloading/unpacking jsonschema 04:38:04 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 04:38:04 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 04:38:04 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 04:38:04 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 04:38:04 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 04:38:04 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 04:38:07 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:38:07 INFO - Downloading/unpacking functools32 (from jsonschema) 04:38:07 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 04:38:07 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 04:38:07 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 04:38:07 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 04:38:07 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 04:38:07 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 04:38:07 INFO - Downloading functools32-3.2.3-2.tar.gz 04:38:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:38:07 INFO - warning: no files found matching '*.txt' 04:38:07 INFO - no previously-included directories found matching 'build' 04:38:07 INFO - no previously-included directories found matching 'dist' 04:38:07 INFO - no previously-included directories found matching '.git*' 04:38:07 INFO - Installing collected packages: jsonschema, functools32 04:38:07 INFO - Running setup.py install for functools32 04:38:07 INFO - warning: no files found matching '*.txt' 04:38:07 INFO - no previously-included directories found matching 'build' 04:38:07 INFO - no previously-included directories found matching 'dist' 04:38:07 INFO - no previously-included directories found matching '.git*' 04:38:07 INFO - Successfully installed jsonschema functools32 04:38:07 INFO - Cleaning up... 04:38:07 INFO - Return code: 0 04:38:07 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:38: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:38:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:38:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:38:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:38:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:38:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:38:08 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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e981a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e991420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb5b3477560>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e820e00>, '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 0x10e689db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e81bb20>, '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.e6Erri8krh/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.YdS1dYY70A/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/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 04:38:08 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', 'flake8'] in /builds/slave/test/build 04:38:08 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 flake8 04:38:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.e6Erri8krh/Render', 04:38:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:38:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:38:08 INFO - 'HOME': '/Users/cltbld', 04:38:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:38:08 INFO - 'LOGNAME': 'cltbld', 04:38:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:38:08 INFO - 'MOZ_NO_REMOTE': '1', 04:38:08 INFO - 'NO_EM_RESTART': '1', 04:38:08 INFO - 'PAGER': '/bin/cat', 04:38:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:38:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:38:08 INFO - 'PWD': '/builds/slave/test', 04:38:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:38:08 INFO - 'SHELL': '/bin/bash', 04:38:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YdS1dYY70A/Listeners', 04:38:08 INFO - 'TMPDIR': '/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/', 04:38:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:38:08 INFO - 'USER': 'cltbld', 04:38:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:38:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:38:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:38:08 INFO - 'XPC_FLAGS': '0x0', 04:38:08 INFO - 'XPC_SERVICE_NAME': '0', 04:38:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:38:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:38:08 INFO - Downloading/unpacking flake8 04:38:08 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 04:38:08 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 04:38:08 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 04:38:08 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 04:38:08 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 04:38:08 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 04:38:11 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:38:11 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:38:11 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 04:38:11 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 04:38:11 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 04:38:11 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 04:38:11 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 04:38:11 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 04:38:11 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:38:11 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:38:11 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 04:38:11 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 04:38:11 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 04:38:11 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 04:38:11 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 04:38:11 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 04:38:12 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:38:12 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 04:38:12 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 04:38:12 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 04:38:12 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 04:38:12 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 04:38:12 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 04:38:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:38:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:38:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:38:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:38:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:38:12 INFO - no previously-included directories found matching 'docs/_build' 04:38:12 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:38:12 INFO - Running setup.py install for pep8 04:38:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:38:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:38:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:38:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:38:13 INFO - no previously-included directories found matching 'docs/_build' 04:38:13 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:38:13 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:38:13 INFO - Cleaning up... 04:38:13 INFO - Return code: 0 04:38:13 INFO - Running post-action listener: _resource_record_post_action 04:38:13 INFO - Running post-action listener: _start_resource_monitoring 04:38:13 INFO - Starting resource monitoring. 04:38:13 INFO - ##### 04:38:13 INFO - ##### Running install step. 04:38:13 INFO - ##### 04:38:13 INFO - Running pre-action listener: _resource_record_pre_action 04:38:13 INFO - Running main action method: install 04:38:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:38:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:38:13 INFO - Reading from file tmpfile_stdout 04:38:13 INFO - Detecting whether we're running mozinstall >=1.0... 04:38:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:38:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:38:13 INFO - Reading from file tmpfile_stdout 04:38:13 INFO - Output received: 04:38:13 INFO - Usage: mozinstall [options] installer 04:38:13 INFO - Options: 04:38:13 INFO - -h, --help show this help message and exit 04:38:13 INFO - -d DEST, --destination=DEST 04:38:13 INFO - Directory to install application into. [default: 04:38:13 INFO - "/builds/slave/test"] 04:38:13 INFO - --app=APP Application being installed. [default: firefox] 04:38:13 INFO - mkdir: /builds/slave/test/build/application 04:38:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 04:38:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 04:38:47 INFO - Reading from file tmpfile_stdout 04:38:47 INFO - Output received: 04:38:47 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 04:38:47 INFO - Running post-action listener: _resource_record_post_action 04:38:47 INFO - ##### 04:38:47 INFO - ##### Running run-tests step. 04:38:47 INFO - ##### 04:38:47 INFO - Running pre-action listener: _resource_record_pre_action 04:38:47 INFO - Running main action method: run_tests 04:38:47 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:38:47 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:38:47 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:38:47 INFO - 2016-04-27 04:38:47.308 screenresolution[2509:36928] starting screenresolution argv=screenresolution get 04:38:47 INFO - 2016-04-27 04:38:47.311 screenresolution[2509:36928] Display 0: 1600x1200x32@60 04:38:47 INFO - 2016-04-27 04:38:47.317 screenresolution[2510:36930] starting screenresolution argv=screenresolution list 04:38:47 INFO - Available Modes on Display 0 04:38:47 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:38:47 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:38:47 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:38:47 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:38:47 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:38:47 INFO - Intel Iris: 04:38:47 INFO - Chipset Model: Intel Iris 04:38:47 INFO - Type: GPU 04:38:47 INFO - Bus: Built-In 04:38:47 INFO - VRAM (Dynamic, Max): 1536 MB 04:38:47 INFO - Vendor: Intel (0x8086) 04:38:47 INFO - Device ID: 0x0a2e 04:38:47 INFO - Revision ID: 0x0009 04:38:47 INFO - Displays: 04:38:47 INFO - Display: 04:38:47 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:38:47 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:38:47 INFO - Display Serial Number: 1600x1200 60 04:38:47 INFO - Main Display: Yes 04:38:47 INFO - Mirror: Off 04:38:47 INFO - Online: Yes 04:38:47 INFO - Rotation: Supported 04:38:47 INFO - Return code: 0 04:38:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:38:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:38:47 INFO - Python 2.7.3 04:38:47 INFO - Return code: 0 04:38:47 INFO - grabbing minidump binary from tooltool 04:38:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:38:47 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e820e00>, '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 0x10e689db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e81bb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:38:47 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 04:38:47 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 04:38:47 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:38:47 INFO - Return code: 0 04:38:47 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 04:38:47 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:38:47 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:38:47 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 04:38:47 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:38:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:38:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:38:48 INFO - Return code: 0 04:38:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/b2PQxyzfRb2H8sxK4MAqnA/artifacts/public/build/firefox-49.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0129', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 04:38:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/b2PQxyzfRb2H8sxK4MAqnA/artifacts/public/build/firefox-49.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0129 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 04:38:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.e6Erri8krh/Render', 04:38:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:38:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:38:48 INFO - 'HOME': '/Users/cltbld', 04:38:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:38:48 INFO - 'LOGNAME': 'cltbld', 04:38:48 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:38:48 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 04:38:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:38:48 INFO - 'MOZ_NO_REMOTE': '1', 04:38:48 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:38:48 INFO - 'NO_EM_RESTART': '1', 04:38:48 INFO - 'PAGER': '/bin/cat', 04:38:48 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:38:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:38:48 INFO - 'PWD': '/builds/slave/test', 04:38:48 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:38:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:38:48 INFO - 'SHELL': '/bin/bash', 04:38:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YdS1dYY70A/Listeners', 04:38:48 INFO - 'TMPDIR': '/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/', 04:38:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:38:48 INFO - 'USER': 'cltbld', 04:38:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:38:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:38:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:38:48 INFO - 'XPC_FLAGS': '0x0', 04:38:48 INFO - 'XPC_SERVICE_NAME': '0', 04:38:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:38:48 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/b2PQxyzfRb2H8sxK4MAqnA/artifacts/public/build/firefox-49.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0129', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 04:38:48 INFO - mozversion application_buildid: 20160427025907 04:38:48 INFO - mozversion application_changeset: ab0044bfa1df858919797bcd6a9aef76a668cd4a 04:38:48 INFO - mozversion application_display_name: Nightly 04:38:48 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:38:48 INFO - mozversion application_name: Firefox 04:38:48 INFO - mozversion application_remotingname: firefox 04:38:48 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:38:48 INFO - mozversion application_vendor: Mozilla 04:38:48 INFO - mozversion application_version: 49.0a1 04:38:48 INFO - mozversion platform_buildid: 20160427025907 04:38:48 INFO - mozversion platform_changeset: ab0044bfa1df858919797bcd6a9aef76a668cd4a 04:38:48 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:38:48 INFO - mozversion platform_version: 49.0a1 04:38:48 INFO - using testdate: 1461757128 04:38:48 INFO - actual date: 1461757128 04:38:48 INFO - starting webserver on 'localhost:51914' 04:38:48 INFO - SUITE-START | Running 2 tests 04:38:48 INFO - TEST-START | dromaeo_css 04:38:48 INFO - operating with platform_type : mac_ 04:38:48 INFO - Initialising browser for dromaeo_css test... 04:38:48 INFO - TEST-INFO | started process 2528 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/tmpUjuqT5/profile http://localhost:51914/getInfo.html) 04:38:51 INFO - PROCESS | 2528 | __metrics Screen width/height:1600/1200 04:38:51 INFO - PROCESS | 2528 | colorDepth:24 04:38:51 INFO - PROCESS | 2528 | Browser inner width/height: 1024/689 04:38:51 INFO - PROCESS | 2528 | __metrics 04:38:51 ERROR - PROCESS | 2528 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 04:38:52 INFO - TEST-INFO | 2528: exit 0 04:38:52 INFO - Browser initialized. 04:38:52 INFO - Running cycle 1/1 for dromaeo_css test... 04:38:52 INFO - TEST-INFO | started process 2531 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/tmpUjuqT5/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:39:04 INFO - PROCESS | 2531 | RSS: Main: 249819136 04:39:04 INFO - PROCESS | 2531 | 04:39:54 INFO - PROCESS | 2531 | 1461757194169 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] 04:42:04 INFO - PROCESS | 2531 | Cycle 1(1): loaded http://localhost:51914/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51914/tests/dromaeo/cssquery-ext.html) 04:42:06 INFO - PROCESS | 2531 | RSS: Main: 265146368 04:42:06 INFO - PROCESS | 2531 | 04:45:08 INFO - PROCESS | 2531 | Cycle 1(1): loaded http://localhost:51914/tests/dromaeo/cssquery-ext.html (next: http://localhost:51914/tests/dromaeo/cssquery-jquery.html) 04:45:09 INFO - PROCESS | 2531 | RSS: Main: 276877312 04:45:09 INFO - PROCESS | 2531 | 04:48:10 INFO - PROCESS | 2531 | Cycle 1(1): loaded http://localhost:51914/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51914/tests/dromaeo/cssquery-mootools.html) 04:48:11 INFO - PROCESS | 2531 | RSS: Main: 278646784 04:48:11 INFO - PROCESS | 2531 | 04:51:13 INFO - PROCESS | 2531 | Cycle 1(1): loaded http://localhost:51914/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51914/tests/dromaeo/cssquery-prototype.html) 04:51:13 INFO - PROCESS | 2531 | RSS: Main: 280227840 04:51:13 INFO - PROCESS | 2531 | 04:54:16 INFO - PROCESS | 2531 | Cycle 1(1): loaded http://localhost:51914/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51914/tests/dromaeo/cssquery-yui.html) 04:54:17 INFO - PROCESS | 2531 | RSS: Main: 283148288 04:54:17 INFO - PROCESS | 2531 | 04:57:19 INFO - PROCESS | 2531 | Cycle 1(1): loaded http://localhost:51914/tests/dromaeo/cssquery-yui.html (next: http://localhost:51914/tests/dromaeo/cssquery-dojo.html) 04:57:20 INFO - PROCESS | 2531 | RSS: Main: 284528640 04:57:20 INFO - PROCESS | 2531 | 04:57:20 INFO - PROCESS | 2531 | __start_tp_report 04:57:20 INFO - PROCESS | 2531 | _x_x_mozilla_page_load 04:57:20 INFO - PROCESS | 2531 | _x_x_mozilla_page_load_details 04:57:20 INFO - PROCESS | 2531 | |i|pagename|runs| 04:57:20 INFO - PROCESS | 2531 | |0;dojo.html;2879.7975873850723;3414.573178352706;3431.3137372525503;3480.303939212158;3492.7729697569657;5541.5289700375415;5591.4688104630095;5597.58018148639;5605.467480589347;5627.071533197018;4420.31485119807;5576.637518561291;5632.464915832999;5671.517920976722;5719.113537401699;5128.435872054071;5160.25176349431;5164.819231326905;5201.0898092833795;5215.21771734241;5188.92216616751;5197.298364720771;5239.816606418776;5258.13240815265;5267.420583735786;3976.5228172619472;5060.79756809729;5098.107831129556;5214.035403450373;5231.764570594332;5140.3060586820675;5141.38303403594;5175.068487672217;5179.378474583074;5251.6061295402615;4436.889077773049;5028.094942910275;5032.723200223986;5161.406438259611;5205.063088644042;5362.35651721792;5478.315210598676;5522.641028333145;5567.721613919288;5610.69141197234;5023.321851550067;5817.650940943515;6065.848353791191;6197.628142311476;6209.316975132731;6111.561351782692;6127.172831667713;6235.563510554263;6244.500439964792;6254.6247225166635;5735.713214339266;5755.021646320052;5755.251817263729;5762.394948530427;5819.854503637443;6240.095186198067;6244.843878903063;6248.28144763349;6254.499640028786;6259.061140828912;5924.200232968494;6025.849353766103;6103.511719062464;6119.877602448015;6142.877142457126;6054.8183554493435;6190.442860142609;6204.565680402328;6204.5967012144065;6213.316535181127;6108.725107370179;6142.416470435302;6172.845678858064;6186.721597528122;6206.596571222946;4919.409670839451;6074.726637301332;6120.969395152996;6187.84530386744;6198.194234749544;4151.14901445203;4889.095517329305;4893.388326459192;4906.754662266872;4915.58217551505;4337.566243375637;4371.497277813029;4396;4399.428074350378;4426.955730442719;5562.833115006556;5615.157726341082;5733.512651424676;5752.741126649227;5768.163616275617;6217.626942383381;6222.279679389088;6237.563370564017;6240.126382306481;6254.468370188585;5670.688112153871;5673.290838645169;5675.489205971482;5692.57305702074;5706.885862282731;4750.453697824725;5170.6380553360905;5310.734463276821;5388.299521062237;5428.891422171534;5512.614117011771;5843.678597677083;6329.398707122816;6337.239531256371;6354.364563543609;6127.877442451215;6229.4393504584805;6240.656763877849;6247.625142491465;6254.781082662085;6210.782622608368;6266.2480502338185;6291.465225455888;6295.244570651551;6296.5277604178955;6084.847878803065;6110.633361998294;6119.938800612115;6121.265448146251;6132.08018797184;4827.686200396963;6083.6045657032155;6140.746504631453;6224.751009959551;6229;5949.672767997802;6020.036794112921;6097.969510152421;6125.203723515914;6133.785317513865;4993.750312484434;6015.338312785678;6059.121427392915;6106.6946652668075;6118.816435506942;4978.2781496682055;5814.767409303749;5953.76184952597;5996.850078748066;5999.640021598718;6026.216591843032;6052.546059045501;6080.422359875804;6101.328853826164;6141.955867502446;5948.732307046107;5967.880642387041;5968.970155149196;5978.641281522949;5983.670898100472 04:57:20 INFO - PROCESS | 2531 | |1;ext.html;500.80718923214573;512.3109417833015;536.8979893820175;559.0579872914143;566.6203643558821;36253.81873090634;36332.81833590832;36350.81824590873;37122.25755484889;37206.06984825377;37539.061523461925;37593.248135037284;38179.80910095446;38222.23555528888;38280.80859595698;9037.638494460214;9097.408668436563;9146.405483643543;9264.073592640749;9270.026647202048;9133.36066475347;9238.260939124888;9279.582418791137;9338.066193380675;9344.626214951393;8775.946886373644;9216.769580760467;9263.027382124881;9331.860022099674;9368.625254989793;7012.859742805166;7790.493617914845;9284.118008789153;9294.163525282689;9320.487373194472;9040.095990400907;9117.49853758043;9157.725268241964;9244.260459163252;9257.398269112553;26992.86503567489;36535.4519682205;36808.81595592032;36909.26181476355;37090.443643345374;3010.969890301091;3169.2710676544293;3282.720968717662;3470.7396945229207;3854.383298672227;18330.816691833177;26677.199624390807;27023.45953080947;27232.31919202016;27250.72749272502;2603.609458581209;2618.0574993002506;2638.4327369615626;2647.4440367522843;2765.1013420638174;312189;326484;351454.99999999744;353090;354896;33324.66675333216;34161.31677366439;34313.48529772055;34369.48445773315;34412.139696507285;34954.47568286478;35057;35153;35376.64623353785;35452.468212976826;14828.70342593142;15000.399984000736;15122.470713525194;15147.242637868283;15165.317560709795;10651.573937042587;12310.953568946561;12703.047271454678;12740.872591274154;12741.10812243134;7927;8049.879251811228;8086.797830054295;8121.675132994614;8182;3327.600687917417;3395.151212196951;3400.540926974876;3416.79499230047;3446.672566106216;974.4007435427303;1019.6074511313197;1036.264257368904;1039.719275795531;1168.3457263932225;19257.80742192588;26791.660416979463;28376.432471350457;28791.136265912057;28951.276218094295;1019.4291196929743;1026.4970164619433;1081.9404932728619;1099.631623406152;1103.6027030269097;11502.907223813725;14067.788983165055;14891;15146.091234525964;15272;494890;506496;507196;510499;513309;59228.40771592229;59549.70225148847;59597.106043408516;59730.10404843931;59870.70064649649;1434.3258668425824;1487.2786698451243;1487.5834766265464;1489.6797188604503;1495.0730547060675;28592.285192870346;28680.85276588913;28870.42259154763;29373;29373.70626293795;50480.74759626178;51796.741016294676;53252;53269.733651331495;53393.19910201428;467016;472726;479035;479721.6013919908;480792;39492.60507395004;41128;41782.95542611459;41802;41837;44481;44929.32606010978;44999.775001124784;45013.874653133935;45518.77240613776;36691.89924302275;37074.6292537082;37198;37384.626153739206;37511.62488375081;36846.815765921;36858.8157059213;37169.628303716614;37583.43624845684;37761.2447751049;35634.46548301829;36096.45855312225;36834.63165368312;37085.072873177305;37541.81229093837;30443.086707398812;30654.540181896842;30757.38485230238;31284.37431251408;32265.193370165933;17132.914335428242;22259.55312904656;23177.88411057934;24091.759082408953;24095 04:57:20 INFO - PROCESS | 2531 | |2;jquery.html;338.9729120764085;392.12556000119713;400.6054036773778;403.80819110922295;408.311994289622;18432.631347373062;19797;20778.48053798654;20783.064762085705;20895;19535.316263930767;20161.899190504064;20199.49501262469;20378;20455.488612784688;5444.020076386249;5586.13414920687;5728.283964504437;5735.397783232763;5805.82582522525;4949.787302110988;5521.089020311644;5551.666899986014;5577.107662773957;5687.17535957286;4674.555917187861;5538.75075621598;5629.408912064236;5643.661380317194;5658.236138121362;5557.72211389433;5616.747246373902;5632.746526406321;5642.379338272786;5660.60375773696;4907.950920490785;4909.975450122763;5015.1975683890405;5017.147084995559;5020.196768517019;24216;24447.511049778906;24701.25896223116;24975.250742477572;25007.374815629573;2146.4633841539617;2205.426589086833;2323.5585238804574;2559.4113353928515;2841.8863245470156;14116.576502704935;14543.49097781583;14545.127292362493;14586.70826583473;14908.478203262834;1499.8975752821668;1705.8123606403285;1746.1967494952337;1768.5490199998917;1794.0760508338217;105194;105560.41659375116;106044.40933386005;107085.3937190935;107602;10278.794424111476;10306.505556694237;10565.577376904837;10684.145268378667;11151.944240278746;13538.79691804604;13670.384832682554;13770.724585508233;13798.448062077405;13828.101173423694;7481.802911534129;8443.155684431631;8533.829323413496;8682;8833.69082082124;8777.42946708462;8795.53724957013;8801.911980880237;8914;8950.14973577509;6536.084948107269;6665.633390163491;6677.899831502531;6681.76613818514;6746.325367463214;1850.12119243361;1883.7456943312752;1883.7833649130525;1890.5253901956496;1925.8555608329432;921.7142685767434;941.6798288581778;967.9854802177973;993.1409330928839;1037.8339465685453;19197.424077277705;19792.50518737014;19845.00774961246;20041.29855455052;20484.79515204829;671.4427025568766;893.1559676106148;950.7955789505289;969.3602222533094;1038.0398131728273;9996.50017499122;10002.449865257335;10331.380117192843;10352.171826254033;10593.57625694979;593637.0636293668;604569;610066;611435;638799;96816.51591741997;97109;121422.392888035;122199;123393.38303308426;997.7356000659831;1010.4038617215878;1035.0787798859021;1037.0303765978833;1043.5147656339839;14768.556943291718;15725;16100.03399796016;17298.394556190473;17654;42568.78715606402;42845.78577107094;44009.77995110004;44548.77725611351;48963.75518122387;64661.35338646553;66790.99813502704;66869.32826679372;66896;68328.65835670789;7847.136814950237;7982.800429989296;8002.759917202493;8045.637946292314;8390.748277551684;11688.240264382788;11716.626698641223;12195.573154939535;12540.686482838002;12711.61865144047;9968.451735154636;10616.734581635521;10623.946880265548;10820.242583019113;10942.069924056545;7092;9552.949175590818;10258.58965641366;10669.986351296615;10708.732281692708;9069.63721451161;10219.1824654026;10640;10648;11032.338059716443;7992.320652744582;8001.039875215011;8029.237222463857;8145.104038555635;8162.755117346489;7994.480358776661;9416.764580885532;10646.680599582025;10816.708850668545;10935.726606834893 04:57:20 INFO - PROCESS | 2531 | |3;mootools.html;1463.2610531681498;1620.4328485030237;1870.4201697473784;1963.9803601963977;1991.770946341171;8068.1125076241715;8507.149285071497;8553.529555874424;8818.514981676006;8837.91162088378;8642.438241514314;8649.048604653499;8708.17272359125;8714.651413943451;8767.780805479866;2417.842840215385;2455.8894849731714;2459.053264493174;2461.3108329667634;2464.5687004774095;2296.2537175418056;2401.8655654371037;2445.8654773987423;2448.1431498975394;2448.6449464827588;2404.9759502405013;2409.783119519243;2414.311921102486;2417.746136655652;2447;2000.5098750806;2385.224801939368;2401.5317013182434;2406.602910519762;2416.178499310243;2386;2391.712994440661;2393.293978276395;2400.5198960208027;2401.903923843044;8773;8859.379843410963;8875.958529538242;8884.333674974338;8891.911080889173;5310.973445132789;5431.646942948735;5483.150111732688;5522.502974732253;5537.390887002426;3025.848707564613;3530.0468873404293;3543.6810687038032;3578.8210589470423;3609.8195090245645;850.3622283287534;1023.8822535408449;1036.5905467340433;1040.9947950260275;1066.610687099211;9214.216791572724;10849.728756781144;11614.709632259091;11645.6506304811;11651.475683594259;4809.735464549413;4817.566419022235;4920.163572192736;4954.40547134339;4958.752062396866;9390.436573805593;9972.002799720116;9978.151857092083;9980.201583873273;9982;4882.975585122052;5379.596530260246;5454.945450545523;5459.3994660587305;5479.2602998594675;4466.57567531084;4839.370881785346;4956.553910148104;4995.375578052744;4996.625253106032;3935.842566297373;3986.521617405872;4039.3537034074407;4064.7154699171365;4067.593240675968;1363.7749771287824;1368.5210176438366;1371.991586184154;1382.4677499162894;1387.049870838479;887.671561522241;899.7885496908222;907.0272158056201;909.949952752605;924.8289066522581;5812.564057695605;5828.708564571754;5916.704164791743;5937.554683398763;6035.094735789667;401.5302096547047;465.3392183100006;465.52748959805825;788.3299195683624;1034.1623285139062;3665.890023299305;3821.331267028259;3828.2343531293295;3907.5310962684093;3911.647951684362;10357.741056473498;10693.732656683645;10700.625478108228;10802.351858888493;10903.672889813319;7870.488418252795;10353.792924141475;10739.463026848782;10744.785104298027;10769.299995500267;7909.841803164019;8073.31376832964;8140.674373025013;8153.103158652543;8223.629936652746;5636.436356364331;5733.942660573508;5778.306603207642;5798.739056742373;5997;9452.621895124394;9785.902140978498;9787.314887957775;9852.852207217042;10075.697729068139;7821.374290056668;9620;9864.704058877958;10072.395656260647;10128.34165779222;7529.88705169412;7992.320652744582;8139.308158806568;8326.583670816313;8393.076761556102;7137.892931606134;8268.83462330762;8406.033306169624;8439.95780021096;8493.938257717786;7356.080489938758;7523.398128149625;7573.9242607575425;7590.240975902587;7619.161892191965;7325.743598974011;7377.926220737724;7385.150707668472;7455.515391499535;7504.887426688495;6988.021676965127;7015.964920175366;7112.893306600508;7123.679434425567;7131.572105673677;4688.812447502061;4754.405699287589;4846.781894814671;4854.393200849894;5050;4724.71651700899;4815.783289751899;4818.229083346648;4862.781174847211;5045.394552653705 04:57:20 INFO - PROCESS | 2531 | |4;prototype.html;312.47660169216573;324.07476654152396;324.9512573114034;327.99469625597544;330.84781000739656;4311.504177019644;5395.973020134898;5448.2100095486185;5502.284702988616;5581.553475721943;4741.762911854411;4867.732274724889;5337.877341755078;5482.9152281550305;5494.450554944504;4162.250794856925;4169.958300416987;4170.249355116078;4194.769287689176;4204.59146186028;3475.8783442579515;3858.4791053207737;3915.7454765440298;4142.668586513072;4153.522344930341;3712.2204337089242;3883.456316115746;4053.7973101344814;4109.876703698879;4111.465509483763;3158.478850989584;3320.8671653133965;3758.699304055669;3930.820753773871;4090.672746180328;3268.6567910369545;3372.005258448739;3503.8087050402987;3588.3899737044767;3603.8017909014993;4855.781489832966;4929.507049295078;4974.552290293855;5192.1952097424955;5241.764120614544;4065.3292206785845;4465.370139898946;4702.247640377524;4731.33761273422;4731.384919960417;4774.331593576902;5498.113490417522;5711.314642242916;5713.6000479966415;5724.8855022899725;3776.4712940188397;3808.333541630204;3852.903677408059;3926.2540117377607;3947.605239476058;5106.565941894981;5686.867424715731;6003.519718422515;6098.420650038283;6109.14471973924;3246.6915643013876;3627.766559369827;3841.9231615368094;3919.92160156801;3964;3391.6263913115226;4026.63760261572;4050.4531888195306;4055.7566546007333;4058.3100872851687;4655.906881862412;4672.322513235562;4673.158831410311;4681.50844161365;4689.413823272091;5261.473852614785;5297.708626025528;5695.03184458643;5709.685967271756;5734.598578099493;1081.6538707613645;1474.86726194643;1474.9336279867432;1476.5644134980207;1479.2825479642365;942.2181303532248;957.8132264208413;972.644984580623;981.1562056631292;987.9308448408542;5688.829335119953;5743;5752.108423194411;5759.481646651821;5819.214406055213;5448.046591846411;6330.651814150266;6456.192975878015;6456.838579035561;6477.255115661759;5476.945230547723;5547.583931205095;5708.143778433268;5810.6513609183585;5824.835032993418;3032.69673032695;3052.984735076355;3135.0751528299206;3324.517944897976;3367.461206206995;5798.449147330997;6118.20463339763;6288.9056664150075;6465.741370345228;6725.562838415487;6480.902786458207;6568.587753632992;6582.617650293396;6585.958352910613;6640.933590664032;6145.139680444741;6537.411632953057;6702.564333318319;6707.53047286695;6708.463322934153;6422.967885160544;6452.677366131768;6458.935410646021;6462.967685161544;6517.4134327910715;5627.634203776742;5836.416358364299;6325.96837015812;6368.5860419072615;6382.648954307372;5364.195370694271;5375.941164420838;6157.4458298753325;6217.595856269328;6268.780592679234;3323.5845519310087;3948.7433316834313;3969.4442778010525;3994.6617883009517;4018.7588744675413;5458.836234912959;5915.852103697442;5927.110933360031;5957.582969192115;5980.700964951822;5356.544693701079;5465.535429488538;5851.795187168599;5868.706564671835;5909.409059094056;4596.494385617512;4653.511381304914;5087.516685914832;5451.155070964007;5702.51528620072;5060.772265247999;5380.354357477127;5730.369659337386;5755.366909639853;5777.94222057774;5533.667979921218;5829.854253643693;5849.327327357409;5868.823935281948;5883.470487656132;4855.611551075976;5737.9139312911175;5761.942380576141;5802.361740208489;5803.90824468757 04:57:20 INFO - PROCESS | 2531 | |5;yui.html;643.5752403413748;655.4592461219494;669.9196096468424;699.604723331318;739.5267029101375;12748.936255318722;14533.200673962929;14565.708685826277;14844.480443184491;15932.52202433926;15425.460108896192;15425.92287038566;15521.301541430634;15581.298841552129;15601.765973510406;723.1141851232225;895.0512456795785;896.6996056321141;899.5007770687266;910.1035480052143;893.78995935955;914.6981496106268;922.7554698005034;924.7503174142977;929.3355250995537;936.3071327217878;965.7151140413595;967.762898089969;969.3117886300735;970.6651205334149;925.6343744221028;951.9952400238024;954.9713508594754;957.8036502516967;963.7879666473435;708.4297140801652;714.2643077630049;718.3211864787778;721.1346384338815;727.1456039154026;14824.629384265372;14969.401223951028;15003.099814011195;15065.171415572138;15180.848191518164;12060.879391206063;12204.206726562745;12239.571614993432;12325.198862073936;12390.75218495625;7955.562444065574;9743.707688769347;9883.950580247125;9918.752031199205;9920.288735238008;3057.877684892602;3191.9680803191904;3352.3630510202984;3393.0838673558246;3428.9142771430666;75014;77733.22266777317;78970.60514697447;80090.59954700248;81166.59416702879;9206.539673016323;9221.53892305382;9290.723772675603;9414.011528789515;9443.055694430639;19876.50308742264;20650.86420246901;20958.056887440103;21006.78993210079;21066.368008959755;7435.776926692208;7440.813979650552;7635.923640763522;7714.074311082706;7864;4041.4341992121126;4050.696197785119;4052.65552428041;4083.612056854594;4102.692298077656;3487.2676737885326;3553.5558055243096;3560.412531932202;3562.679358857715;3563.6792688658147;621.1149112514648;628.867937733072;636.6562056489537;642.4539141729585;648.1994736500512;560.4507582569105;580.9012467880386;587.5593305021234;609.2110716621985;617.4597227426002;7609.429292803062;7959.602019898982;8044.235797599219;8179.959100204461;8183.918160818434;444.89989752305473;520.7136075158647;571.9751978865645;579.6406228138496;603.435787538644;3333.283344080986;3774.679152272088;3831.2912111259507;3876.7286289959434;3903.902402439905;101557;102941.97058029474;103328.48335758274;104061;105700;83378.74931876027;86047.27905441856;86209.1379086201;86712;87410.1258987402;60871.6956415224;70819.10494922726;74980.62509687417;75425.24574754293;75748;6707.859663857058;7564.697412103675;7798.571078590732;7805.414593905593;7867.763967080997;36177.819110904275;47573.28640070333;48165;48358;48368.27447588219;63950.680246598466;64142.67928660327;66423.66788166028;68924.65537672279;68975.65512172406;9456.196223321094;11059.059979901476;11122.888771112186;11314.547418103184;11420.885791141982;11624.360660163435;11825;11985.64043078709;12174.14780965324;12200.694982625506;11434.42827858587;11437.885621144014;11651.88348116508;11675.532978680758;11956.880431195925;10242.180625549789;10477.057064864199;10528.36829790215;10532.631357902437;10542.841857371992;11195.328280303207;11272.943635281772;11292.604758833402;11387.601433949772;11561.017313528444;9560.808783824146;9669.419834809934;9701.6119355225;9798.65704700332;9845.85231221518;9717.222622190066;10012.799744004933;10026.03779936037;10075.697729068139;10113.083845949908 04:57:20 INFO - PROCESS | 2531 | __end_tp_report 04:57:20 INFO - PROCESS | 2531 | __start_cc_report 04:57:20 INFO - PROCESS | 2531 | _x_x_mozilla_cycle_collect,418 04:57:20 INFO - PROCESS | 2531 | __end_cc_report 04:57:20 INFO - PROCESS | 2531 | __startTimestamp1461758240037__endTimestamp 04:57:20 INFO - PROCESS | 2531 | 04:57:20 INFO - PROCESS | 2531 | ------- Summary: start ------- 04:57:20 INFO - PROCESS | 2531 | Number of tests: 6 04:57:20 INFO - PROCESS | 2531 | 04:57:20 INFO - PROCESS | 2531 | [#0] dojo.html Cycles:165 Average:5634.72 Median:5819.85 stddev:679.22 (11.7%) stddev-sans-first:646.01 04:57:20 INFO - PROCESS | 2531 | Values: 2879.8 3414.6 3431.3 3480.3 3492.8 5541.5 5591.5 5597.6 5605.5 5627.1 4420.3 5576.6 5632.5 5671.5 5719.1 5128.4 5160.3 5164.8 5201.1 5215.2 5188.9 5197.3 5239.8 5258.1 5267.4 3976.5 5060.8 5098.1 5214.0 5231.8 5140.3 5141.4 5175.1 5179.4 5251.6 4436.9 5028.1 5032.7 5161.4 5205.1 5362.4 5478.3 5522.6 5567.7 5610.7 5023.3 5817.7 6065.8 6197.6 6209.3 6111.6 6127.2 6235.6 6244.5 6254.6 5735.7 5755.0 5755.3 5762.4 5819.9 6240.1 6244.8 6248.3 6254.5 6259.1 5924.2 6025.8 6103.5 6119.9 6142.9 6054.8 6190.4 6204.6 6204.6 6213.3 6108.7 6142.4 6172.8 6186.7 6206.6 4919.4 6074.7 6121.0 6187.8 6198.2 4151.1 4889.1 4893.4 4906.8 4915.6 4337.6 4371.5 4396.0 4399.4 4427.0 5562.8 5615.2 5733.5 5752.7 5768.2 6217.6 6222.3 6237.6 6240.1 6254.5 5670.7 5673.3 5675.5 5692.6 5706.9 4750.5 5170.6 5310.7 5388.3 5428.9 5512.6 5843.7 6329.4 6337.2 6354.4 6127.9 6229.4 6240.7 6247.6 6254.8 6210.8 6266.2 6291.5 6295.2 6296.5 6084.8 6110.6 6119.9 6121.3 6132.1 4827.7 6083.6 6140.7 6224.8 6229.0 5949.7 6020.0 6098.0 6125.2 6133.8 4993.8 6015.3 6059.1 6106.7 6118.8 4978.3 5814.8 5953.8 5996.9 5999.6 6026.2 6052.5 6080.4 6101.3 6142.0 5948.7 5967.9 5969.0 5978.6 5983.7 04:57:20 INFO - PROCESS | 2531 | 04:57:20 INFO - PROCESS | 2531 | [#1] ext.html Cycles:180 Average:57010.66 Median:36750.36 stddev:119001.54 (323.8%) stddev-sans-first:119259.73 04:57:20 INFO - PROCESS | 2531 | Values: 500.8 512.3 536.9 559.1 566.6 36253.8 36332.8 36350.8 37122.3 37206.1 37539.1 37593.2 38179.8 38222.2 38280.8 9037.6 9097.4 9146.4 9264.1 9270.0 9133.4 9238.3 9279.6 9338.1 9344.6 8775.9 9216.8 9263.0 9331.9 9368.6 7012.9 7790.5 9284.1 9294.2 9320.5 9040.1 9117.5 9157.7 9244.3 9257.4 26992.9 36535.5 36808.8 36909.3 37090.4 3011.0 3169.3 3282.7 3470.7 3854.4 18330.8 26677.2 27023.5 27232.3 27250.7 2603.6 2618.1 2638.4 2647.4 2765.1 312189.0 326484.0 351455.0 353090.0 354896.0 33324.7 34161.3 34313.5 34369.5 34412.1 34954.5 35057.0 35153.0 35376.6 35452.5 14828.7 15000.4 15122.5 15147.2 15165.3 10651.6 12311.0 12703.0 12740.9 12741.1 7927.0 8049.9 8086.8 8121.7 8182.0 3327.6 3395.2 3400.5 3416.8 3446.7 974.4 1019.6 1036.3 1039.7 1168.3 19257.8 26791.7 28376.4 28791.1 28951.3 1019.4 1026.5 1081.9 1099.6 1103.6 11502.9 14067.8 14891.0 15146.1 15272.0 494890.0 506496.0 507196.0 510499.0 513309.0 59228.4 59549.7 59597.1 59730.1 59870.7 1434.3 1487.3 1487.6 1489.7 1495.1 28592.3 28680.9 28870.4 29373.0 29373.7 50480.7 51796.7 53252.0 53269.7 53393.2 467016.0 472726.0 479035.0 479721.6 480792.0 39492.6 41128.0 41783.0 41802.0 41837.0 44481.0 44929.3 44999.8 45013.9 45518.8 36691.9 37074.6 37198.0 37384.6 37511.6 36846.8 36858.8 37169.6 37583.4 37761.2 35634.5 36096.5 36834.6 37085.1 37541.8 30443.1 30654.5 30757.4 31284.4 32265.2 17132.9 22259.6 23177.9 24091.8 24095.0 04:57:20 INFO - PROCESS | 2531 | 04:57:20 INFO - PROCESS | 2531 | [#2] jquery.html Cycles:180 Average:33913.85 Median:2700.65 stddev:101281.19 (3750.3%) stddev-sans-first:101533.94 04:57:20 INFO - PROCESS | 2531 | Values: 339.0 392.1 400.6 403.8 408.3 18432.6 19797.0 20778.5 20783.1 20895.0 19535.3 20161.9 20199.5 20378.0 20455.5 5444.0 5586.1 5728.3 5735.4 5805.8 4949.8 5521.1 5551.7 5577.1 5687.2 4674.6 5538.8 5629.4 5643.7 5658.2 5557.7 5616.7 5632.7 5642.4 5660.6 4908.0 4910.0 5015.2 5017.1 5020.2 24216.0 24447.5 24701.3 24975.3 25007.4 2146.5 2205.4 2323.6 2559.4 2841.9 14116.6 14543.5 14545.1 14586.7 14908.5 1499.9 1705.8 1746.2 1768.5 1794.1 105194.0 105560.4 106044.4 107085.4 107602.0 10278.8 10306.5 10565.6 10684.1 11151.9 13538.8 13670.4 13770.7 13798.4 13828.1 7481.8 8443.2 8533.8 8682.0 8833.7 8777.4 8795.5 8801.9 8914.0 8950.1 6536.1 6665.6 6677.9 6681.8 6746.3 1850.1 1883.7 1883.8 1890.5 1925.9 921.7 941.7 968.0 993.1 1037.8 19197.4 19792.5 19845.0 20041.3 20484.8 671.4 893.2 950.8 969.4 1038.0 9996.5 10002.4 10331.4 10352.2 10593.6 593637.1 604569.0 610066.0 611435.0 638799.0 96816.5 97109.0 121422.4 122199.0 123393.4 997.7 1010.4 1035.1 1037.0 1043.5 14768.6 15725.0 16100.0 17298.4 17654.0 42568.8 42845.8 44009.8 44548.8 48963.8 64661.4 66791.0 66869.3 66896.0 68328.7 7847.1 7982.8 8002.8 8045.6 8390.7 11688.2 11716.6 12195.6 12540.7 12711.6 9968.5 10616.7 10623.9 10820.2 10942.1 7092.0 9552.9 10258.6 10670.0 10708.7 9069.6 10219.2 10640.0 10648.0 11032.3 7992.3 8001.0 8029.2 8145.1 8162.8 7994.5 9416.8 10646.7 10816.7 10935.7 04:57:20 INFO - PROCESS | 2531 | 04:57:20 INFO - PROCESS | 2531 | [#3] mootools.html Cycles:180 Average:5675.07 Median:4977.06 stddev:3131.12 (62.9%) stddev-sans-first:3123.91 04:57:20 INFO - PROCESS | 2531 | Values: 1463.3 1620.4 1870.4 1964.0 1991.8 8068.1 8507.1 8553.5 8818.5 8837.9 8642.4 8649.0 8708.2 8714.7 8767.8 2417.8 2455.9 2459.1 2461.3 2464.6 2296.3 2401.9 2445.9 2448.1 2448.6 2405.0 2409.8 2414.3 2417.7 2447.0 2000.5 2385.2 2401.5 2406.6 2416.2 2386.0 2391.7 2393.3 2400.5 2401.9 8773.0 8859.4 8876.0 8884.3 8891.9 5311.0 5431.6 5483.2 5522.5 5537.4 3025.8 3530.0 3543.7 3578.8 3609.8 850.4 1023.9 1036.6 1041.0 1066.6 9214.2 10849.7 11614.7 11645.7 11651.5 4809.7 4817.6 4920.2 4954.4 4958.8 9390.4 9972.0 9978.2 9980.2 9982.0 4883.0 5379.6 5454.9 5459.4 5479.3 4466.6 4839.4 4956.6 4995.4 4996.6 3935.8 3986.5 4039.4 4064.7 4067.6 1363.8 1368.5 1372.0 1382.5 1387.0 887.7 899.8 907.0 909.9 924.8 5812.6 5828.7 5916.7 5937.6 6035.1 401.5 465.3 465.5 788.3 1034.2 3665.9 3821.3 3828.2 3907.5 3911.6 10357.7 10693.7 10700.6 10802.4 10903.7 7870.5 10353.8 10739.5 10744.8 10769.3 7909.8 8073.3 8140.7 8153.1 8223.6 5636.4 5733.9 5778.3 5798.7 5997.0 9452.6 9785.9 9787.3 9852.9 10075.7 7821.4 9620.0 9864.7 10072.4 10128.3 7529.9 7992.3 8139.3 8326.6 8393.1 7137.9 8268.8 8406.0 8440.0 8493.9 7356.1 7523.4 7573.9 7590.2 7619.2 7325.7 7377.9 7385.2 7455.5 7504.9 6988.0 7016.0 7112.9 7123.7 7131.6 4688.8 4754.4 4846.8 4854.4 5050.0 4724.7 4815.8 4818.2 4862.8 5045.4 04:57:20 INFO - PROCESS | 2531 | 04:57:20 INFO - PROCESS | 2531 | [#4] prototype.html Cycles:180 Average:4749.95 Median:5378.15 stddev:1534.25 (28.5%) stddev-sans-first:1501.97 04:57:20 INFO - PROCESS | 2531 | Values: 312.5 324.1 325.0 328.0 330.8 4311.5 5396.0 5448.2 5502.3 5581.6 4741.8 4867.7 5337.9 5482.9 5494.5 4162.3 4170.0 4170.2 4194.8 4204.6 3475.9 3858.5 3915.7 4142.7 4153.5 3712.2 3883.5 4053.8 4109.9 4111.5 3158.5 3320.9 3758.7 3930.8 4090.7 3268.7 3372.0 3503.8 3588.4 3603.8 4855.8 4929.5 4974.6 5192.2 5241.8 4065.3 4465.4 4702.2 4731.3 4731.4 4774.3 5498.1 5711.3 5713.6 5724.9 3776.5 3808.3 3852.9 3926.3 3947.6 5106.6 5686.9 6003.5 6098.4 6109.1 3246.7 3627.8 3841.9 3919.9 3964.0 3391.6 4026.6 4050.5 4055.8 4058.3 4655.9 4672.3 4673.2 4681.5 4689.4 5261.5 5297.7 5695.0 5709.7 5734.6 1081.7 1474.9 1474.9 1476.6 1479.3 942.2 957.8 972.6 981.2 987.9 5688.8 5743.0 5752.1 5759.5 5819.2 5448.0 6330.7 6456.2 6456.8 6477.3 5476.9 5547.6 5708.1 5810.7 5824.8 3032.7 3053.0 3135.1 3324.5 3367.5 5798.4 6118.2 6288.9 6465.7 6725.6 6480.9 6568.6 6582.6 6586.0 6640.9 6145.1 6537.4 6702.6 6707.5 6708.5 6423.0 6452.7 6458.9 6463.0 6517.4 5627.6 5836.4 6326.0 6368.6 6382.6 5364.2 5375.9 6157.4 6217.6 6268.8 3323.6 3948.7 3969.4 3994.7 4018.8 5458.8 5915.9 5927.1 5957.6 5980.7 5356.5 5465.5 5851.8 5868.7 5909.4 4596.5 4653.5 5087.5 5451.2 5702.5 5060.8 5380.4 5730.4 5755.4 5777.9 5533.7 5829.9 5849.3 5868.8 5883.5 4855.6 5737.9 5761.9 5802.4 5803.9 04:57:20 INFO - PROCESS | 2531 | 04:57:20 INFO - PROCESS | 2531 | [#5] yui.html Cycles:180 Average:18591.44 Median:30737.57 stddev:26970.51 (87.7%) stddev-sans-first:27012.50 04:57:20 INFO - PROCESS | 2531 | Values: 643.6 655.5 669.9 699.6 739.5 12748.9 14533.2 14565.7 14844.5 15932.5 15425.5 15425.9 15521.3 15581.3 15601.8 723.1 895.1 896.7 899.5 910.1 893.8 914.7 922.8 924.8 929.3 936.3 965.7 967.8 969.3 970.7 925.6 952.0 955.0 957.8 963.8 708.4 714.3 718.3 721.1 727.1 14824.6 14969.4 15003.1 15065.2 15180.8 12060.9 12204.2 12239.6 12325.2 12390.8 7955.6 9743.7 9884.0 9918.8 9920.3 3057.9 3192.0 3352.4 3393.1 3428.9 75014.0 77733.2 78970.6 80090.6 81166.6 9206.5 9221.5 9290.7 9414.0 9443.1 19876.5 20650.9 20958.1 21006.8 21066.4 7435.8 7440.8 7635.9 7714.1 7864.0 4041.4 4050.7 4052.7 4083.6 4102.7 3487.3 3553.6 3560.4 3562.7 3563.7 621.1 628.9 636.7 642.5 648.2 560.5 580.9 587.6 609.2 617.5 7609.4 7959.6 8044.2 8180.0 8183.9 444.9 520.7 572.0 579.6 603.4 3333.3 3774.7 3831.3 3876.7 3903.9 101557.0 102942.0 103328.5 104061.0 105700.0 83378.7 86047.3 86209.1 86712.0 87410.1 60871.7 70819.1 74980.6 75425.2 75748.0 6707.9 7564.7 7798.6 7805.4 7867.8 36177.8 47573.3 48165.0 48358.0 48368.3 63950.7 64142.7 66423.7 68924.7 68975.7 9456.2 11059.1 11122.9 11314.5 11420.9 11624.4 11825.0 11985.6 12174.1 12200.7 11434.4 11437.9 11651.9 11675.5 11956.9 10242.2 10477.1 10528.4 10532.6 10542.8 11195.3 11272.9 11292.6 11387.6 11561.0 9560.8 9669.4 9701.6 9798.7 9845.9 9717.2 10012.8 10026.0 10075.7 10113.1 04:57:20 INFO - PROCESS | 2531 | -------- Summary: end -------- 04:57:20 INFO - PROCESS | 2531 | 04:57:20 INFO - TEST-INFO | 2531: exit 0 04:57:20 INFO - TEST-OK | dromaeo_css | took 1111632ms 04:57:20 INFO - TEST-START | kraken 04:57:20 INFO - operating with platform_type : mac_ 04:57:20 INFO - Initialising browser for kraken test... 04:57:20 INFO - TEST-INFO | started process 2535 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/tmphZmFon/profile http://localhost:51914/getInfo.html) 04:57:23 INFO - PROCESS | 2535 | __metrics Screen width/height:1600/1200 04:57:23 INFO - PROCESS | 2535 | colorDepth:24 04:57:23 INFO - PROCESS | 2535 | Browser inner width/height: 1024/689 04:57:23 INFO - PROCESS | 2535 | __metrics 04:57:23 ERROR - PROCESS | 2535 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 04:57:24 INFO - TEST-INFO | 2535: exit 0 04:57:24 INFO - Browser initialized. 04:57:24 INFO - Running cycle 1/1 for kraken test... 04:57:24 INFO - TEST-INFO | started process 2538 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/tmphZmFon/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:57:36 INFO - PROCESS | 2538 | RSS: Main: 249872384 04:57:36 INFO - PROCESS | 2538 | 04:57:38 INFO - PROCESS | 2538 | Cycle 1(1): loaded http://localhost:51914/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51914/tests/kraken/driver.html?testName=audio-beat-detection) 04:57:39 INFO - PROCESS | 2538 | RSS: Main: 262070272 04:57:39 INFO - PROCESS | 2538 | 04:57:42 INFO - PROCESS | 2538 | Cycle 1(1): loaded http://localhost:51914/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51914/tests/kraken/driver.html?testName=audio-dft) 04:57:43 INFO - PROCESS | 2538 | RSS: Main: 271429632 04:57:43 INFO - PROCESS | 2538 | 04:57:46 INFO - PROCESS | 2538 | Cycle 1(1): loaded http://localhost:51914/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51914/tests/kraken/driver.html?testName=audio-fft) 04:57:47 INFO - PROCESS | 2538 | RSS: Main: 273997824 04:57:47 INFO - PROCESS | 2538 | 04:57:49 INFO - PROCESS | 2538 | Cycle 1(1): loaded http://localhost:51914/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51914/tests/kraken/driver.html?testName=audio-oscillator) 04:57:50 INFO - PROCESS | 2538 | RSS: Main: 275951616 04:57:50 INFO - PROCESS | 2538 | 04:57:52 INFO - PROCESS | 2538 | Cycle 1(1): loaded http://localhost:51914/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51914/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:57:53 INFO - PROCESS | 2538 | RSS: Main: 276320256 04:57:53 INFO - PROCESS | 2538 | 04:57:56 INFO - PROCESS | 2538 | Cycle 1(1): loaded http://localhost:51914/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51914/tests/kraken/driver.html?testName=imaging-darkroom) 04:57:56 INFO - PROCESS | 2538 | RSS: Main: 277176320 04:57:56 INFO - PROCESS | 2538 | 04:57:59 INFO - PROCESS | 2538 | Cycle 1(1): loaded http://localhost:51914/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51914/tests/kraken/driver.html?testName=imaging-desaturate) 04:58:00 INFO - PROCESS | 2538 | RSS: Main: 276819968 04:58:00 INFO - PROCESS | 2538 | 04:58:03 INFO - PROCESS | 2538 | Cycle 1(1): loaded http://localhost:51914/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51914/tests/kraken/driver.html?testName=json-parse-financial) 04:58:04 INFO - PROCESS | 2538 | RSS: Main: 276869120 04:58:04 INFO - PROCESS | 2538 | 04:58:05 INFO - PROCESS | 2538 | Cycle 1(1): loaded http://localhost:51914/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51914/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:58:06 INFO - PROCESS | 2538 | RSS: Main: 277385216 04:58:06 INFO - PROCESS | 2538 | 04:58:08 INFO - PROCESS | 2538 | Cycle 1(1): loaded http://localhost:51914/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51914/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:58:08 INFO - PROCESS | 2538 | RSS: Main: 277024768 04:58:08 INFO - PROCESS | 2538 | 04:58:10 INFO - PROCESS | 2538 | Cycle 1(1): loaded http://localhost:51914/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51914/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:58:11 INFO - PROCESS | 2538 | RSS: Main: 277209088 04:58:11 INFO - PROCESS | 2538 | 04:58:14 INFO - PROCESS | 2538 | Cycle 1(1): loaded http://localhost:51914/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51914/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:58:15 INFO - PROCESS | 2538 | RSS: Main: 277303296 04:58:15 INFO - PROCESS | 2538 | 04:58:18 INFO - PROCESS | 2538 | Cycle 1(1): loaded http://localhost:51914/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51914/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:58:19 INFO - PROCESS | 2538 | RSS: Main: 277422080 04:58:19 INFO - PROCESS | 2538 | 04:58:20 INFO - PROCESS | 2538 | Cycle 1(1): loaded http://localhost:51914/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51914/tests/kraken/driver.html?testName=ai-astar) 04:58:21 INFO - PROCESS | 2538 | RSS: Main: 279044096 04:58:21 INFO - PROCESS | 2538 | 04:58:21 INFO - PROCESS | 2538 | __start_tp_report 04:58:21 INFO - PROCESS | 2538 | _x_x_mozilla_page_load 04:58:21 INFO - PROCESS | 2538 | _x_x_mozilla_page_load_details 04:58:21 INFO - PROCESS | 2538 | |i|pagename|runs| 04:58:21 INFO - PROCESS | 2538 | |0;ai-astar;116;112;115;116;118;127;119;167;169;118 04:58:21 INFO - PROCESS | 2538 | |1;audio-beat-detection;156;124;153;157;144;177;163;148;209;155 04:58:21 INFO - PROCESS | 2538 | |2;audio-dft;251;265;228;222;187;226;216;270;208;268 04:58:21 INFO - PROCESS | 2538 | |3;audio-fft;68;89;88;138;52;82;99;89;78;58 04:58:21 INFO - PROCESS | 2538 | |4;audio-oscillator;81;82;140;79;97;68;143;120;121;162 04:58:21 INFO - PROCESS | 2538 | |5;imaging-gaussian-blur;132;130;92;74;137;88;108;88;90;87 04:58:21 INFO - PROCESS | 2538 | |6;imaging-darkroom;97;98;105;126;94;92;90;153;150;110 04:58:21 INFO - PROCESS | 2538 | |7;imaging-desaturate;96;152;133;92;127;93;98;96;147;90 04:58:21 INFO - PROCESS | 2538 | |8;json-parse-financial;61;63;61;62;62;61;62;81;64;60 04:58:21 INFO - PROCESS | 2538 | |9;json-stringify-tinderbox;64;66;66;74;80;76;72;67;69;68 04:58:21 INFO - PROCESS | 2538 | |10;stanford-crypto-aes;86;82;83;82;83;84;91;82;78;103 04:58:21 INFO - PROCESS | 2538 | |11;stanford-crypto-ccm;142;137;172;160;163;141;139;149;175;141 04:58:21 INFO - PROCESS | 2538 | |12;stanford-crypto-pbkdf2;202;205;210;202;199;199;213;232;281;277 04:58:21 INFO - PROCESS | 2538 | |13;stanford-crypto-sha256-iterative;68;70;69;68;72;70;68;72;70;68 04:58:21 INFO - PROCESS | 2538 | __end_tp_report 04:58:21 INFO - PROCESS | 2538 | __start_cc_report 04:58:21 INFO - PROCESS | 2538 | _x_x_mozilla_cycle_collect,1080 04:58:21 INFO - PROCESS | 2538 | __end_cc_report 04:58:21 INFO - PROCESS | 2538 | __startTimestamp1461758301235__endTimestamp 04:58:21 INFO - PROCESS | 2538 | 04:58:21 INFO - PROCESS | 2538 | ------- Summary: start ------- 04:58:21 INFO - PROCESS | 2538 | Number of tests: 14 04:58:21 INFO - PROCESS | 2538 | 04:58:21 INFO - PROCESS | 2538 | [#0] ai-astar Cycles:10 Average:127.70 Median:118.50 stddev:21.59 (18.2%) stddev-sans-first:22.48 04:58:21 INFO - PROCESS | 2538 | Values: 116.0 112.0 115.0 116.0 118.0 127.0 119.0 167.0 169.0 118.0 04:58:21 INFO - PROCESS | 2538 | 04:58:21 INFO - PROCESS | 2538 | [#1] audio-beat-detection Cycles:10 Average:158.60 Median:156.50 stddev:22.30 (14.2%) stddev-sans-first:23.63 04:58:21 INFO - PROCESS | 2538 | Values: 156.0 124.0 153.0 157.0 144.0 177.0 163.0 148.0 209.0 155.0 04:58:21 INFO - PROCESS | 2538 | 04:58:21 INFO - PROCESS | 2538 | [#2] audio-dft Cycles:10 Average:234.10 Median:239.50 stddev:28.20 (11.8%) stddev-sans-first:29.24 04:58:21 INFO - PROCESS | 2538 | Values: 251.0 265.0 228.0 222.0 187.0 226.0 216.0 270.0 208.0 268.0 04:58:21 INFO - PROCESS | 2538 | 04:58:21 INFO - PROCESS | 2538 | [#3] audio-fft Cycles:10 Average:84.10 Median:85.00 stddev:24.04 (28.3%) stddev-sans-first:24.79 04:58:21 INFO - PROCESS | 2538 | Values: 68.0 89.0 88.0 138.0 52.0 82.0 99.0 89.0 78.0 58.0 04:58:21 INFO - PROCESS | 2538 | 04:58:21 INFO - PROCESS | 2538 | [#4] audio-oscillator Cycles:10 Average:109.30 Median:73.50 stddev:32.37 (44.0%) stddev-sans-first:32.67 04:58:21 INFO - PROCESS | 2538 | Values: 81.0 82.0 140.0 79.0 97.0 68.0 143.0 120.0 121.0 162.0 04:58:21 INFO - PROCESS | 2538 | 04:58:21 INFO - PROCESS | 2538 | [#5] imaging-gaussian-blur Cycles:10 Average:102.60 Median:87.50 stddev:22.57 (25.8%) stddev-sans-first:21.29 04:58:21 INFO - PROCESS | 2538 | Values: 132.0 130.0 92.0 74.0 137.0 88.0 108.0 88.0 90.0 87.0 04:58:21 INFO - PROCESS | 2538 | 04:58:21 INFO - PROCESS | 2538 | [#6] imaging-darkroom Cycles:10 Average:111.50 Median:91.00 stddev:23.57 (25.9%) stddev-sans-first:24.41 04:58:21 INFO - PROCESS | 2538 | Values: 97.0 98.0 105.0 126.0 94.0 92.0 90.0 153.0 150.0 110.0 04:58:21 INFO - PROCESS | 2538 | 04:58:21 INFO - PROCESS | 2538 | [#7] imaging-desaturate Cycles:10 Average:112.40 Median:92.50 stddev:24.59 (26.6%) stddev-sans-first:25.36 04:58:21 INFO - PROCESS | 2538 | Values: 96.0 152.0 133.0 92.0 127.0 93.0 98.0 96.0 147.0 90.0 04:58:21 INFO - PROCESS | 2538 | 04:58:21 INFO - PROCESS | 2538 | [#8] json-parse-financial Cycles:10 Average:63.70 Median:62.00 stddev:6.18 (10.0%) stddev-sans-first:6.48 04:58:21 INFO - PROCESS | 2538 | Values: 61.0 63.0 61.0 62.0 62.0 61.0 62.0 81.0 64.0 60.0 04:58:21 INFO - PROCESS | 2538 | 04:58:21 INFO - PROCESS | 2538 | [#9] json-stringify-tinderbox Cycles:10 Average:70.20 Median:70.50 stddev:5.14 (7.3%) stddev-sans-first:4.94 04:58:21 INFO - PROCESS | 2538 | Values: 64.0 66.0 66.0 74.0 80.0 76.0 72.0 67.0 69.0 68.0 04:58:21 INFO - PROCESS | 2538 | 04:58:21 INFO - PROCESS | 2538 | [#10] stanford-crypto-aes Cycles:10 Average:85.40 Median:83.00 stddev:7.03 (8.5%) stddev-sans-first:7.45 04:58:21 INFO - PROCESS | 2538 | Values: 86.0 82.0 83.0 82.0 83.0 84.0 91.0 82.0 78.0 103.0 04:58:21 INFO - PROCESS | 2538 | 04:58:21 INFO - PROCESS | 2538 | [#11] stanford-crypto-ccm Cycles:10 Average:151.90 Median:154.50 stddev:14.37 (9.3%) stddev-sans-first:14.79 04:58:21 INFO - PROCESS | 2538 | Values: 142.0 137.0 172.0 160.0 163.0 141.0 139.0 149.0 175.0 141.0 04:58:21 INFO - PROCESS | 2538 | 04:58:21 INFO - PROCESS | 2538 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:222.00 Median:211.50 stddev:31.58 (14.9%) stddev-sans-first:32.66 04:58:21 INFO - PROCESS | 2538 | Values: 202.0 205.0 210.0 202.0 199.0 199.0 213.0 232.0 281.0 277.0 04:58:21 INFO - PROCESS | 2538 | 04:58:21 INFO - PROCESS | 2538 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.50 Median:70.00 stddev:1.58 (2.3%) stddev-sans-first:1.58 04:58:21 INFO - PROCESS | 2538 | Values: 68.0 70.0 69.0 68.0 72.0 70.0 68.0 72.0 70.0 68.0 04:58:21 INFO - PROCESS | 2538 | -------- Summary: end -------- 04:58:21 INFO - PROCESS | 2538 | 04:58:22 INFO - TEST-INFO | 2538: exit 0 04:58:22 INFO - TEST-OK | kraken | took 61641ms 04:58:22 INFO - SUITE-END | took 1173s 04:58:22 INFO - Completed test suite (00:19:33) 04:58:22 INFO - javascript benchmark 04:58:22 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2879.7975873850723, 3414.573178352706, 3431.3137372525503, 3480.303939212158, 3492.7729697569657, 5541.5289700375415, 5591.4688104630095, 5597.58018148639, 5605.467480589347, 5627.071533197018, 4420.31485119807, 5576.637518561291, 5632.464915832999, 5671.517920976722, 5719.113537401699, 5128.435872054071, 5160.25176349431, 5164.819231326905, 5201.0898092833795, 5215.21771734241, 5188.92216616751, 5197.298364720771, 5239.816606418776, 5258.13240815265, 5267.420583735786, 3976.5228172619472, 5060.79756809729, 5098.107831129556, 5214.035403450373, 5231.764570594332, 5140.3060586820675, 5141.38303403594, 5175.068487672217, 5179.378474583074, 5251.6061295402615, 4436.889077773049, 5028.094942910275, 5032.723200223986, 5161.406438259611, 5205.063088644042, 5362.35651721792, 5478.315210598676, 5522.641028333145, 5567.721613919288, 5610.69141197234, 5023.321851550067, 5817.650940943515, 6065.848353791191, 6197.628142311476, 6209.316975132731, 6111.561351782692, 6127.172831667713, 6235.563510554263, 6244.500439964792, 6254.6247225166635, 5735.713214339266, 5755.021646320052, 5755.251817263729, 5762.394948530427, 5819.854503637443, 6240.095186198067, 6244.843878903063, 6248.28144763349, 6254.499640028786, 6259.061140828912, 5924.200232968494, 6025.849353766103, 6103.511719062464, 6119.877602448015, 6142.877142457126, 6054.8183554493435, 6190.442860142609, 6204.565680402328, 6204.5967012144065, 6213.316535181127, 6108.725107370179, 6142.416470435302, 6172.845678858064, 6186.721597528122, 6206.596571222946, 4919.409670839451, 6074.726637301332, 6120.969395152996, 6187.84530386744, 6198.194234749544, 4151.14901445203, 4889.095517329305, 4893.388326459192, 4906.754662266872, 4915.58217551505, 4337.566243375637, 4371.497277813029, 4396.0, 4399.428074350378, 4426.955730442719, 5562.833115006556, 5615.157726341082, 5733.512651424676, 5752.741126649227, 5768.163616275617, 6217.626942383381, 6222.279679389088, 6237.563370564017, 6240.126382306481, 6254.468370188585, 5670.688112153871, 5673.290838645169, 5675.489205971482, 5692.57305702074, 5706.885862282731, 4750.453697824725, 5170.6380553360905, 5310.734463276821, 5388.299521062237, 5428.891422171534, 5512.614117011771, 5843.678597677083, 6329.398707122816, 6337.239531256371, 6354.364563543609, 6127.877442451215, 6229.4393504584805, 6240.656763877849, 6247.625142491465, 6254.781082662085, 6210.782622608368, 6266.2480502338185, 6291.465225455888, 6295.244570651551, 6296.5277604178955, 6084.847878803065, 6110.633361998294, 6119.938800612115, 6121.265448146251, 6132.08018797184, 4827.686200396963, 6083.6045657032155, 6140.746504631453, 6224.751009959551, 6229.0, 5949.672767997802, 6020.036794112921, 6097.969510152421, 6125.203723515914, 6133.785317513865, 4993.750312484434, 6015.338312785678, 6059.121427392915, 6106.6946652668075, 6118.816435506942, 4978.2781496682055, 5814.767409303749, 5953.76184952597, 5996.850078748066, 5999.640021598718, 6026.216591843032, 6052.546059045501, 6080.422359875804, 6101.328853826164, 6141.955867502446, 5948.732307046107, 5967.880642387041, 5968.970155149196, 5978.641281522949, 5983.670898100472], "value": 5593.155912731293, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [500.80718923214573, 512.3109417833015, 536.8979893820175, 559.0579872914143, 566.6203643558821, 36253.81873090634, 36332.81833590832, 36350.81824590873, 37122.25755484889, 37206.06984825377, 37539.061523461925, 37593.248135037284, 38179.80910095446, 38222.23555528888, 38280.80859595698, 9037.638494460214, 9097.408668436563, 9146.405483643543, 9264.073592640749, 9270.026647202048, 9133.36066475347, 9238.260939124888, 9279.582418791137, 9338.066193380675, 9344.626214951393, 8775.946886373644, 9216.769580760467, 9263.027382124881, 9331.860022099674, 9368.625254989793, 7012.859742805166, 7790.493617914845, 9284.118008789153, 9294.163525282689, 9320.487373194472, 9040.095990400907, 9117.49853758043, 9157.725268241964, 9244.260459163252, 9257.398269112553, 26992.86503567489, 36535.4519682205, 36808.81595592032, 36909.26181476355, 37090.443643345374, 3010.969890301091, 3169.2710676544293, 3282.720968717662, 3470.7396945229207, 3854.383298672227, 18330.816691833177, 26677.199624390807, 27023.45953080947, 27232.31919202016, 27250.72749272502, 2603.609458581209, 2618.0574993002506, 2638.4327369615626, 2647.4440367522843, 2765.1013420638174, 312189.0, 326484.0, 351454.99999999744, 353090.0, 354896.0, 33324.66675333216, 34161.31677366439, 34313.48529772055, 34369.48445773315, 34412.139696507285, 34954.47568286478, 35057.0, 35153.0, 35376.64623353785, 35452.468212976826, 14828.70342593142, 15000.399984000736, 15122.470713525194, 15147.242637868283, 15165.317560709795, 10651.573937042587, 12310.953568946561, 12703.047271454678, 12740.872591274154, 12741.10812243134, 7927.0, 8049.879251811228, 8086.797830054295, 8121.675132994614, 8182.0, 3327.600687917417, 3395.151212196951, 3400.540926974876, 3416.79499230047, 3446.672566106216, 974.4007435427303, 1019.6074511313197, 1036.264257368904, 1039.719275795531, 1168.3457263932225, 19257.80742192588, 26791.660416979463, 28376.432471350457, 28791.136265912057, 28951.276218094295, 1019.4291196929743, 1026.4970164619433, 1081.9404932728619, 1099.631623406152, 1103.6027030269097, 11502.907223813725, 14067.788983165055, 14891.0, 15146.091234525964, 15272.0, 494890.0, 506496.0, 507196.0, 510499.0, 513309.0, 59228.40771592229, 59549.70225148847, 59597.106043408516, 59730.10404843931, 59870.70064649649, 1434.3258668425824, 1487.2786698451243, 1487.5834766265464, 1489.6797188604503, 1495.0730547060675, 28592.285192870346, 28680.85276588913, 28870.42259154763, 29373.0, 29373.70626293795, 50480.74759626178, 51796.741016294676, 53252.0, 53269.733651331495, 53393.19910201428, 467016.0, 472726.0, 479035.0, 479721.6013919908, 480792.0, 39492.60507395004, 41128.0, 41782.95542611459, 41802.0, 41837.0, 44481.0, 44929.32606010978, 44999.775001124784, 45013.874653133935, 45518.77240613776, 36691.89924302275, 37074.6292537082, 37198.0, 37384.626153739206, 37511.62488375081, 36846.815765921, 36858.8157059213, 37169.628303716614, 37583.43624845684, 37761.2447751049, 35634.46548301829, 36096.45855312225, 36834.63165368312, 37085.072873177305, 37541.81229093837, 30443.086707398812, 30654.540181896842, 30757.38485230238, 31284.37431251408, 32265.193370165933, 17132.914335428242, 22259.55312904656, 23177.88411057934, 24091.759082408953, 24095.0], "value": 17569.180726613067, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [338.9729120764085, 392.12556000119713, 400.6054036773778, 403.80819110922295, 408.311994289622, 18432.631347373062, 19797.0, 20778.48053798654, 20783.064762085705, 20895.0, 19535.316263930767, 20161.899190504064, 20199.49501262469, 20378.0, 20455.488612784688, 5444.020076386249, 5586.13414920687, 5728.283964504437, 5735.397783232763, 5805.82582522525, 4949.787302110988, 5521.089020311644, 5551.666899986014, 5577.107662773957, 5687.17535957286, 4674.555917187861, 5538.75075621598, 5629.408912064236, 5643.661380317194, 5658.236138121362, 5557.72211389433, 5616.747246373902, 5632.746526406321, 5642.379338272786, 5660.60375773696, 4907.950920490785, 4909.975450122763, 5015.1975683890405, 5017.147084995559, 5020.196768517019, 24216.0, 24447.511049778906, 24701.25896223116, 24975.250742477572, 25007.374815629573, 2146.4633841539617, 2205.426589086833, 2323.5585238804574, 2559.4113353928515, 2841.8863245470156, 14116.576502704935, 14543.49097781583, 14545.127292362493, 14586.70826583473, 14908.478203262834, 1499.8975752821668, 1705.8123606403285, 1746.1967494952337, 1768.5490199998917, 1794.0760508338217, 105194.0, 105560.41659375116, 106044.40933386005, 107085.3937190935, 107602.0, 10278.794424111476, 10306.505556694237, 10565.577376904837, 10684.145268378667, 11151.944240278746, 13538.79691804604, 13670.384832682554, 13770.724585508233, 13798.448062077405, 13828.101173423694, 7481.802911534129, 8443.155684431631, 8533.829323413496, 8682.0, 8833.69082082124, 8777.42946708462, 8795.53724957013, 8801.911980880237, 8914.0, 8950.14973577509, 6536.084948107269, 6665.633390163491, 6677.899831502531, 6681.76613818514, 6746.325367463214, 1850.12119243361, 1883.7456943312752, 1883.7833649130525, 1890.5253901956496, 1925.8555608329432, 921.7142685767434, 941.6798288581778, 967.9854802177973, 993.1409330928839, 1037.8339465685453, 19197.424077277705, 19792.50518737014, 19845.00774961246, 20041.29855455052, 20484.79515204829, 671.4427025568766, 893.1559676106148, 950.7955789505289, 969.3602222533094, 1038.0398131728273, 9996.50017499122, 10002.449865257335, 10331.380117192843, 10352.171826254033, 10593.57625694979, 593637.0636293668, 604569.0, 610066.0, 611435.0, 638799.0, 96816.51591741997, 97109.0, 121422.392888035, 122199.0, 123393.38303308426, 997.7356000659831, 1010.4038617215878, 1035.0787798859021, 1037.0303765978833, 1043.5147656339839, 14768.556943291718, 15725.0, 16100.03399796016, 17298.394556190473, 17654.0, 42568.78715606402, 42845.78577107094, 44009.77995110004, 44548.77725611351, 48963.75518122387, 64661.35338646553, 66790.99813502704, 66869.32826679372, 66896.0, 68328.65835670789, 7847.136814950237, 7982.800429989296, 8002.759917202493, 8045.637946292314, 8390.748277551684, 11688.240264382788, 11716.626698641223, 12195.573154939535, 12540.686482838002, 12711.61865144047, 9968.451735154636, 10616.734581635521, 10623.946880265548, 10820.242583019113, 10942.069924056545, 7092.0, 9552.949175590818, 10258.58965641366, 10669.986351296615, 10708.732281692708, 9069.63721451161, 10219.1824654026, 10640.0, 10648.0, 11032.338059716443, 7992.320652744582, 8001.039875215011, 8029.237222463857, 8145.104038555635, 8162.755117346489, 7994.480358776661, 9416.764580885532, 10646.680599582025, 10816.708850668545, 10935.726606834893], "value": 9324.299700711299, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1463.2610531681498, 1620.4328485030237, 1870.4201697473784, 1963.9803601963977, 1991.770946341171, 8068.1125076241715, 8507.149285071497, 8553.529555874424, 8818.514981676006, 8837.91162088378, 8642.438241514314, 8649.048604653499, 8708.17272359125, 8714.651413943451, 8767.780805479866, 2417.842840215385, 2455.8894849731714, 2459.053264493174, 2461.3108329667634, 2464.5687004774095, 2296.2537175418056, 2401.8655654371037, 2445.8654773987423, 2448.1431498975394, 2448.6449464827588, 2404.9759502405013, 2409.783119519243, 2414.311921102486, 2417.746136655652, 2447.0, 2000.5098750806, 2385.224801939368, 2401.5317013182434, 2406.602910519762, 2416.178499310243, 2386.0, 2391.712994440661, 2393.293978276395, 2400.5198960208027, 2401.903923843044, 8773.0, 8859.379843410963, 8875.958529538242, 8884.333674974338, 8891.911080889173, 5310.973445132789, 5431.646942948735, 5483.150111732688, 5522.502974732253, 5537.390887002426, 3025.848707564613, 3530.0468873404293, 3543.6810687038032, 3578.8210589470423, 3609.8195090245645, 850.3622283287534, 1023.8822535408449, 1036.5905467340433, 1040.9947950260275, 1066.610687099211, 9214.216791572724, 10849.728756781144, 11614.709632259091, 11645.6506304811, 11651.475683594259, 4809.735464549413, 4817.566419022235, 4920.163572192736, 4954.40547134339, 4958.752062396866, 9390.436573805593, 9972.002799720116, 9978.151857092083, 9980.201583873273, 9982.0, 4882.975585122052, 5379.596530260246, 5454.945450545523, 5459.3994660587305, 5479.2602998594675, 4466.57567531084, 4839.370881785346, 4956.553910148104, 4995.375578052744, 4996.625253106032, 3935.842566297373, 3986.521617405872, 4039.3537034074407, 4064.7154699171365, 4067.593240675968, 1363.7749771287824, 1368.5210176438366, 1371.991586184154, 1382.4677499162894, 1387.049870838479, 887.671561522241, 899.7885496908222, 907.0272158056201, 909.949952752605, 924.8289066522581, 5812.564057695605, 5828.708564571754, 5916.704164791743, 5937.554683398763, 6035.094735789667, 401.5302096547047, 465.3392183100006, 465.52748959805825, 788.3299195683624, 1034.1623285139062, 3665.890023299305, 3821.331267028259, 3828.2343531293295, 3907.5310962684093, 3911.647951684362, 10357.741056473498, 10693.732656683645, 10700.625478108228, 10802.351858888493, 10903.672889813319, 7870.488418252795, 10353.792924141475, 10739.463026848782, 10744.785104298027, 10769.299995500267, 7909.841803164019, 8073.31376832964, 8140.674373025013, 8153.103158652543, 8223.629936652746, 5636.436356364331, 5733.942660573508, 5778.306603207642, 5798.739056742373, 5997.0, 9452.621895124394, 9785.902140978498, 9787.314887957775, 9852.852207217042, 10075.697729068139, 7821.374290056668, 9620.0, 9864.704058877958, 10072.395656260647, 10128.34165779222, 7529.88705169412, 7992.320652744582, 8139.308158806568, 8326.583670816313, 8393.076761556102, 7137.892931606134, 8268.83462330762, 8406.033306169624, 8439.95780021096, 8493.938257717786, 7356.080489938758, 7523.398128149625, 7573.9242607575425, 7590.240975902587, 7619.161892191965, 7325.743598974011, 7377.926220737724, 7385.150707668472, 7455.515391499535, 7504.887426688495, 6988.021676965127, 7015.964920175366, 7112.893306600508, 7123.679434425567, 7131.572105673677, 4688.812447502061, 4754.405699287589, 4846.781894814671, 4854.393200849894, 5050.0, 4724.71651700899, 4815.783289751899, 4818.229083346648, 4862.781174847211, 5045.394552653705], "value": 4552.697086028661, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [312.47660169216573, 324.07476654152396, 324.9512573114034, 327.99469625597544, 330.84781000739656, 4311.504177019644, 5395.973020134898, 5448.2100095486185, 5502.284702988616, 5581.553475721943, 4741.762911854411, 4867.732274724889, 5337.877341755078, 5482.9152281550305, 5494.450554944504, 4162.250794856925, 4169.958300416987, 4170.249355116078, 4194.769287689176, 4204.59146186028, 3475.8783442579515, 3858.4791053207737, 3915.7454765440298, 4142.668586513072, 4153.522344930341, 3712.2204337089242, 3883.456316115746, 4053.7973101344814, 4109.876703698879, 4111.465509483763, 3158.478850989584, 3320.8671653133965, 3758.699304055669, 3930.820753773871, 4090.672746180328, 3268.6567910369545, 3372.005258448739, 3503.8087050402987, 3588.3899737044767, 3603.8017909014993, 4855.781489832966, 4929.507049295078, 4974.552290293855, 5192.1952097424955, 5241.764120614544, 4065.3292206785845, 4465.370139898946, 4702.247640377524, 4731.33761273422, 4731.384919960417, 4774.331593576902, 5498.113490417522, 5711.314642242916, 5713.6000479966415, 5724.8855022899725, 3776.4712940188397, 3808.333541630204, 3852.903677408059, 3926.2540117377607, 3947.605239476058, 5106.565941894981, 5686.867424715731, 6003.519718422515, 6098.420650038283, 6109.14471973924, 3246.6915643013876, 3627.766559369827, 3841.9231615368094, 3919.92160156801, 3964.0, 3391.6263913115226, 4026.63760261572, 4050.4531888195306, 4055.7566546007333, 4058.3100872851687, 4655.906881862412, 4672.322513235562, 4673.158831410311, 4681.50844161365, 4689.413823272091, 5261.473852614785, 5297.708626025528, 5695.03184458643, 5709.685967271756, 5734.598578099493, 1081.6538707613645, 1474.86726194643, 1474.9336279867432, 1476.5644134980207, 1479.2825479642365, 942.2181303532248, 957.8132264208413, 972.644984580623, 981.1562056631292, 987.9308448408542, 5688.829335119953, 5743.0, 5752.108423194411, 5759.481646651821, 5819.214406055213, 5448.046591846411, 6330.651814150266, 6456.192975878015, 6456.838579035561, 6477.255115661759, 5476.945230547723, 5547.583931205095, 5708.143778433268, 5810.6513609183585, 5824.835032993418, 3032.69673032695, 3052.984735076355, 3135.0751528299206, 3324.517944897976, 3367.461206206995, 5798.449147330997, 6118.20463339763, 6288.9056664150075, 6465.741370345228, 6725.562838415487, 6480.902786458207, 6568.587753632992, 6582.617650293396, 6585.958352910613, 6640.933590664032, 6145.139680444741, 6537.411632953057, 6702.564333318319, 6707.53047286695, 6708.463322934153, 6422.967885160544, 6452.677366131768, 6458.935410646021, 6462.967685161544, 6517.4134327910715, 5627.634203776742, 5836.416358364299, 6325.96837015812, 6368.5860419072615, 6382.648954307372, 5364.195370694271, 5375.941164420838, 6157.4458298753325, 6217.595856269328, 6268.780592679234, 3323.5845519310087, 3948.7433316834313, 3969.4442778010525, 3994.6617883009517, 4018.7588744675413, 5458.836234912959, 5915.852103697442, 5927.110933360031, 5957.582969192115, 5980.700964951822, 5356.544693701079, 5465.535429488538, 5851.795187168599, 5868.706564671835, 5909.409059094056, 4596.494385617512, 4653.511381304914, 5087.516685914832, 5451.155070964007, 5702.51528620072, 5060.772265247999, 5380.354357477127, 5730.369659337386, 5755.366909639853, 5777.94222057774, 5533.667979921218, 5829.854253643693, 5849.327327357409, 5868.823935281948, 5883.470487656132, 4855.611551075976, 5737.9139312911175, 5761.942380576141, 5802.361740208489, 5803.90824468757], "value": 4270.467914198239, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [643.5752403413748, 655.4592461219494, 669.9196096468424, 699.604723331318, 739.5267029101375, 12748.936255318722, 14533.200673962929, 14565.708685826277, 14844.480443184491, 15932.52202433926, 15425.460108896192, 15425.92287038566, 15521.301541430634, 15581.298841552129, 15601.765973510406, 723.1141851232225, 895.0512456795785, 896.6996056321141, 899.5007770687266, 910.1035480052143, 893.78995935955, 914.6981496106268, 922.7554698005034, 924.7503174142977, 929.3355250995537, 936.3071327217878, 965.7151140413595, 967.762898089969, 969.3117886300735, 970.6651205334149, 925.6343744221028, 951.9952400238024, 954.9713508594754, 957.8036502516967, 963.7879666473435, 708.4297140801652, 714.2643077630049, 718.3211864787778, 721.1346384338815, 727.1456039154026, 14824.629384265372, 14969.401223951028, 15003.099814011195, 15065.171415572138, 15180.848191518164, 12060.879391206063, 12204.206726562745, 12239.571614993432, 12325.198862073936, 12390.75218495625, 7955.562444065574, 9743.707688769347, 9883.950580247125, 9918.752031199205, 9920.288735238008, 3057.877684892602, 3191.9680803191904, 3352.3630510202984, 3393.0838673558246, 3428.9142771430666, 75014.0, 77733.22266777317, 78970.60514697447, 80090.59954700248, 81166.59416702879, 9206.539673016323, 9221.53892305382, 9290.723772675603, 9414.011528789515, 9443.055694430639, 19876.50308742264, 20650.86420246901, 20958.056887440103, 21006.78993210079, 21066.368008959755, 7435.776926692208, 7440.813979650552, 7635.923640763522, 7714.074311082706, 7864.0, 4041.4341992121126, 4050.696197785119, 4052.65552428041, 4083.612056854594, 4102.692298077656, 3487.2676737885326, 3553.5558055243096, 3560.412531932202, 3562.679358857715, 3563.6792688658147, 621.1149112514648, 628.867937733072, 636.6562056489537, 642.4539141729585, 648.1994736500512, 560.4507582569105, 580.9012467880386, 587.5593305021234, 609.2110716621985, 617.4597227426002, 7609.429292803062, 7959.602019898982, 8044.235797599219, 8179.959100204461, 8183.918160818434, 444.89989752305473, 520.7136075158647, 571.9751978865645, 579.6406228138496, 603.435787538644, 3333.283344080986, 3774.679152272088, 3831.2912111259507, 3876.7286289959434, 3903.902402439905, 101557.0, 102941.97058029474, 103328.48335758274, 104061.0, 105700.0, 83378.74931876027, 86047.27905441856, 86209.1379086201, 86712.0, 87410.1258987402, 60871.6956415224, 70819.10494922726, 74980.62509687417, 75425.24574754293, 75748.0, 6707.859663857058, 7564.697412103675, 7798.571078590732, 7805.414593905593, 7867.763967080997, 36177.819110904275, 47573.28640070333, 48165.0, 48358.0, 48368.27447588219, 63950.680246598466, 64142.67928660327, 66423.66788166028, 68924.65537672279, 68975.65512172406, 9456.196223321094, 11059.059979901476, 11122.888771112186, 11314.547418103184, 11420.885791141982, 11624.360660163435, 11825.0, 11985.64043078709, 12174.14780965324, 12200.694982625506, 11434.42827858587, 11437.885621144014, 11651.88348116508, 11675.532978680758, 11956.880431195925, 10242.180625549789, 10477.057064864199, 10528.36829790215, 10532.631357902437, 10542.841857371992, 11195.328280303207, 11272.943635281772, 11292.604758833402, 11387.601433949772, 11561.017313528444, 9560.808783824146, 9669.419834809934, 9701.6119355225, 9798.65704700332, 9845.85231221518, 9717.222622190066, 10012.799744004933, 10026.03779936037, 10075.697729068139, 10113.083845949908], "value": 6847.51277389864, "unit": "score"}], "name": "dromaeo_css", "value": 7042.446036465163, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 112.0, 115.0, 116.0, 118.0, 127.0, 119.0, 167.0, 169.0, 118.0], "value": 127.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 124.0, 153.0, 157.0, 144.0, 177.0, 163.0, 148.0, 209.0, 155.0], "value": 158.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [251.0, 265.0, 228.0, 222.0, 187.0, 226.0, 216.0, 270.0, 208.0, 268.0], "value": 234.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 89.0, 88.0, 138.0, 52.0, 82.0, 99.0, 89.0, 78.0, 58.0], "value": 84.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 82.0, 140.0, 79.0, 97.0, 68.0, 143.0, 120.0, 121.0, 162.0], "value": 109.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 130.0, 92.0, 74.0, 137.0, 88.0, 108.0, 88.0, 90.0, 87.0], "value": 102.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 98.0, 105.0, 126.0, 94.0, 92.0, 90.0, 153.0, 150.0, 110.0], "value": 111.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 152.0, 133.0, 92.0, 127.0, 93.0, 98.0, 96.0, 147.0, 90.0], "value": 112.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 63.0, 61.0, 62.0, 62.0, 61.0, 62.0, 81.0, 64.0, 60.0], "value": 63.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 66.0, 66.0, 74.0, 80.0, 76.0, 72.0, 67.0, 69.0, 68.0], "value": 70.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 82.0, 83.0, 82.0, 83.0, 84.0, 91.0, 82.0, 78.0, 103.0], "value": 85.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 137.0, 172.0, 160.0, 163.0, 141.0, 139.0, 149.0, 175.0, 141.0], "value": 151.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [202.0, 205.0, 210.0, 202.0, 199.0, 199.0, 213.0, 232.0, 281.0, 277.0], "value": 222.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 70.0, 69.0, 68.0, 72.0, 70.0, 68.0, 72.0, 70.0, 68.0], "value": 69.5, "unit": "score"}], "name": "kraken", "value": 1703.0000000000002, "alertThreshold": 2.0}]} 04:58:22 INFO - Return code: 0 04:58:22 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 04:58:22 ERROR - # TBPL SUCCESS # 04:58:22 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:58:22 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:58:22 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:58:22 INFO - 2016-04-27 04:58:22.563 screenresolution[2543:39484] starting screenresolution argv=screenresolution get 04:58:22 INFO - 2016-04-27 04:58:22.566 screenresolution[2543:39484] Display 0: 1600x1200x32@60 04:58:22 INFO - 2016-04-27 04:58:22.573 screenresolution[2544:39487] starting screenresolution argv=screenresolution list 04:58:22 INFO - Available Modes on Display 0 04:58:22 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:58:22 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:58:22 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:58:22 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:58:22 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:58:22 INFO - Intel Iris: 04:58:22 INFO - Chipset Model: Intel Iris 04:58:22 INFO - Type: GPU 04:58:22 INFO - Bus: Built-In 04:58:22 INFO - VRAM (Dynamic, Max): 1536 MB 04:58:22 INFO - Vendor: Intel (0x8086) 04:58:22 INFO - Device ID: 0x0a2e 04:58:22 INFO - Revision ID: 0x0009 04:58:22 INFO - Displays: 04:58:22 INFO - Display: 04:58:22 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:58:22 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:58:22 INFO - Display Serial Number: 1600x1200 60 04:58:22 INFO - Main Display: Yes 04:58:22 INFO - Mirror: Off 04:58:22 INFO - Online: Yes 04:58:22 INFO - Rotation: Supported 04:58:22 INFO - Return code: 0 04:58:22 INFO - Running post-action listener: _resource_record_post_action 04:58:22 INFO - Running post-run listener: _resource_record_post_run 04:58:23 INFO - Total resource usage - Wall time: 1209s; CPU: 54.0%; Read bytes: 8192; Write bytes: 696901632; Read time: 1; Write time: 1838 04:58:23 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 396239360; Write bytes: 397379584; Read time: 29870; Write time: 692 04:58:23 INFO - run-tests - Wall time: 1176s; CPU: 54.0%; Read bytes: 8192; Write bytes: 298674176; Read time: 1; Write time: 1143 04:58:23 INFO - Running post-run listener: _upload_blobber_files 04:58:23 INFO - Blob upload gear active. 04:58:23 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:58:23 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 04:58:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:58:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:58:24 INFO - (blobuploader) - INFO - Open directory for files ... 04:58:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:58:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:58:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:58:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:58:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:58:25 INFO - (blobuploader) - INFO - Done attempting. 04:58:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:58:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:58:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:58:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:58:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:58:26 INFO - (blobuploader) - INFO - Done attempting. 04:58:26 INFO - (blobuploader) - INFO - Iteration through files over. 04:58:26 INFO - Return code: 0 04:58:26 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:58:26 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:58:26 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0b626067546d8e42ceb7ca4c597f2fa3c63376ebf3638fb2d607b741f31d188a591c9a3e6be61d00c4f60d161fc0d0b2e465c5029e6a1be6f2e99be80af7b2fe", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b8174ee3165741ca8c2d6bac82c3050f80e776a0bb2c42946ccf6d7c6772b0214e02b3ab4bb4f004f2d618704c781f958c4ef3791e6b0f6f230691ffd07ce759"} 04:58:26 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:58:26 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:58:26 INFO - Contents: 04:58:26 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0b626067546d8e42ceb7ca4c597f2fa3c63376ebf3638fb2d607b741f31d188a591c9a3e6be61d00c4f60d161fc0d0b2e465c5029e6a1be6f2e99be80af7b2fe", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b8174ee3165741ca8c2d6bac82c3050f80e776a0bb2c42946ccf6d7c6772b0214e02b3ab4bb4f004f2d618704c781f958c4ef3791e6b0f6f230691ffd07ce759"} 04:58:26 INFO - Running post-run listener: copy_logs_to_upload_dir 04:58:26 INFO - Copying logs to upload dir... 04:58:26 INFO - mkdir: /builds/slave/test/build/upload/logs 04:58:26 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1275.558540 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 15 secs) (at 2016-04-27 04:58:26.086843) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-27 04:58:26.090302) ========= 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.e6Erri8krh/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.YdS1dYY70A/Listeners TMPDIR=/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0b626067546d8e42ceb7ca4c597f2fa3c63376ebf3638fb2d607b741f31d188a591c9a3e6be61d00c4f60d161fc0d0b2e465c5029e6a1be6f2e99be80af7b2fe", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b8174ee3165741ca8c2d6bac82c3050f80e776a0bb2c42946ccf6d7c6772b0214e02b3ab4bb4f004f2d618704c781f958c4ef3791e6b0f6f230691ffd07ce759"} build_url:https://queue.taskcluster.net/v1/task/b2PQxyzfRb2H8sxK4MAqnA/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011065 build_url: 'https://queue.taskcluster.net/v1/task/b2PQxyzfRb2H8sxK4MAqnA/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0b626067546d8e42ceb7ca4c597f2fa3c63376ebf3638fb2d607b741f31d188a591c9a3e6be61d00c4f60d161fc0d0b2e465c5029e6a1be6f2e99be80af7b2fe", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b8174ee3165741ca8c2d6bac82c3050f80e776a0bb2c42946ccf6d7c6772b0214e02b3ab4bb4f004f2d618704c781f958c4ef3791e6b0f6f230691ffd07ce759"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-27 04:58:26.120278) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-27 04:58:26.120870) ========= 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.e6Erri8krh/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.YdS1dYY70A/Listeners TMPDIR=/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/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.005394 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-27 04:58:26.171866) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-27 04:58:26.172421) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-27 04:58:26.173152) ========= ========= Total master_lag: 0.17 =========