builder: mozilla-aurora_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0036 starttime: 1461232712.78 results: success (0) buildid: 20160421004015 builduid: f5477824316040afb8baf30e22588afd revision: d9fdbad8f079c7801abdef70df2cad93efcce797 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-21 02:58:32.778081) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-21 02:58:32.778482) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 9 secs) (at 2016-04-21 02:58:32.782739) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 9 secs) (at 2016-04-21 02:58:41.880492) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 10 secs) (at 2016-04-21 02:58:41.880805) ========= 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.RADXpxaORO/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.VUVFzidAel/Listeners TMPDIR=/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/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-21 02:58:41-- 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% 28.9M=0s 2016-04-21 02:58:41 (28.9 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.087875 ========= master_lag: 10.24 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 10 secs) (at 2016-04-21 02:58:52.206981) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 1 secs) (at 2016-04-21 02:58:52.207278) ========= 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.RADXpxaORO/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.VUVFzidAel/Listeners TMPDIR=/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/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.026958 ========= master_lag: 1.09 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 1 secs) (at 2016-04-21 02:58:53.323661) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 4 secs) (at 2016-04-21 02:58:53.324033) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev d9fdbad8f079c7801abdef70df2cad93efcce797 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev d9fdbad8f079c7801abdef70df2cad93efcce797 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.RADXpxaORO/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.VUVFzidAel/Listeners TMPDIR=/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/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-21 02:58:53,419 truncating revision to first 12 chars 2016-04-21 02:58:53,420 Setting DEBUG logging. 2016-04-21 02:58:53,420 attempt 1/10 2016-04-21 02:58:53,420 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/d9fdbad8f079?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-21 02:58:54,490 unpacking tar archive at: mozilla-aurora-d9fdbad8f079/testing/mozharness/ program finished with exit code 0 elapsedTime=1.499232 ========= master_lag: 2.72 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 4 secs) (at 2016-04-21 02:58:57.543446) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-21 02:58:57.543744) ========= script_repo_revision: d9fdbad8f079c7801abdef70df2cad93efcce797 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-21 02:58:57.544131) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 25 secs) (at 2016-04-21 02:58:57.544406) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 25 secs) (at 2016-04-21 02:59:22.587230) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 59 secs) (at 2016-04-21 02:59:22.587558) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 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', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.RADXpxaORO/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.VUVFzidAel/Listeners TMPDIR=/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/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 02:59:23 INFO - MultiFileLogger online at 20160421 02:59:23 in /builds/slave/test 02:59:23 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 02:59:23 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:59:23 INFO - {'append_to_log': False, 02:59:23 INFO - 'base_work_dir': '/builds/slave/test', 02:59:23 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 02:59:23 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:59:23 INFO - 'branch': 'Mozilla-Aurora', 02:59:23 INFO - 'buildbot_json_path': 'buildprops.json', 02:59:23 INFO - 'config_files': ('talos/mac_config.py',), 02:59:23 INFO - 'default_actions': ('clobber', 02:59:23 INFO - 'read-buildbot-config', 02:59:23 INFO - 'download-and-extract', 02:59:23 INFO - 'populate-webroot', 02:59:23 INFO - 'create-virtualenv', 02:59:23 INFO - 'install', 02:59:23 INFO - 'run-tests'), 02:59:23 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:59:23 INFO - 'download_minidump_stackwalk': True, 02:59:23 INFO - 'download_symbols': 'ondemand', 02:59:23 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:59:23 INFO - 'tooltool.py': '/tools/tooltool.py', 02:59:23 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:59:23 INFO - '/tools/misc-python/virtualenv.py')}, 02:59:23 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:59:23 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:59:23 INFO - 'installer_path': 'installer.exe', 02:59:23 INFO - 'log_level': 'info', 02:59:23 INFO - 'log_name': 'talos', 02:59:23 INFO - 'log_to_console': True, 02:59:23 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 02:59:23 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 02:59:23 INFO - 'opt_config_files': (), 02:59:23 INFO - 'pip_index': False, 02:59:23 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:59:23 INFO - 'cmd': ('bash', 02:59:23 INFO - '-c', 02:59:23 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:59:23 INFO - 'enabled': True, 02:59:23 INFO - 'halt_on_failure': False, 02:59:23 INFO - 'name': 'check_screen_resolution'},), 02:59:23 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:59:23 INFO - 'cmd': ('bash', 02:59:23 INFO - '-c', 02:59:23 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:59:23 INFO - 'enabled': True, 02:59:23 INFO - 'halt_on_failure': False, 02:59:23 INFO - 'name': 'check_screen_resolution'},), 02:59:23 INFO - 'run_cmd_checks_enabled': True, 02:59:23 INFO - 'sps_profile': False, 02:59:23 INFO - 'sps_profile_interval': 0, 02:59:23 INFO - 'suite': 'dromaeojs-e10s', 02:59:23 INFO - 'system_bits': '32', 02:59:23 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:59:23 INFO - 'title': 't-yosemite-r7-0036', 02:59:23 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:59:23 INFO - 'use_talos_json': True, 02:59:23 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:59:23 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:59:23 INFO - 'work_dir': 'build'} 02:59:23 INFO - ##### 02:59:23 INFO - ##### Running clobber step. 02:59:23 INFO - ##### 02:59:23 INFO - Running pre-action listener: _resource_record_pre_action 02:59:23 INFO - Running main action method: clobber 02:59:23 INFO - rmtree: /builds/slave/test/build 02:59:23 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:59:25 INFO - Running post-action listener: _resource_record_post_action 02:59:25 INFO - ##### 02:59:25 INFO - ##### Running read-buildbot-config step. 02:59:25 INFO - ##### 02:59:25 INFO - Running pre-action listener: _resource_record_pre_action 02:59:25 INFO - Running main action method: read_buildbot_config 02:59:25 INFO - Using buildbot properties: 02:59:25 INFO - { 02:59:25 INFO - "project": "", 02:59:25 INFO - "product": "firefox", 02:59:25 INFO - "script_repo_revision": "production", 02:59:25 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs-e10s", 02:59:25 INFO - "repository": "", 02:59:25 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs-e10s", 02:59:25 INFO - "buildid": "20160421004015", 02:59:25 INFO - "stage_platform": "macosx64", 02:59:25 INFO - "basedir": "/builds/slave/test", 02:59:25 INFO - "nightly_build": "True", 02:59:25 INFO - "buildnumber": 274, 02:59:25 INFO - "slavename": "t-yosemite-r7-0036", 02:59:25 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 02:59:25 INFO - "platform": "yosemite_r7", 02:59:25 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 02:59:25 INFO - "branch": "mozilla-aurora", 02:59:25 INFO - "repo_path": "releases/mozilla-aurora", 02:59:25 INFO - "revision": "d9fdbad8f079c7801abdef70df2cad93efcce797", 02:59:25 INFO - "pgo_build": "False", 02:59:25 INFO - "builduid": "f5477824316040afb8baf30e22588afd", 02:59:25 INFO - "slavebuilddir": "test" 02:59:25 INFO - } 02:59:25 INFO - Found installer url https://queue.taskcluster.net/v1/task/QYA9JMn0QByLdkawb6hf5w/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg. 02:59:25 INFO - Running post-action listener: _resource_record_post_action 02:59:25 INFO - ##### 02:59:25 INFO - ##### Running download-and-extract step. 02:59:25 INFO - ##### 02:59:25 INFO - Running pre-action listener: _resource_record_pre_action 02:59:25 INFO - Running main action method: download_and_extract 02:59:25 INFO - mkdir: /builds/slave/test/build/tests 02:59: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')]} 02:59:25 INFO - https://queue.taskcluster.net/v1/task/QYA9JMn0QByLdkawb6hf5w/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json matches https://queue.taskcluster.net 02:59:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QYA9JMn0QByLdkawb6hf5w/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json 02:59:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QYA9JMn0QByLdkawb6hf5w/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json 02:59:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QYA9JMn0QByLdkawb6hf5w/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-47.0a2.en-US.mac.test_packages.json 02:59:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QYA9JMn0QByLdkawb6hf5w/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-47.0a2.en-US.mac.test_packages.json'}, attempt #1 02:59:26 INFO - Downloaded 1277 bytes. 02:59:26 INFO - Reading from file /builds/slave/test/build/firefox-47.0a2.en-US.mac.test_packages.json 02:59:26 INFO - Using the following test package requirements: 02:59:26 INFO - {u'common': [u'firefox-47.0a2.en-US.mac.common.tests.zip'], 02:59:26 INFO - u'cppunittest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 02:59:26 INFO - u'firefox-47.0a2.en-US.mac.cppunittest.tests.zip'], 02:59:26 INFO - u'gtest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 02:59:26 INFO - u'firefox-47.0a2.en-US.mac.gtest.tests.zip'], 02:59:26 INFO - u'jittest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 02:59:26 INFO - u'jsshell-mac.zip'], 02:59:26 INFO - u'mochitest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 02:59:26 INFO - u'firefox-47.0a2.en-US.mac.mochitest.tests.zip'], 02:59:26 INFO - u'mozbase': [u'firefox-47.0a2.en-US.mac.common.tests.zip'], 02:59:26 INFO - u'reftest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 02:59:26 INFO - u'firefox-47.0a2.en-US.mac.reftest.tests.zip'], 02:59:26 INFO - u'talos': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 02:59:26 INFO - u'firefox-47.0a2.en-US.mac.talos.tests.zip'], 02:59:26 INFO - u'web-platform': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 02:59:26 INFO - u'firefox-47.0a2.en-US.mac.web-platform.tests.zip'], 02:59:26 INFO - u'webapprt': [u'firefox-47.0a2.en-US.mac.common.tests.zip'], 02:59:26 INFO - u'xpcshell': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 02:59:26 INFO - u'firefox-47.0a2.en-US.mac.xpcshell.tests.zip']} 02:59:26 INFO - Downloading packages: [u'firefox-47.0a2.en-US.mac.common.tests.zip'] for test suite category: common 02:59:26 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')]} 02:59:26 INFO - https://queue.taskcluster.net/v1/task/QYA9JMn0QByLdkawb6hf5w/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 02:59:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QYA9JMn0QByLdkawb6hf5w/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 02:59:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QYA9JMn0QByLdkawb6hf5w/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 02:59:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QYA9JMn0QByLdkawb6hf5w/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip 02:59:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QYA9JMn0QByLdkawb6hf5w/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip'}, attempt #1 02:59:27 INFO - Downloaded 17913975 bytes. 02:59:27 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:59:27 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 02:59:30 INFO - Return code: 0 02:59:30 INFO - Downloading packages: [u'firefox-47.0a2.en-US.mac.common.tests.zip', u'firefox-47.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 02:59:30 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')]} 02:59:30 INFO - https://queue.taskcluster.net/v1/task/QYA9JMn0QByLdkawb6hf5w/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 02:59:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QYA9JMn0QByLdkawb6hf5w/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 02:59:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QYA9JMn0QByLdkawb6hf5w/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 02:59:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QYA9JMn0QByLdkawb6hf5w/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip 02:59:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QYA9JMn0QByLdkawb6hf5w/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip'}, attempt #1 02:59:32 INFO - Downloaded 17913975 bytes. 02:59:32 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:59:32 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 02:59:35 INFO - Return code: 0 02:59:35 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')]} 02:59:35 INFO - https://queue.taskcluster.net/v1/task/QYA9JMn0QByLdkawb6hf5w/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 02:59:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QYA9JMn0QByLdkawb6hf5w/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip 02:59:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QYA9JMn0QByLdkawb6hf5w/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip 02:59:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QYA9JMn0QByLdkawb6hf5w/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-47.0a2.en-US.mac.talos.tests.zip 02:59:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QYA9JMn0QByLdkawb6hf5w/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.talos.tests.zip'}, attempt #1 02:59:36 INFO - Downloaded 10845198 bytes. 02:59:36 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:59:36 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a2.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 02:59:37 INFO - Return code: 0 02:59:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 02:59:37 INFO - https://queue.taskcluster.net/v1/task/QYA9JMn0QByLdkawb6hf5w/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg matches https://queue.taskcluster.net 02:59:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QYA9JMn0QByLdkawb6hf5w/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 02:59:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QYA9JMn0QByLdkawb6hf5w/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 02:59:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QYA9JMn0QByLdkawb6hf5w/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a2.en-US.mac.dmg 02:59:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QYA9JMn0QByLdkawb6hf5w/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-47.0a2.en-US.mac.dmg'}, attempt #1 02:59:40 INFO - Downloaded 115339891 bytes. 02:59:40 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/QYA9JMn0QByLdkawb6hf5w/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 02:59:40 INFO - mkdir: /builds/slave/test/properties 02:59:40 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:59:40 INFO - Writing to file /builds/slave/test/properties/build_url 02:59:40 INFO - Contents: 02:59:40 INFO - build_url:https://queue.taskcluster.net/v1/task/QYA9JMn0QByLdkawb6hf5w/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 02:59:40 INFO - Running post-action listener: _resource_record_post_action 02:59:40 INFO - Running post-action listener: set_extra_try_arguments 02:59:40 INFO - ##### 02:59:40 INFO - ##### Running populate-webroot step. 02:59:40 INFO - ##### 02:59:40 INFO - Running pre-action listener: _resource_record_pre_action 02:59:40 INFO - Running main action method: populate_webroot 02:59:40 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:59:40 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:59:40 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:59:40 INFO - '--tppagecycles', 02:59:40 INFO - '7'], 02:59:40 INFO - 'tests': ['tsvgm']}}, 02:59:40 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 02:59:40 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 02:59:40 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:59:40 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 02:59:40 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 02:59:40 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:59:40 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:59:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:59:40 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:59:40 INFO - 'talos_options': ['--e10s'], 02:59:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:59:40 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:59:40 INFO - 'tests': ['damp', 'tps']}, 02:59:40 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:59:40 INFO - 'talos_options': ['--e10s'], 02:59:40 INFO - 'tests': ['damp', 'tps']}, 02:59:40 INFO - 'g3': {'tests': ['dromaeo_dom']}, 02:59:40 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:59:40 INFO - 'other': {'tests': ['a11yr', 02:59:40 INFO - 'ts_paint', 02:59:40 INFO - 'tpaint', 02:59:40 INFO - 'sessionrestore', 02:59:40 INFO - 'sessionrestore_no_auto_restore', 02:59:40 INFO - 'tabpaint']}, 02:59:40 INFO - 'other-e10s': {'talos_options': ['--e10s'], 02:59:40 INFO - 'tests': ['a11yr', 02:59:40 INFO - 'ts_paint', 02:59:40 INFO - 'tpaint', 02:59:40 INFO - 'sessionrestore', 02:59:40 INFO - 'sessionrestore_no_auto_restore', 02:59:40 INFO - 'tabpaint']}, 02:59:40 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 02:59:40 INFO - 'tests': ['a11yr', 02:59:40 INFO - 'ts_paint', 02:59:40 INFO - 'tpaint', 02:59:40 INFO - 'sessionrestore', 02:59:40 INFO - 'sessionrestore_no_auto_restore', 02:59:40 INFO - 'tabpaint']}, 02:59:40 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 02:59:40 INFO - 'tests': ['a11yr', 02:59:40 INFO - 'ts_paint', 02:59:40 INFO - 'tpaint', 02:59:40 INFO - 'sessionrestore', 02:59:40 INFO - 'sessionrestore_no_auto_restore', 02:59:40 INFO - 'tabpaint']}, 02:59:40 INFO - 'other_l64': {'tests': ['a11yr', 02:59:40 INFO - 'ts_paint', 02:59:40 INFO - 'tpaint', 02:59:40 INFO - 'sessionrestore', 02:59:40 INFO - 'sessionrestore_no_auto_restore', 02:59:40 INFO - 'tabpaint']}, 02:59:40 INFO - 'other_nol64': {'tests': ['a11yr', 02:59:40 INFO - 'ts_paint', 02:59:40 INFO - 'tpaint', 02:59:40 INFO - 'sessionrestore', 02:59:40 INFO - 'sessionrestore_no_auto_restore', 02:59:40 INFO - 'tabpaint']}, 02:59:40 INFO - 'svgr': {'tests': ['tsvgx', 02:59:40 INFO - 'tsvgr_opacity', 02:59:40 INFO - 'tart', 02:59:40 INFO - 'tscrollx', 02:59:40 INFO - 'cart']}, 02:59:40 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 02:59:40 INFO - 'tests': ['tsvgx', 02:59:40 INFO - 'tsvgr_opacity', 02:59:40 INFO - 'tart', 02:59:40 INFO - 'tscrollx', 02:59:40 INFO - 'cart']}, 02:59:40 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:59:40 INFO - 'tests': ['tp5o']}, 02:59:40 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:59:40 INFO - 'talos_options': ['--e10s'], 02:59:40 INFO - 'tests': ['tp5o']}, 02:59:40 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:59:40 INFO - 'talos_options': ['--xperf_path', 02:59:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:59:40 INFO - 'tests': ['tp5n']}, 02:59:40 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:59:40 INFO - 'talos_options': ['--e10s', 02:59:40 INFO - '--xperf_path', 02:59:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:59:40 INFO - 'tests': ['tp5n']}}, 02:59:40 INFO - 'talos.zip': {'path': '', 02:59:40 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:59:40 INFO - Running post-action listener: _resource_record_post_action 02:59:40 INFO - ##### 02:59:40 INFO - ##### Running create-virtualenv step. 02:59:40 INFO - ##### 02:59:40 INFO - Running pre-action listener: _resource_record_pre_action 02:59:40 INFO - Running main action method: create_virtualenv 02:59:40 INFO - Creating virtualenv /builds/slave/test/build/venv 02:59:40 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 02:59:40 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:59:41 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:59:41 INFO - Using real prefix '/tools/python27' 02:59:41 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:59:41 INFO - Installing distribute.............................................................................................................................................................................................done. 02:59:44 INFO - Installing pip.................done. 02:59:44 INFO - Return code: 0 02:59:44 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:59:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 02:59:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:59:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:59:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 02:59:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:59:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:59:44 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 0x106534a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10653b4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f803a493540>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1063d8d30>, '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 0x10623cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1063cfb20>, '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.RADXpxaORO/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.VUVFzidAel/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/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 02:59:44 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 02:59:44 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 02:59:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RADXpxaORO/Render', 02:59:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:59:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:59:44 INFO - 'HOME': '/Users/cltbld', 02:59:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:59:44 INFO - 'LOGNAME': 'cltbld', 02:59:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:59:44 INFO - 'MOZ_NO_REMOTE': '1', 02:59:44 INFO - 'NO_EM_RESTART': '1', 02:59:44 INFO - 'PAGER': '/bin/cat', 02:59:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:59:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:59:44 INFO - 'PWD': '/builds/slave/test', 02:59:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:59:44 INFO - 'SHELL': '/bin/bash', 02:59:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VUVFzidAel/Listeners', 02:59:44 INFO - 'TMPDIR': '/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/', 02:59:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:59:44 INFO - 'USER': 'cltbld', 02:59:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:59:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:59:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:59:44 INFO - 'XPC_FLAGS': '0x0', 02:59:44 INFO - 'XPC_SERVICE_NAME': '0', 02:59:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:59:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:59:44 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 02:59:44 INFO - Cleaning up... 02:59:44 INFO - Return code: 0 02:59:44 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 02:59:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 02:59:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:59:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:59:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 02:59:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:59:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:59:44 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 0x106534a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10653b4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f803a493540>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1063d8d30>, '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 0x10623cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1063cfb20>, '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.RADXpxaORO/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.VUVFzidAel/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/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 02:59:44 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 02:59:44 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 02:59:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RADXpxaORO/Render', 02:59:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:59:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:59:44 INFO - 'HOME': '/Users/cltbld', 02:59:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:59:44 INFO - 'LOGNAME': 'cltbld', 02:59:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:59:44 INFO - 'MOZ_NO_REMOTE': '1', 02:59:44 INFO - 'NO_EM_RESTART': '1', 02:59:44 INFO - 'PAGER': '/bin/cat', 02:59:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:59:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:59:44 INFO - 'PWD': '/builds/slave/test', 02:59:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:59:44 INFO - 'SHELL': '/bin/bash', 02:59:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VUVFzidAel/Listeners', 02:59:44 INFO - 'TMPDIR': '/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/', 02:59:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:59:44 INFO - 'USER': 'cltbld', 02:59:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:59:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:59:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:59:44 INFO - 'XPC_FLAGS': '0x0', 02:59:44 INFO - 'XPC_SERVICE_NAME': '0', 02:59:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:59:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:59:45 INFO - Downloading/unpacking psutil>=0.7.1 02:59:45 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 02:59:45 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 02:59:45 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 02:59:45 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 02:59:45 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 02:59:45 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 02:59:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:59:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:59:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:59:48 INFO - Installing collected packages: psutil 02:59:48 INFO - Running setup.py install for psutil 02:59:48 INFO - building 'psutil._psutil_osx' extension 02:59:48 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 02:59:49 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 02:59:49 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 02:59:49 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 02:59:49 INFO - building 'psutil._psutil_posix' extension 02:59:49 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 02:59:49 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 02:59:49 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 02:59:49 INFO - ^ 02:59:49 INFO - 1 warning generated. 02:59:49 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 02:59:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:59:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:59:49 INFO - Successfully installed psutil 02:59:49 INFO - Cleaning up... 02:59:49 INFO - Return code: 0 02:59:49 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 02:59: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')]} 02:59:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:59:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:59: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')]} 02:59:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:59:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:59: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', '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 0x106534a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10653b4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f803a493540>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1063d8d30>, '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 0x10623cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1063cfb20>, '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.RADXpxaORO/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.VUVFzidAel/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/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 02:59: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', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 02:59: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 mozsystemmonitor==0.0.0 02:59:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RADXpxaORO/Render', 02:59:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:59:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:59:49 INFO - 'HOME': '/Users/cltbld', 02:59:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:59:49 INFO - 'LOGNAME': 'cltbld', 02:59:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:59:49 INFO - 'MOZ_NO_REMOTE': '1', 02:59:49 INFO - 'NO_EM_RESTART': '1', 02:59:49 INFO - 'PAGER': '/bin/cat', 02:59:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:59:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:59:49 INFO - 'PWD': '/builds/slave/test', 02:59:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:59:49 INFO - 'SHELL': '/bin/bash', 02:59:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VUVFzidAel/Listeners', 02:59:49 INFO - 'TMPDIR': '/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/', 02:59:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:59:49 INFO - 'USER': 'cltbld', 02:59:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:59:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:59:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:59:49 INFO - 'XPC_FLAGS': '0x0', 02:59:49 INFO - 'XPC_SERVICE_NAME': '0', 02:59:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:59:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:59:50 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 02:59: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 02:59: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 02:59: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 02:59: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 02:59: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 02:59: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 02:59:52 INFO - Downloading mozsystemmonitor-0.0.tar.gz 02:59:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:59:52 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 02:59:52 INFO - Installing collected packages: mozsystemmonitor 02:59:52 INFO - Running setup.py install for mozsystemmonitor 02:59:52 INFO - Successfully installed mozsystemmonitor 02:59:52 INFO - Cleaning up... 02:59:52 INFO - Return code: 0 02:59:52 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:59:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 02:59:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:59:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:59:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 02:59:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:59:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:59:52 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 0x106534a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10653b4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f803a493540>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1063d8d30>, '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 0x10623cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1063cfb20>, '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.RADXpxaORO/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.VUVFzidAel/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/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 02:59:52 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 02:59:52 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 02:59:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RADXpxaORO/Render', 02:59:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:59:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:59:52 INFO - 'HOME': '/Users/cltbld', 02:59:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:59:52 INFO - 'LOGNAME': 'cltbld', 02:59:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:59:52 INFO - 'MOZ_NO_REMOTE': '1', 02:59:52 INFO - 'NO_EM_RESTART': '1', 02:59:52 INFO - 'PAGER': '/bin/cat', 02:59:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:59:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:59:52 INFO - 'PWD': '/builds/slave/test', 02:59:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:59:52 INFO - 'SHELL': '/bin/bash', 02:59:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VUVFzidAel/Listeners', 02:59:52 INFO - 'TMPDIR': '/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/', 02:59:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:59:52 INFO - 'USER': 'cltbld', 02:59:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:59:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:59:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:59:52 INFO - 'XPC_FLAGS': '0x0', 02:59:52 INFO - 'XPC_SERVICE_NAME': '0', 02:59:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:59:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:59:53 INFO - Downloading/unpacking blobuploader==1.2.4 02:59: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 02:59: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 02:59: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 02:59: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 02:59: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 02:59: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 02:59:55 INFO - Downloading blobuploader-1.2.4.tar.gz 02:59:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:59:55 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:59:55 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 02:59:55 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 02:59:55 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 02:59:55 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 02:59:55 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 02:59:55 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 02:59:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:59:56 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:59:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:59:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:59:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:59:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:59:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:59:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:59:56 INFO - Downloading docopt-0.6.1.tar.gz 02:59:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:59:56 INFO - Installing collected packages: blobuploader, requests, docopt 02:59:56 INFO - Running setup.py install for blobuploader 02:59:56 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:59:56 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:59:56 INFO - Running setup.py install for requests 02:59:57 INFO - Running setup.py install for docopt 02:59:57 INFO - Successfully installed blobuploader requests docopt 02:59:57 INFO - Cleaning up... 02:59:57 INFO - Return code: 0 02:59:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:59:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 02:59:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:59:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:59:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 02:59:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:59:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:59:57 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 0x106534a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10653b4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f803a493540>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1063d8d30>, '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 0x10623cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1063cfb20>, '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.RADXpxaORO/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.VUVFzidAel/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/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 02:59:57 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 02:59:57 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 02:59:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RADXpxaORO/Render', 02:59:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:59:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:59:57 INFO - 'HOME': '/Users/cltbld', 02:59:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:59:57 INFO - 'LOGNAME': 'cltbld', 02:59:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:59:57 INFO - 'MOZ_NO_REMOTE': '1', 02:59:57 INFO - 'NO_EM_RESTART': '1', 02:59:57 INFO - 'PAGER': '/bin/cat', 02:59:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:59:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:59:57 INFO - 'PWD': '/builds/slave/test', 02:59:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:59:57 INFO - 'SHELL': '/bin/bash', 02:59:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VUVFzidAel/Listeners', 02:59:57 INFO - 'TMPDIR': '/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/', 02:59:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:59:57 INFO - 'USER': 'cltbld', 02:59:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:59:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:59:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:59:57 INFO - 'XPC_FLAGS': '0x0', 02:59:57 INFO - 'XPC_SERVICE_NAME': '0', 02:59:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:59:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:59:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:59:57 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-yYhSQV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:59:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:59:57 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-YxkZV6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:59:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:59:58 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-cC0eJW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:59:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:59:58 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-JMs4ZV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:59:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:59:58 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-nBaB3i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:59:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:59:58 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-dVJdeQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:59:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:59:58 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-xuFmIj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:59:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:59:58 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-FdG5uu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:59:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:59:58 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-ynbXvr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:59:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:59:58 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-Mvarhn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:59:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:59:58 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-7_swxt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:59:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:59:59 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-gX_JKo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:59:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:59:59 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-aoixOU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:59:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:59:59 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-2LGds0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:59:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:59:59 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-v5Bxkj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:59:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:59:59 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-k2ZpM4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:59:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:59:59 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-qYTsVT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:59:59 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:59:59 INFO - Running setup.py install for manifestparser 02:59:59 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:59:59 INFO - Running setup.py install for mozcrash 02:59:59 INFO - Running setup.py install for mozdebug 03:00:00 INFO - Running setup.py install for mozdevice 03:00:00 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:00:00 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:00:00 INFO - Running setup.py install for mozfile 03:00:00 INFO - Running setup.py install for mozhttpd 03:00:00 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:00:00 INFO - Running setup.py install for mozinfo 03:00:00 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:00:00 INFO - Running setup.py install for mozInstall 03:00:00 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:00:00 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:00:00 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:00:00 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:00:00 INFO - Running setup.py install for mozleak 03:00:00 INFO - Running setup.py install for mozlog 03:00:01 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:00:01 INFO - Running setup.py install for moznetwork 03:00:01 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:00:01 INFO - Running setup.py install for mozprocess 03:00:01 INFO - Running setup.py install for mozprofile 03:00:01 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:00:01 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:00:01 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:00:01 INFO - Running setup.py install for mozrunner 03:00:01 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:00:01 INFO - Running setup.py install for mozscreenshot 03:00:01 INFO - Running setup.py install for moztest 03:00:02 INFO - Running setup.py install for mozversion 03:00:02 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:00:02 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:00:02 INFO - Cleaning up... 03:00:02 INFO - Return code: 0 03:00:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:00:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 03:00:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:00:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:00:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 03:00:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:00:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:00:02 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 0x106534a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10653b4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f803a493540>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1063d8d30>, '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 0x10623cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1063cfb20>, '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.RADXpxaORO/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.VUVFzidAel/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/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 03:00:02 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 03:00:02 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 03:00:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RADXpxaORO/Render', 03:00:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:00:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:00:02 INFO - 'HOME': '/Users/cltbld', 03:00:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:00:02 INFO - 'LOGNAME': 'cltbld', 03:00:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:00:02 INFO - 'MOZ_NO_REMOTE': '1', 03:00:02 INFO - 'NO_EM_RESTART': '1', 03:00:02 INFO - 'PAGER': '/bin/cat', 03:00:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:00:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:00:02 INFO - 'PWD': '/builds/slave/test', 03:00:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:00:02 INFO - 'SHELL': '/bin/bash', 03:00:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VUVFzidAel/Listeners', 03:00:02 INFO - 'TMPDIR': '/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/', 03:00:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:00:02 INFO - 'USER': 'cltbld', 03:00:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:00:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:00:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:00:02 INFO - 'XPC_FLAGS': '0x0', 03:00:02 INFO - 'XPC_SERVICE_NAME': '0', 03:00:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:00:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:00:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:00:02 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-MB4JWv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:00:02 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)) 03:00:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:00:02 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-H0vd42-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:00:02 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)) 03:00:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:00:02 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-u6Kg6w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:00:02 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)) 03:00:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:00:02 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-viJm5m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:00:02 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)) 03:00:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:00:02 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-6o2mjP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:00:03 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)) 03:00:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:00:03 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-QIL8qg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:00:03 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)) 03:00:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:00:03 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-yxAeU2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:00:03 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)) 03:00:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:00:03 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-NEkx5v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:00:03 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)) 03:00:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:00:03 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-36rO_q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:00:03 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)) 03:00:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:00:03 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-FiqVeO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:00:03 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)) 03:00:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:00:03 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-dHuKE0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:00:03 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)) 03:00:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:00:03 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-ZRBbMJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:00:03 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)) 03:00:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:00:03 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-_geY57-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:00:03 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)) 03:00:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:00:03 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-ABwMTB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:00:04 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)) 03:00:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:00:04 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-qMLfcZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:00:04 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)) 03:00:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:00:04 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-HN0zHh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:00:04 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)) 03:00:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:00:04 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-ITdUvN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:00:04 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)) 03:00:04 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)) 03:00:04 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)) 03:00:04 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)) 03:00:04 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)) 03:00:04 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)) 03:00:04 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:00: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 03:00: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 03:00: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 03:00: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 03:00: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 03:00: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 03:00:06 INFO - Downloading blessings-1.6.tar.gz 03:00:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:00:06 INFO - Installing collected packages: blessings 03:00:06 INFO - Running setup.py install for blessings 03:00:06 INFO - Successfully installed blessings 03:00:06 INFO - Cleaning up... 03:00:07 INFO - Return code: 0 03:00:07 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:00:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:00:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:00:07 INFO - Reading from file tmpfile_stdout 03:00:07 INFO - Current package versions: 03:00:07 INFO - blessings == 1.6 03:00:07 INFO - blobuploader == 1.2.4 03:00:07 INFO - docopt == 0.6.1 03:00:07 INFO - manifestparser == 1.1 03:00:07 INFO - mozInstall == 1.12 03:00:07 INFO - mozcrash == 0.17 03:00:07 INFO - mozdebug == 0.1 03:00:07 INFO - mozdevice == 0.48 03:00:07 INFO - mozfile == 1.2 03:00:07 INFO - mozhttpd == 0.7 03:00:07 INFO - mozinfo == 0.9 03:00:07 INFO - mozleak == 0.1 03:00:07 INFO - mozlog == 3.1 03:00:07 INFO - moznetwork == 0.27 03:00:07 INFO - mozprocess == 0.22 03:00:07 INFO - mozprofile == 0.28 03:00:07 INFO - mozrunner == 6.11 03:00:07 INFO - mozscreenshot == 0.1 03:00:07 INFO - mozsystemmonitor == 0.0 03:00:07 INFO - moztest == 0.7 03:00:07 INFO - mozversion == 1.4 03:00:07 INFO - psutil == 3.1.1 03:00:07 INFO - requests == 1.2.3 03:00:07 INFO - wsgiref == 0.1.2 03:00:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:00: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')]} 03:00:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:00:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:00: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')]} 03:00:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:00:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:00:07 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 0x106534a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10653b4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f803a493540>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1063d8d30>, '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 0x10623cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1063cfb20>, '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.RADXpxaORO/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.VUVFzidAel/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/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 03:00:07 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 03:00:07 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 03:00:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RADXpxaORO/Render', 03:00:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:00:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:00:07 INFO - 'HOME': '/Users/cltbld', 03:00:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:00:07 INFO - 'LOGNAME': 'cltbld', 03:00:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:00:07 INFO - 'MOZ_NO_REMOTE': '1', 03:00:07 INFO - 'NO_EM_RESTART': '1', 03:00:07 INFO - 'PAGER': '/bin/cat', 03:00:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:00:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:00:07 INFO - 'PWD': '/builds/slave/test', 03:00:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:00:07 INFO - 'SHELL': '/bin/bash', 03:00:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VUVFzidAel/Listeners', 03:00:07 INFO - 'TMPDIR': '/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/', 03:00:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:00:07 INFO - 'USER': 'cltbld', 03:00:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:00:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:00:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:00:07 INFO - 'XPC_FLAGS': '0x0', 03:00:07 INFO - 'XPC_SERVICE_NAME': '0', 03:00:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:00:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:00:07 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)) 03:00:07 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)) 03:00:07 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)) 03:00:07 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)) 03:00:07 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)) 03:00:07 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)) 03:00:07 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)) 03:00:07 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)) 03:00:07 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)) 03:00:07 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)) 03:00:07 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)) 03:00:07 INFO - Cleaning up... 03:00:07 INFO - Return code: 0 03:00:07 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:00: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')]} 03:00:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:00:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:00: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')]} 03:00:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:00:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:00:07 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 0x106534a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10653b4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f803a493540>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1063d8d30>, '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 0x10623cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1063cfb20>, '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.RADXpxaORO/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.VUVFzidAel/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/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 03:00:07 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 03:00:07 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 03:00:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RADXpxaORO/Render', 03:00:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:00:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:00:07 INFO - 'HOME': '/Users/cltbld', 03:00:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:00:07 INFO - 'LOGNAME': 'cltbld', 03:00:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:00:07 INFO - 'MOZ_NO_REMOTE': '1', 03:00:07 INFO - 'NO_EM_RESTART': '1', 03:00:07 INFO - 'PAGER': '/bin/cat', 03:00:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:00:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:00:07 INFO - 'PWD': '/builds/slave/test', 03:00:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:00:07 INFO - 'SHELL': '/bin/bash', 03:00:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VUVFzidAel/Listeners', 03:00:07 INFO - 'TMPDIR': '/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/', 03:00:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:00:07 INFO - 'USER': 'cltbld', 03:00:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:00:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:00:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:00:07 INFO - 'XPC_FLAGS': '0x0', 03:00:07 INFO - 'XPC_SERVICE_NAME': '0', 03:00:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:00:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:00:07 INFO - Downloading/unpacking jsonschema 03:00: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 03:00: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 03:00: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 03:00: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 03:00: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 03:00: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 03:00:10 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:00:10 INFO - Downloading/unpacking functools32 (from jsonschema) 03:00:10 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 03:00:10 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 03:00:10 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 03:00:10 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 03:00:10 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 03:00:10 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 03:00:10 INFO - Downloading functools32-3.2.3-2.tar.gz 03:00:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:00:10 INFO - warning: no files found matching '*.txt' 03:00:10 INFO - no previously-included directories found matching 'build' 03:00:10 INFO - no previously-included directories found matching 'dist' 03:00:10 INFO - no previously-included directories found matching '.git*' 03:00:10 INFO - Installing collected packages: jsonschema, functools32 03:00:10 INFO - Running setup.py install for functools32 03:00:10 INFO - warning: no files found matching '*.txt' 03:00:10 INFO - no previously-included directories found matching 'build' 03:00:10 INFO - no previously-included directories found matching 'dist' 03:00:10 INFO - no previously-included directories found matching '.git*' 03:00:10 INFO - Successfully installed jsonschema functools32 03:00:10 INFO - Cleaning up... 03:00:11 INFO - Return code: 0 03:00:11 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 03:00:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 03:00:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:00:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:00:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 03:00:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:00:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:00:11 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 0x106534a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10653b4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f803a493540>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1063d8d30>, '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 0x10623cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1063cfb20>, '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.RADXpxaORO/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.VUVFzidAel/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/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 03:00:11 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 03:00:11 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 03:00:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RADXpxaORO/Render', 03:00:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:00:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:00:11 INFO - 'HOME': '/Users/cltbld', 03:00:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:00:11 INFO - 'LOGNAME': 'cltbld', 03:00:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:00:11 INFO - 'MOZ_NO_REMOTE': '1', 03:00:11 INFO - 'NO_EM_RESTART': '1', 03:00:11 INFO - 'PAGER': '/bin/cat', 03:00:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:00:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:00:11 INFO - 'PWD': '/builds/slave/test', 03:00:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:00:11 INFO - 'SHELL': '/bin/bash', 03:00:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VUVFzidAel/Listeners', 03:00:11 INFO - 'TMPDIR': '/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/', 03:00:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:00:11 INFO - 'USER': 'cltbld', 03:00:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:00:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:00:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:00:11 INFO - 'XPC_FLAGS': '0x0', 03:00:11 INFO - 'XPC_SERVICE_NAME': '0', 03:00:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:00:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:00:11 INFO - Downloading/unpacking flake8 03:00: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 03:00: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 03:00: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 03:00: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 03:00: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 03:00: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 03:00:13 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 03:00:13 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 03:00:13 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 03:00:13 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 03:00:13 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 03:00:13 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 03:00:13 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 03:00:13 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 03:00:13 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 03:00:13 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 03:00:13 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 03:00:13 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 03:00:13 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 03:00:13 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 03:00:13 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 03:00:13 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 03:00:14 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 03:00:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:00:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:00:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:00:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:00:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:00:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:00:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 03:00:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:00:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:00:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:00:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:00:14 INFO - no previously-included directories found matching 'docs/_build' 03:00:14 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 03:00:14 INFO - Running setup.py install for pep8 03:00:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:00:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:00:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:00:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:00:15 INFO - no previously-included directories found matching 'docs/_build' 03:00:15 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 03:00:15 INFO - Successfully installed flake8 mccabe pyflakes pep8 03:00:15 INFO - Cleaning up... 03:00:15 INFO - Return code: 0 03:00:15 INFO - Running post-action listener: _resource_record_post_action 03:00:15 INFO - Running post-action listener: _start_resource_monitoring 03:00:15 INFO - Starting resource monitoring. 03:00:15 INFO - ##### 03:00:15 INFO - ##### Running install step. 03:00:15 INFO - ##### 03:00:15 INFO - Running pre-action listener: _resource_record_pre_action 03:00:15 INFO - Running main action method: install 03:00:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:00:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:00:15 INFO - Reading from file tmpfile_stdout 03:00:15 INFO - Detecting whether we're running mozinstall >=1.0... 03:00:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:00:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:00:15 INFO - Reading from file tmpfile_stdout 03:00:15 INFO - Output received: 03:00:15 INFO - Usage: mozinstall [options] installer 03:00:15 INFO - Options: 03:00:15 INFO - -h, --help show this help message and exit 03:00:15 INFO - -d DEST, --destination=DEST 03:00:15 INFO - Directory to install application into. [default: 03:00:15 INFO - "/builds/slave/test"] 03:00:15 INFO - --app=APP Application being installed. [default: firefox] 03:00:15 INFO - mkdir: /builds/slave/test/build/application 03:00:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 03:00:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 03:00:47 INFO - Reading from file tmpfile_stdout 03:00:47 INFO - Output received: 03:00:47 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 03:00:47 INFO - Running post-action listener: _resource_record_post_action 03:00:47 INFO - ##### 03:00:47 INFO - ##### Running run-tests step. 03:00:47 INFO - ##### 03:00:47 INFO - Running pre-action listener: _resource_record_pre_action 03:00:47 INFO - Running main action method: run_tests 03:00:47 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:00:47 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:00:47 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:00:47 INFO - 2016-04-21 03:00:47.403 screenresolution[1648:8361] starting screenresolution argv=screenresolution get 03:00:47 INFO - 2016-04-21 03:00:47.406 screenresolution[1648:8361] Display 0: 1600x1200x32@60 03:00:47 INFO - 2016-04-21 03:00:47.413 screenresolution[1649:8363] starting screenresolution argv=screenresolution list 03:00:47 INFO - Available Modes on Display 0 03:00:47 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:00:47 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:00:47 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:00:47 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:00:47 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:00:47 INFO - Intel Iris: 03:00:47 INFO - Chipset Model: Intel Iris 03:00:47 INFO - Type: GPU 03:00:47 INFO - Bus: Built-In 03:00:47 INFO - VRAM (Dynamic, Max): 1536 MB 03:00:47 INFO - Vendor: Intel (0x8086) 03:00:47 INFO - Device ID: 0x0a2e 03:00:47 INFO - Revision ID: 0x0009 03:00:47 INFO - Displays: 03:00:47 INFO - Display: 03:00:47 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:00:47 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:00:47 INFO - Display Serial Number: 1600x1200 60 03:00:47 INFO - Main Display: Yes 03:00:47 INFO - Mirror: Off 03:00:47 INFO - Online: Yes 03:00:47 INFO - Rotation: Supported 03:00:47 INFO - Return code: 0 03:00:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:00:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:00:47 INFO - Python 2.7.3 03:00:47 INFO - Return code: 0 03:00:47 INFO - grabbing minidump binary from tooltool 03:00: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')]} 03:00: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 0x1063d8d30>, '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 0x10623cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1063cfb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:00: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 03:00: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 03:00:47 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:00:47 INFO - Return code: 0 03:00:47 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 03:00:47 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:00:47 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:00:47 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 03:00:47 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:00:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 03:00:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 03:00:48 INFO - Return code: 0 03:00:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/QYA9JMn0QByLdkawb6hf5w/artifacts/public/build/firefox-47.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0036', '--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 03:00:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/QYA9JMn0QByLdkawb6hf5w/artifacts/public/build/firefox-47.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0036 --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 03:00:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RADXpxaORO/Render', 03:00:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:00:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:00:48 INFO - 'HOME': '/Users/cltbld', 03:00:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:00:48 INFO - 'LOGNAME': 'cltbld', 03:00:48 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:00:48 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 03:00:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:00:48 INFO - 'MOZ_NO_REMOTE': '1', 03:00:48 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:00:48 INFO - 'NO_EM_RESTART': '1', 03:00:48 INFO - 'PAGER': '/bin/cat', 03:00:48 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:00:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:00:48 INFO - 'PWD': '/builds/slave/test', 03:00:48 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:00:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:00:48 INFO - 'SHELL': '/bin/bash', 03:00:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VUVFzidAel/Listeners', 03:00:48 INFO - 'TMPDIR': '/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/', 03:00:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:00:48 INFO - 'USER': 'cltbld', 03:00:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:00:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:00:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:00:48 INFO - 'XPC_FLAGS': '0x0', 03:00:48 INFO - 'XPC_SERVICE_NAME': '0', 03:00:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:00:48 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/QYA9JMn0QByLdkawb6hf5w/artifacts/public/build/firefox-47.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0036', '--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 03:00:49 INFO - mozversion application_buildid: 20160421004015 03:00:49 INFO - mozversion application_changeset: d9fdbad8f079c7801abdef70df2cad93efcce797 03:00:49 INFO - mozversion application_display_name: FirefoxDeveloperEdition 03:00:49 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:00:49 INFO - mozversion application_name: Firefox 03:00:49 INFO - mozversion application_remotingname: firefox-dev 03:00:49 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:00:49 INFO - mozversion application_vendor: Mozilla 03:00:49 INFO - mozversion application_version: 47.0a2 03:00:49 INFO - mozversion platform_buildid: 20160421004015 03:00:49 INFO - mozversion platform_changeset: d9fdbad8f079c7801abdef70df2cad93efcce797 03:00:49 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:00:49 INFO - mozversion platform_version: 47.0a2 03:00:49 INFO - using testdate: 1461232849 03:00:49 INFO - actual date: 1461232849 03:00:49 INFO - starting webserver on 'localhost:49270' 03:00:49 INFO - SUITE-START | Running 2 tests 03:00:49 INFO - TEST-START | dromaeo_css 03:00:49 INFO - operating with platform_type : mac_ 03:00:49 INFO - Initialising browser for dromaeo_css test... 03:00:49 INFO - TEST-INFO | started process 1667 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/tmpowItdT/profile http://localhost:49270/getInfo.html) 03:00:52 INFO - PROCESS | 1667 | __metrics Screen width/height:1600/1200 03:00:52 INFO - PROCESS | 1667 | colorDepth:24 03:00:52 INFO - PROCESS | 1667 | Browser inner width/height: 1024/689 03:00:52 INFO - PROCESS | 1667 | __metrics 03:00:52 ERROR - PROCESS | 1667 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 03:00:52 INFO - TEST-INFO | 1667: exit 0 03:00:52 INFO - Browser initialized. 03:00:52 INFO - Running cycle 1/1 for dromaeo_css test... 03:00:52 INFO - TEST-INFO | started process 1671 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/tmpowItdT/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:01:04 INFO - PROCESS | 1671 | RSS: Main: 217702400 03:01:04 INFO - PROCESS | 1671 | 03:01:54 INFO - PROCESS | 1671 | 1461232914413 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] 03:04:05 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49270/tests/dromaeo/cssquery-ext.html) 03:04:06 INFO - PROCESS | 1671 | RSS: Main: 230289408 03:04:06 INFO - PROCESS | 1671 | 03:07:08 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-ext.html (next: http://localhost:49270/tests/dromaeo/cssquery-jquery.html) 03:07:09 INFO - PROCESS | 1671 | RSS: Main: 240508928 03:07:09 INFO - PROCESS | 1671 | 03:10:10 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49270/tests/dromaeo/cssquery-mootools.html) 03:10:11 INFO - PROCESS | 1671 | RSS: Main: 242466816 03:10:11 INFO - PROCESS | 1671 | 03:13:13 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49270/tests/dromaeo/cssquery-prototype.html) 03:13:13 INFO - PROCESS | 1671 | RSS: Main: 244658176 03:13:13 INFO - PROCESS | 1671 | 03:16:16 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49270/tests/dromaeo/cssquery-yui.html) 03:16:17 INFO - PROCESS | 1671 | RSS: Main: 247746560 03:16:17 INFO - PROCESS | 1671 | 03:19:19 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-yui.html (next: http://localhost:49270/tests/dromaeo/cssquery-dojo.html) 03:19:19 INFO - PROCESS | 1671 | RSS: Main: 248528896 03:19:19 INFO - PROCESS | 1671 | 03:19:19 INFO - PROCESS | 1671 | __start_tp_report 03:19:19 INFO - PROCESS | 1671 | _x_x_mozilla_page_load 03:19:19 INFO - PROCESS | 1671 | _x_x_mozilla_page_load_details 03:19:19 INFO - PROCESS | 1671 | |i|pagename|runs| 03:19:19 INFO - PROCESS | 1671 | |0;dojo.html;2952.940941181176;3263.9836800815992;3413.9317213655713;3519.3665140274748;3569;5601.215829783833;5611.9438805611935;5633.943660563393;5636.605437619358;5665.971670141644;4846.836759177799;5544.6118771686;5620.522255608278;5630.634008789436;5647.604667673254;5091.981603679251;5130.538251557359;5151.845444636649;5177.119889618755;5240.711760853171;4653.208954477747;4845.781939812699;5154.8711282218055;5198.414483582505;5199.558037566811;5093.668911520739;5160.819371322004;5164.173732202848;5165.9225111623355;5166.095933211692;5170.6122040847085;5177.689338639656;5216.087184742655;5219.5041471060185;5230.320058392384;4287.678424118172;5037.395512538482;5141.305923700327;5174.560162386202;5205.635605507616;5478.616496845222;5504.669719816784;5532;5564.582656300794;5695.34503532095;6117.694115294217;6153.200083989098;6182.258129024501;6189.628622282632;6209.348018458088;6178.69106544671;6196;6205.100260462208;6240.438360547527;6244.4067813558095;4716.575508204278;5668.546516278688;5758.7696492140685;5767.826965191051;5797.971010144923;6196.406899707571;6225.066240064027;6232.968835155795;6235.038356780493;6263.843403914848;6115.6330620162935;6116.694165291718;6120.418560236771;6122.836661034389;6129.754809807647;6092.939070609325;6111.774065234738;6162.26052873658;6163.106349579286;6237.500999919996;6074.42292982166;6117.663528505975;6130.785422510191;6151.077338399186;6204.441600255908;6047;6131.877362452815;6218.160548326008;6221.875562488815;6239.937600623935;4827.468978412372;4883.4139903211135;4889.193283108319;4900.926486102711;4930.654854160174;4384.4519435070615;4388.517263101056;4398.142362239332;4405.7797110144365;4420.071784925201;5613.382527921925;5689.317281926113;5693.5160511357;5738.368779434259;5754.136879468113;6073.635581865102;6109.283207920342;6160.353162917829;6191.659458729723;6210.31686514483;5741.052726300197;5741.971290143606;5758.74085666146;5762.4525670061275;5778.682172480554;5246;5341.439148889388;5385.676859388449;5394.163904594794;5401.108817045222;6205.193324867739;6265.467435267871;6280.05799130125;6307.306196318493;6321.620702757666;6195.473384762346;6208.286047104641;6214.72033758491;6237.438630523275;6241.78153764616;6129.693515324305;6208.565400421927;6304.432601065926;6330.778422755181;6338.524610654127;6114.052321890114;6130.233720784902;6150.446459818638;6154.3845615438095;6157.599756015845;6154.415330543591;6154.569180157346;6168.383161683796;6170.784022559189;6187.319394866651;5887.735051922588;6054.273487181566;6064.04984423676;6089.086637004485;6113.938860611337;4985.700857948535;5139.97200559882;5675.148727690715;6093.542984276109;6119.8776024478375;5902.055671092605;5929.644221346733;5951.583389162717;5957.791477298274;5962.970185149046;5665.773369065356;5945.10823376497;6024.849378765566;6092.360302168208;6115.969420152871;5919.91120133207;5968.552358573038;5994.790182343597;6001.099835024606;6001.36985616504 03:19:19 INFO - PROCESS | 1671 | |1;ext.html;485.5096352683788;492.6059152677857;574.95932362424;596.9373215812341;613.9899864722531;30172.54741178881;39056.60943390569;39079.609203907916;39085.60914390855;39271.214575708465;40563.59436405635;41013.17973640533;41153;41220.58779412205;41259.349626014926;9489.003654616286;9631.422114673107;9667.226621870268;9670.129688328048;9680;9400.294977876652;9613.279004074688;9613.567389467491;9626.518674066303;9672.613095476172;9603.18372938301;9605.855912161323;9675.032496750304;9687.273454490905;9688.079632434907;9573.569189386495;9622.422654640744;9635.18100961419;9639.228861691048;9649.517524123767;9660.130588247092;9762.316637835354;9804.117629413387;9820.607175712963;9825.263105267062;39445.80277098596;39573;39825.80087099575;39873.60126398728;39909;2737.397772490049;3210.82340471274;3360.781549199294;3480.7215422766117;3974.324364857981;26935.787889544823;27432.588511172147;27657.585136222773;27690.030848920393;27766.722332776615;2753.6420265365573;2771.3764403009163;2803.747662710366;2803.971960280412;2818;432602;438735;439893;440326;442204;66972.33027669661;68040.31959680439;68631.31368686249;68703;68712.3128768716;84126;84241.57879210687;85284.14715852762;85695.57152214323;85823;18669.159887805083;18879.81120188808;18887.150078246512;18930.337438189596;18935.147918343708;14233.78649320261;14239.003269771016;14318;14322.14067155974;14332.49836255726;23069.077236910336;23194.84025798737;23433;23519.647205291592;23586;8972.327075469366;9180.31147663928;9207.76980575491;9211.63153473867;9219.354645174908;989.1888651306004;1085.7719878825378;1163.6392718257368;1188.6968822950093;1250.3435696259355;30438;30499.08502744921;30594.38811223763;30880.53679194814;31059.068227953197;1080.956761729522;1084.8969347911936;1101.3281898042187;1143.2683082826998;1249.5126900508808;12785.424655890507;15170.620734481727;15191.848081519265;15872.285747141406;15914.204289785464;536594.3170284202;536724;539165;544027;546321;61108.33349999014;62167.689161553906;62425.06362404567;62597.37402626006;62757.68621156865;1305.1973036582433;1460.9342579583945;1477.1137317609348;1498.2134379450877;1502.6919481506266;29800.701992979793;30029.69970300269;30156.547651784804;30476.39047218999;30548.541771873883;53432;56814.715926420104;57225.14162287652;57411.425885742276;57622;379788;381448;384738;387046;387618;44813;45161.77419112883;46489;46614.06771864476;46706.53293467158;44484.555154449336;48295.551133466055;50006.74996624994;50066.24900626421;51741.7412912933;40314.59685403226;41357;41727.165456691306;42287.36568951407;42312.36531451969;41188.1762364757;41232.79383603183;41249.98129218713;41450.37824432696;42030;38501.6149838498;38958.80520597379;40914;41290.967725807095;42305.365419518115;24755.62866556967;34109.315778974466;36018.4597231047;36338.4549231767;36482.8175859119;26848.59727104056;27144;27205.91176352924;27222.72777272202;27361.042363517183 03:19:19 INFO - PROCESS | 1671 | |2;jquery.html;384.2430412088185;384.9884503464895;392.458407397791;392.8546437818007;398.51580329899167;19513.414597562078;21211.045502952365;22056.448588785268;22087.66868496974;22116.33650990469;19427.931463769488;19669.60660786787;21079.367618971417;21117;21406.464838379048;5615.2700148980575;5931.406859314077;6128.754849806002;6203.2245969253845;6204.720787564571;5794.565407594426;5802.796902108427;5818.44724751148;5842.094475356326;5852.502537284315;5760.4815566599;5838.562107841907;6029.216201893748;6081.148639190517;6095.05526643371;6000.639961602296;6020.307664618537;6043.335233124375;6063.6361818290825;6073.969630151821;5664.0937450007805;5698;5771.855703607402;5836.241288632493;5856.238688970449;12875.484980600859;13297.53458628953;13500.459981600725;13838.169709817343;13841.515546955809;2075.937721868346;2113.5984163009134;2529.152733834168;2566.7561581649716;2883.3224192314788;8711.695090671796;9664.275179361506;10298.9485052575;11535.019523340443;14332;1372.9588112356646;1703.9233234504354;1711.5635512944243;1741.2773698914934;1744.145368769294;78234.6088269555;79176.60411697962;100264;100264.49867750614;102430;11332.376719280519;11451;11486.540538378538;11562.364069976064;11671.299722016705;13061.412236449383;13090.869091309156;14236.145831250158;14281.000329976801;14295.142291462338;8792.34057445694;8944.86582701247;8964.969028561669;9071.546422678839;9108.49903255314;9129.634814607341;9169.449833009907;9175.174234318943;9178.082191780768;9264.675736349196;3753.3431649461236;4551.817927282872;4592.357070010201;4609.631229501699;4624.930626040612;1848.6672398968315;1939.2533874458436;1950.9612454984576;1951.7462729845029;2024.1459542045939;817.9304759095425;881.2553392383426;894.1996912763041;963.1909196275162;1001.6327712672296;19824.90087549553;20286.391408257776;20505.48736281605;20861.68707469389;20894.37316880496;911.193593669594;916.9128932751378;920.6915683246053;1006.2151521812998;1062.192733522513;9156;11171.664850054349;11258.493367798468;11275.943620281847;11279.154063445274;474459;512148;520903;621524;653051;120135.39932300457;120555.39722301332;123113.38443307726;127111.45777084406;131948.68051319363;1013.7516308504464;1051.7686109055996;1080.8378743188428;1086.21792309537;1086.9293495922739;11192.944035279772;11339.773204535699;11640.94179529097;18458.538536536693;18635.06824658789;49354;50102;51651.48348516467;51995.74002129965;52552.47447525629;74194.25805741873;76711.23288767264;77454;78764.21235787569;86662;11914.40427978615;12333.075019373404;12346.197497162655;12431.129820912449;12578.748425031632;12739.044571656977;12911.5480958166;13483.595492135251;14118.647033824236;14346.928265358607;11820.113491488;11914.285142891455;11922.821157682814;12110.031197504355;12152.331621760888;10289.125424339016;11897.988670962719;11913.821292680443;11918.880811191777;12024.278543287432;8304.83390332202;8320.677803532852;8451.1548845115;12084.335361555199;12386.380680966096;11456.739758626378;11799.17405781587;12414.62756117318;12510.124291299522;12700.682482938;11181.72045698864;11938.58214962472;12247.387630618256;12269.325187114437;12371.566995155126 03:19:19 INFO - PROCESS | 1671 | |3;mootools.html;1664.2843577261776;1689.7127488326987;2037.7962203779623;2060.484878780305;2070.6997485364614;8196.91803081969;8817.250533704642;9001.009888912222;9192.90807091928;9213.815723685531;8958.46249225047;8973;8989.59546820393;9077.228435582983;9102.635894564226;2065.0500769645982;2233.2630232023394;2388.319328991238;2494.1270555305587;2509.6988361396657;2333.4166458385403;2467.3214865911837;2570.974290257092;2581.380468687511;2592.5074235895213;2523.49530093981;2564.192279431982;2565.397131674055;2566.897324107043;2577.5618144915315;2516.848989060653;2525.8231923765343;2540.733223011585;2574.4979728952862;2583.8578878161693;2027.2701827342146;2246.3261021693424;2456.914008009729;2506.987465062663;2555.1440267510407;9065.818683626356;9129.863052054225;9133.771655708593;9153.221976132038;9167.358284920057;5506.559475241971;5590.937721832839;5597.384287728347;5597.748101335409;5673.971630141864;3625.5830579483168;3701.796401197933;3729.813509324523;3746.19456816783;3796.7152463565067;1055.3931489393553;1071.6344911227286;1078.5793540519203;1078.9352638841694;1083.0523292119397;12201.45093470796;12290.631281061582;12360.072994525357;12371.75256494865;12381.504739810396;4908.828191013369;4978.5270399312;5042.168042272984;5081.364829396325;5091.465396133427;10419.166466682798;10485.9475702621;10547.789044219226;10558.52486638103;10577.153827693766;5539.750711217925;5655.604107712421;5673.687947162945;5684.602077854511;5751.281089863767;4568.680192386501;4943.653944223942;4990.750462476862;5027.572656324253;5151.330327057459;4086.591340865949;4135.1316223592785;4136.544980052192;4141.834326626961;4147.854825081107;1365.7336819320335;1380.3167432121165;1385.736710025092;1389.9513517027058;1391.0540832233976;1402.8877689784792;1422.8434872164053;1428.8785453236383;1445.7975883376337;1461.2036440139937;8405.075441701409;8453.281471074904;8455.577221138918;8475.70335038283;8484.448510846774;516.0813751522296;520.3105884702709;521.8512723873678;525.876419041525;529.9735013249399;5843.620164689281;6036.486898613579;6237.438630523184;6388.552801303864;6401.743930242831;10969.067629251604;11198;11329.09367250618;11340.659780206606;11387.032102271234;10561.313514621525;11010.449477526252;11030.393328367018;11103.888961110286;11184.384858832842;8668.176523230282;8718.912810871938;8734.95632521846;8754.037055923844;8785.989611194667;6683.7660681875905;8060;8184.304334131665;8326.209010144026;8340.374471914509;9534.95232523833;9818.85271720939;9842.458664773507;9854.507274636097;9863.852042219229;9974.900250997687;10157.542910568895;10195.23535734808;10204.642837500653;10255.282130250811;6337.366263373626;7473.43949203801;7708.383329333527;7749.302562769378;7760.223977602194;8426.789330266793;8468.788280292796;8497.235248827388;8525.232729054414;8528.616212270586;7360.300771426706;7596;7598.354139898171;7616.9238307616215;7641.197674244125;7306.561606303639;7395.630218489162;7429;7511.3615342696485;7563.205863384485;7963.362930965393;8028.237317454832;8061.435699500978;8080.232377924088;8099.987501562305;7218.386437152901;7260.165081015751;7266.83730603101;7323.231060738759;7333.926660733325;7353.742619008309;7373.33639972405;7396.852062958603;7431.554106753612;7442 03:19:19 INFO - PROCESS | 1671 | |4;prototype.html;344.2495360114949;346.3436787288089;349.55780937114537;353.2405328543631;357.1660173494891;6936.965315173417;6967;6971.930280697192;6974.442044636429;6994.755183568583;6845.520813543054;6852.2462529121885;6908.20555636102;6953.5827850329015;6991.685374158163;4796.880077998043;4953.678010929278;5052.0906236877345;5057.41839688435;5111.003354345913;4757.977034937488;5013.097642424362;5047.949520504784;5059.11465493539;5068.960863023071;4372.628326592244;4979.30289759434;4993.925091123636;5006.374203224597;5013.273075404064;5018.548330650223;5019.523145301208;5050.318207042076;5056.949430505703;5058.494150584912;4341.871113510479;4400.1419723153995;4401.163778882003;4405.03089320349;4415.381846541487;5383.865403364947;6430.3891130342545;6648.700808463631;6671.966640166816;6727.831804204885;6001.399860013964;6006.159137720722;6031.698415079229;6049.788257411014;6055.576109672281;7516.549007059594;7531.284527969834;7548.320651141369;7553.357964573018;7573.242675732437;4427.579379958899;4686.922007938193;4982.57648099912;4985.202367621199;4994.675346102492;6364.586301890408;7116.786496405116;7846.136924938252;7902;7916.485428447132;4906.8773280668265;4918.11473934688;5010.3737032870895;5026.698398096126;5029.245613157982;4588.449386073693;4802.855914322576;5130.153524668388;5186.870328241824;5194.298769666047;6005.969970150121;6026.156338112668;6043.123747056652;6044.093385992049;6061.333253342129;5760.855978600484;6093.268807743099;6501.47988160946;7190.928090719026;7519.248075192437;1687.485316978309;1745.3716662001668;1746.2665680414257;1763.1096296370508;1782.3494424534952;950.9476978766235;1147.9024282936043;1164.132721122752;1169.6783384569312;1170.2744298534963;6811.897821532681;6815.045893574904;6829.624370659562;6840.6921688524135;6854.897176542356;7672.961635191788;7680.577568233801;7684.692612295557;7685.76942691709;7696.846063078707;5564.610477266552;6824.454043676494;6845.349691779273;6851.417629501449;6869.416099631588;3751.437284407306;4062.695297852673;4065.9796701016307;4076.8369265229057;4092.5907409258834;7935.365170786324;8043.758687239392;8059.798505037304;8073.354131669453;8116.228958248957;7999.440039197317;8030.116687164407;8092;8127.512349259064;8144.714934977247;8169.101398846241;8169.142240064826;8183.345332373396;8188;8208.671653134046;5702.7718891243885;6947.062146610143;7474.122462851732;7782.649780759993;7806.57063861493;7586.317231449196;7638.236176382317;7663.348615367756;7666.156722760604;7672;6497.772577959749;8136.918630813616;8149.633266502903;8151.30713889326;8162.469439486652;4422.3808666786035;4863.148948933852;5066.08810414129;5073.467285935071;5096.955124199604;7445.181030086795;7772.067351917806;7774.6890124394395;7789.337906277803;7809.2190780921455;6448.25845027809;7114.181869085121;7495.950566920745;7498.400127989638;7504.212057733859;7473.813154671177;7483.139438964588;7483.476156668981;7495.17553069151;7525.962370188114;6381.202349706286;7321.121465424183;7323.6338183089565;7340.229275925951;7342.70629174827;6863.862722745417;7460.29127232912;7520.8495830082;7521.135069466863;7545.7358992435;7330.706771729071;7344.11870575513;7358.080239970004;7361.963190184015;7372.189059203591 03:19:19 INFO - PROCESS | 1671 | |5;yui.html;605.4883623338279;606.5966132521874;634.9047642853573;636.7389370358154;674.177503445796;12488.687782805435;12530.248185108889;12943.870561294385;14977.251137443138;15226.847731522681;12834.935825320883;14242.145471271731;14250.2162381069;14258.429662813474;14267.50063747769;918.4443411735887;948.4404201521102;959.0505399654362;976.5019839881676;980.1423754215061;802.6548584108831;983.3018556824663;984.4929861121528;985.3152059318776;990.0990099009903;859.5358506406533;979.8089372572351;983.6065573770513;1011.9291649584532;1022.5296363672719;966.6809952715622;990.479998001048;990.8612794208816;995.4922989275449;1006.2704539209088;759.6999185321766;761.0486891385768;765.4450523370567;773.7717373374868;779.4426984705906;15925.124118173495;16122.274497647517;16131.193440328054;16226.269817858225;16273.755893661486;12891.290978996152;12956.611301660965;13043.739125217442;13076.738465230643;13108.803367949393;10136.087752102272;10366.533505992249;10366.792664146751;10368.170546356348;10636;3468.231063070931;3508.561429821272;3510.929781404383;3555.6266592007723;3592.2276710507367;83386.58306708488;84003;84348.3130337396;85938;86286.13713862844;8844.823103537894;9027.954860225656;9031.27749780016;9043.728688139367;9268.582913768896;21846.672299915197;22097.66853497199;22130.114795408004;22138.557228855334;22147.224847130274;6332.588381755171;7310.597917114504;7351.595662238521;7411.332980031823;7616.7334143305825;4083.89790255246;4103.692223083221;4159.292920203573;4187.644050255702;4205.411242426063;3603.081214290339;3606.1886075632774;3660.524131862841;3664.0656632558525;3669.559652841676;635.2504045226584;637.0603360043898;643.2441880790053;648.7859006527834;668.9966550167316;539.7867842202387;548.8572971027562;566.9914951275734;587.1251834766254;609.9634021958608;7061.364477196974;8421.873671894926;8446.450980686235;8512.106228846005;8514.191151840565;524.5934400839303;549.7251374312843;615.4092071611303;619.0868469008177;630.4168644004369;2997.8800847965836;3691.944982392203;3809.733318667722;3828.272628200633;3837.884863454101;76902;97153.0284697158;97189.5140524307;97615;99212;70848.2915170852;84111.5794421024;84898.5755071233;87156.56421717851;87311.56344218238;73464.63267683628;73881.6305918467;74414.6279268611;74786;75428.62285688537;8562.357823163164;8688.478691278291;8815.338849586178;8828.161324674145;8985.730428087169;48436.5156348432;49349.506504935925;51892;52645.7367713159;53598.73200634128;71308;74403.62798185974;74510.88233676608;74808.62595687204;74831.2516874846;11024.669259922215;11292.717682057686;11293.604723834625;11465.828012579652;11555.2489088209;12142.514299427923;12562.246265224116;12595.622131336075;12596.622101336974;12608.36958152107;10967.835482467928;11096.389698566334;11253.88746112561;11486.597969071043;11520.88479115198;11694.532218711156;11807;11819.704507387383;11852.881471185523;11958.940205298917;11359.716007099558;11391.943040284745;11947.044236460888;11962.04303655688;11991.76016479683;9309.394889332172;9362.110599493037;9397.906020939703;9526.809463810547;9712.223022158352;9608.95195524018;9790.75523111928;9812.85280720804;9854.901450985399;9870.605175793175 03:19:19 INFO - PROCESS | 1671 | __end_tp_report 03:19:19 INFO - PROCESS | 1671 | __start_cc_report 03:19:19 INFO - PROCESS | 1671 | _x_x_mozilla_cycle_collect,369 03:19:19 INFO - PROCESS | 1671 | __end_cc_report 03:19:19 INFO - PROCESS | 1671 | __startTimestamp1461233959600__endTimestamp 03:19:19 INFO - PROCESS | 1671 | 03:19:19 INFO - PROCESS | 1671 | ------- Summary: start ------- 03:19:19 INFO - PROCESS | 1671 | Number of tests: 6 03:19:19 INFO - PROCESS | 1671 | 03:19:19 INFO - PROCESS | 1671 | [#0] dojo.html Cycles:165 Average:5668.38 Median:5929.64 stddev:657.17 (11.1%) stddev-sans-first:623.71 03:19:19 INFO - PROCESS | 1671 | Values: 2952.9 3264.0 3413.9 3519.4 3569.0 5601.2 5611.9 5633.9 5636.6 5666.0 4846.8 5544.6 5620.5 5630.6 5647.6 5092.0 5130.5 5151.8 5177.1 5240.7 4653.2 4845.8 5154.9 5198.4 5199.6 5093.7 5160.8 5164.2 5165.9 5166.1 5170.6 5177.7 5216.1 5219.5 5230.3 4287.7 5037.4 5141.3 5174.6 5205.6 5478.6 5504.7 5532.0 5564.6 5695.3 6117.7 6153.2 6182.3 6189.6 6209.3 6178.7 6196.0 6205.1 6240.4 6244.4 4716.6 5668.5 5758.8 5767.8 5798.0 6196.4 6225.1 6233.0 6235.0 6263.8 6115.6 6116.7 6120.4 6122.8 6129.8 6092.9 6111.8 6162.3 6163.1 6237.5 6074.4 6117.7 6130.8 6151.1 6204.4 6047.0 6131.9 6218.2 6221.9 6239.9 4827.5 4883.4 4889.2 4900.9 4930.7 4384.5 4388.5 4398.1 4405.8 4420.1 5613.4 5689.3 5693.5 5738.4 5754.1 6073.6 6109.3 6160.4 6191.7 6210.3 5741.1 5742.0 5758.7 5762.5 5778.7 5246.0 5341.4 5385.7 5394.2 5401.1 6205.2 6265.5 6280.1 6307.3 6321.6 6195.5 6208.3 6214.7 6237.4 6241.8 6129.7 6208.6 6304.4 6330.8 6338.5 6114.1 6130.2 6150.4 6154.4 6157.6 6154.4 6154.6 6168.4 6170.8 6187.3 5887.7 6054.3 6064.0 6089.1 6113.9 4985.7 5140.0 5675.1 6093.5 6119.9 5902.1 5929.6 5951.6 5957.8 5963.0 5665.8 5945.1 6024.8 6092.4 6116.0 5919.9 5968.6 5994.8 6001.1 6001.4 03:19:19 INFO - PROCESS | 1671 | 03:19:19 INFO - PROCESS | 1671 | [#1] ext.html Cycles:180 Average:62784.04 Median:41170.59 stddev:121674.76 (295.5%) stddev-sans-first:121926.18 03:19:19 INFO - PROCESS | 1671 | Values: 485.5 492.6 575.0 596.9 614.0 30172.5 39056.6 39079.6 39085.6 39271.2 40563.6 41013.2 41153.0 41220.6 41259.3 9489.0 9631.4 9667.2 9670.1 9680.0 9400.3 9613.3 9613.6 9626.5 9672.6 9603.2 9605.9 9675.0 9687.3 9688.1 9573.6 9622.4 9635.2 9639.2 9649.5 9660.1 9762.3 9804.1 9820.6 9825.3 39445.8 39573.0 39825.8 39873.6 39909.0 2737.4 3210.8 3360.8 3480.7 3974.3 26935.8 27432.6 27657.6 27690.0 27766.7 2753.6 2771.4 2803.7 2804.0 2818.0 432602.0 438735.0 439893.0 440326.0 442204.0 66972.3 68040.3 68631.3 68703.0 68712.3 84126.0 84241.6 85284.1 85695.6 85823.0 18669.2 18879.8 18887.2 18930.3 18935.1 14233.8 14239.0 14318.0 14322.1 14332.5 23069.1 23194.8 23433.0 23519.6 23586.0 8972.3 9180.3 9207.8 9211.6 9219.4 989.2 1085.8 1163.6 1188.7 1250.3 30438.0 30499.1 30594.4 30880.5 31059.1 1081.0 1084.9 1101.3 1143.3 1249.5 12785.4 15170.6 15191.8 15872.3 15914.2 536594.3 536724.0 539165.0 544027.0 546321.0 61108.3 62167.7 62425.1 62597.4 62757.7 1305.2 1460.9 1477.1 1498.2 1502.7 29800.7 30029.7 30156.5 30476.4 30548.5 53432.0 56814.7 57225.1 57411.4 57622.0 379788.0 381448.0 384738.0 387046.0 387618.0 44813.0 45161.8 46489.0 46614.1 46706.5 44484.6 48295.6 50006.7 50066.2 51741.7 40314.6 41357.0 41727.2 42287.4 42312.4 41188.2 41232.8 41250.0 41450.4 42030.0 38501.6 38958.8 40914.0 41291.0 42305.4 24755.6 34109.3 36018.5 36338.5 36482.8 26848.6 27144.0 27205.9 27222.7 27361.0 03:19:19 INFO - PROCESS | 1671 | 03:19:19 INFO - PROCESS | 1671 | [#2] jquery.html Cycles:180 Average:32921.99 Median:11290.71 stddev:93339.88 (826.7%) stddev-sans-first:93569.75 03:19:19 INFO - PROCESS | 1671 | Values: 384.2 385.0 392.5 392.9 398.5 19513.4 21211.0 22056.4 22087.7 22116.3 19427.9 19669.6 21079.4 21117.0 21406.5 5615.3 5931.4 6128.8 6203.2 6204.7 5794.6 5802.8 5818.4 5842.1 5852.5 5760.5 5838.6 6029.2 6081.1 6095.1 6000.6 6020.3 6043.3 6063.6 6074.0 5664.1 5698.0 5771.9 5836.2 5856.2 12875.5 13297.5 13500.5 13838.2 13841.5 2075.9 2113.6 2529.2 2566.8 2883.3 8711.7 9664.3 10298.9 11535.0 14332.0 1373.0 1703.9 1711.6 1741.3 1744.1 78234.6 79176.6 100264.0 100264.5 102430.0 11332.4 11451.0 11486.5 11562.4 11671.3 13061.4 13090.9 14236.1 14281.0 14295.1 8792.3 8944.9 8965.0 9071.5 9108.5 9129.6 9169.4 9175.2 9178.1 9264.7 3753.3 4551.8 4592.4 4609.6 4624.9 1848.7 1939.3 1951.0 1951.7 2024.1 817.9 881.3 894.2 963.2 1001.6 19824.9 20286.4 20505.5 20861.7 20894.4 911.2 916.9 920.7 1006.2 1062.2 9156.0 11171.7 11258.5 11275.9 11279.2 474459.0 512148.0 520903.0 621524.0 653051.0 120135.4 120555.4 123113.4 127111.5 131948.7 1013.8 1051.8 1080.8 1086.2 1086.9 11192.9 11339.8 11640.9 18458.5 18635.1 49354.0 50102.0 51651.5 51995.7 52552.5 74194.3 76711.2 77454.0 78764.2 86662.0 11914.4 12333.1 12346.2 12431.1 12578.7 12739.0 12911.5 13483.6 14118.6 14346.9 11820.1 11914.3 11922.8 12110.0 12152.3 10289.1 11898.0 11913.8 11918.9 12024.3 8304.8 8320.7 8451.2 12084.3 12386.4 11456.7 11799.2 12414.6 12510.1 12700.7 11181.7 11938.6 12247.4 12269.3 12371.6 03:19:19 INFO - PROCESS | 1671 | 03:19:19 INFO - PROCESS | 1671 | [#3] mootools.html Cycles:180 Average:6240.00 Median:521.08 stddev:3322.42 (637.6%) stddev-sans-first:3313.94 03:19:19 INFO - PROCESS | 1671 | Values: 1664.3 1689.7 2037.8 2060.5 2070.7 8196.9 8817.3 9001.0 9192.9 9213.8 8958.5 8973.0 8989.6 9077.2 9102.6 2065.1 2233.3 2388.3 2494.1 2509.7 2333.4 2467.3 2571.0 2581.4 2592.5 2523.5 2564.2 2565.4 2566.9 2577.6 2516.8 2525.8 2540.7 2574.5 2583.9 2027.3 2246.3 2456.9 2507.0 2555.1 9065.8 9129.9 9133.8 9153.2 9167.4 5506.6 5590.9 5597.4 5597.7 5674.0 3625.6 3701.8 3729.8 3746.2 3796.7 1055.4 1071.6 1078.6 1078.9 1083.1 12201.5 12290.6 12360.1 12371.8 12381.5 4908.8 4978.5 5042.2 5081.4 5091.5 10419.2 10485.9 10547.8 10558.5 10577.2 5539.8 5655.6 5673.7 5684.6 5751.3 4568.7 4943.7 4990.8 5027.6 5151.3 4086.6 4135.1 4136.5 4141.8 4147.9 1365.7 1380.3 1385.7 1390.0 1391.1 1402.9 1422.8 1428.9 1445.8 1461.2 8405.1 8453.3 8455.6 8475.7 8484.4 516.1 520.3 521.9 525.9 530.0 5843.6 6036.5 6237.4 6388.6 6401.7 10969.1 11198.0 11329.1 11340.7 11387.0 10561.3 11010.4 11030.4 11103.9 11184.4 8668.2 8718.9 8735.0 8754.0 8786.0 6683.8 8060.0 8184.3 8326.2 8340.4 9535.0 9818.9 9842.5 9854.5 9863.9 9974.9 10157.5 10195.2 10204.6 10255.3 6337.4 7473.4 7708.4 7749.3 7760.2 8426.8 8468.8 8497.2 8525.2 8528.6 7360.3 7596.0 7598.4 7616.9 7641.2 7306.6 7395.6 7429.0 7511.4 7563.2 7963.4 8028.2 8061.4 8080.2 8100.0 7218.4 7260.2 7266.8 7323.2 7333.9 7353.7 7373.3 7396.9 7431.6 7442.0 03:19:19 INFO - PROCESS | 1671 | 03:19:19 INFO - PROCESS | 1671 | [#4] prototype.html Cycles:180 Average:6039.43 Median:6827.04 stddev:1943.30 (28.5%) stddev-sans-first:1901.16 03:19:19 INFO - PROCESS | 1671 | Values: 344.2 346.3 349.6 353.2 357.2 6937.0 6967.0 6971.9 6974.4 6994.8 6845.5 6852.2 6908.2 6953.6 6991.7 4796.9 4953.7 5052.1 5057.4 5111.0 4758.0 5013.1 5047.9 5059.1 5069.0 4372.6 4979.3 4993.9 5006.4 5013.3 5018.5 5019.5 5050.3 5056.9 5058.5 4341.9 4400.1 4401.2 4405.0 4415.4 5383.9 6430.4 6648.7 6672.0 6727.8 6001.4 6006.2 6031.7 6049.8 6055.6 7516.5 7531.3 7548.3 7553.4 7573.2 4427.6 4686.9 4982.6 4985.2 4994.7 6364.6 7116.8 7846.1 7902.0 7916.5 4906.9 4918.1 5010.4 5026.7 5029.2 4588.4 4802.9 5130.2 5186.9 5194.3 6006.0 6026.2 6043.1 6044.1 6061.3 5760.9 6093.3 6501.5 7190.9 7519.2 1687.5 1745.4 1746.3 1763.1 1782.3 950.9 1147.9 1164.1 1169.7 1170.3 6811.9 6815.0 6829.6 6840.7 6854.9 7673.0 7680.6 7684.7 7685.8 7696.8 5564.6 6824.5 6845.3 6851.4 6869.4 3751.4 4062.7 4066.0 4076.8 4092.6 7935.4 8043.8 8059.8 8073.4 8116.2 7999.4 8030.1 8092.0 8127.5 8144.7 8169.1 8169.1 8183.3 8188.0 8208.7 5702.8 6947.1 7474.1 7782.6 7806.6 7586.3 7638.2 7663.3 7666.2 7672.0 6497.8 8136.9 8149.6 8151.3 8162.5 4422.4 4863.1 5066.1 5073.5 5097.0 7445.2 7772.1 7774.7 7789.3 7809.2 6448.3 7114.2 7496.0 7498.4 7504.2 7473.8 7483.1 7483.5 7495.2 7526.0 6381.2 7321.1 7323.6 7340.2 7342.7 6863.9 7460.3 7520.8 7521.1 7545.7 7330.7 7344.1 7358.1 7362.0 7372.2 03:19:19 INFO - PROCESS | 1671 | 03:19:19 INFO - PROCESS | 1671 | [#5] yui.html Cycles:180 Average:18976.69 Median:608.28 stddev:27063.02 (4449.1%) stddev-sans-first:27103.78 03:19:19 INFO - PROCESS | 1671 | Values: 605.5 606.6 634.9 636.7 674.2 12488.7 12530.2 12943.9 14977.3 15226.8 12834.9 14242.1 14250.2 14258.4 14267.5 918.4 948.4 959.1 976.5 980.1 802.7 983.3 984.5 985.3 990.1 859.5 979.8 983.6 1011.9 1022.5 966.7 990.5 990.9 995.5 1006.3 759.7 761.0 765.4 773.8 779.4 15925.1 16122.3 16131.2 16226.3 16273.8 12891.3 12956.6 13043.7 13076.7 13108.8 10136.1 10366.5 10366.8 10368.2 10636.0 3468.2 3508.6 3510.9 3555.6 3592.2 83386.6 84003.0 84348.3 85938.0 86286.1 8844.8 9028.0 9031.3 9043.7 9268.6 21846.7 22097.7 22130.1 22138.6 22147.2 6332.6 7310.6 7351.6 7411.3 7616.7 4083.9 4103.7 4159.3 4187.6 4205.4 3603.1 3606.2 3660.5 3664.1 3669.6 635.3 637.1 643.2 648.8 669.0 539.8 548.9 567.0 587.1 610.0 7061.4 8421.9 8446.5 8512.1 8514.2 524.6 549.7 615.4 619.1 630.4 2997.9 3691.9 3809.7 3828.3 3837.9 76902.0 97153.0 97189.5 97615.0 99212.0 70848.3 84111.6 84898.6 87156.6 87311.6 73464.6 73881.6 74414.6 74786.0 75428.6 8562.4 8688.5 8815.3 8828.2 8985.7 48436.5 49349.5 51892.0 52645.7 53598.7 71308.0 74403.6 74510.9 74808.6 74831.3 11024.7 11292.7 11293.6 11465.8 11555.2 12142.5 12562.2 12595.6 12596.6 12608.4 10967.8 11096.4 11253.9 11486.6 11520.9 11694.5 11807.0 11819.7 11852.9 11958.9 11359.7 11391.9 11947.0 11962.0 11991.8 9309.4 9362.1 9397.9 9526.8 9712.2 9609.0 9790.8 9812.9 9854.9 9870.6 03:19:19 INFO - PROCESS | 1671 | -------- Summary: end -------- 03:19:19 INFO - PROCESS | 1671 | 03:19:20 INFO - TEST-INFO | 1671: exit 0 03:19:20 INFO - TEST-OK | dromaeo_css | took 1110936ms 03:19:20 INFO - TEST-START | kraken 03:19:20 INFO - operating with platform_type : mac_ 03:19:20 INFO - Initialising browser for kraken test... 03:19:20 INFO - TEST-INFO | started process 1679 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/tmpqHV5hr/profile http://localhost:49270/getInfo.html) 03:19:22 INFO - PROCESS | 1679 | __metrics Screen width/height:1600/1200 03:19:22 INFO - PROCESS | 1679 | colorDepth:24 03:19:22 INFO - PROCESS | 1679 | Browser inner width/height: 1024/689 03:19:22 INFO - PROCESS | 1679 | __metrics 03:19:23 ERROR - PROCESS | 1679 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 03:19:23 INFO - TEST-INFO | 1679: exit 0 03:19:23 INFO - Browser initialized. 03:19:23 INFO - Running cycle 1/1 for kraken test... 03:19:23 INFO - TEST-INFO | started process 1683 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/tmpqHV5hr/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:19:35 INFO - PROCESS | 1683 | RSS: Main: 218185728 03:19:35 INFO - PROCESS | 1683 | 03:19:38 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-beat-detection) 03:19:39 INFO - PROCESS | 1683 | RSS: Main: 229990400 03:19:39 INFO - PROCESS | 1683 | 03:19:41 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-dft) 03:19:42 INFO - PROCESS | 1683 | RSS: Main: 239042560 03:19:42 INFO - PROCESS | 1683 | 03:19:45 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-fft) 03:19:46 INFO - PROCESS | 1683 | RSS: Main: 243191808 03:19:46 INFO - PROCESS | 1683 | 03:19:48 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-oscillator) 03:19:48 INFO - PROCESS | 1683 | RSS: Main: 243122176 03:19:48 INFO - PROCESS | 1683 | 03:19:50 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:19:51 INFO - PROCESS | 1683 | RSS: Main: 243732480 03:19:51 INFO - PROCESS | 1683 | 03:19:54 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-darkroom) 03:19:54 INFO - PROCESS | 1683 | RSS: Main: 243879936 03:19:54 INFO - PROCESS | 1683 | 03:19:57 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-desaturate) 03:19:58 INFO - PROCESS | 1683 | RSS: Main: 244260864 03:19:58 INFO - PROCESS | 1683 | 03:20:01 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49270/tests/kraken/driver.html?testName=json-parse-financial) 03:20:02 INFO - PROCESS | 1683 | RSS: Main: 244744192 03:20:02 INFO - PROCESS | 1683 | 03:20:03 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49270/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:20:04 INFO - PROCESS | 1683 | RSS: Main: 244654080 03:20:04 INFO - PROCESS | 1683 | 03:20:06 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:20:06 INFO - PROCESS | 1683 | RSS: Main: 244596736 03:20:06 INFO - PROCESS | 1683 | 03:20:08 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:20:09 INFO - PROCESS | 1683 | RSS: Main: 245567488 03:20:09 INFO - PROCESS | 1683 | 03:20:12 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:20:12 INFO - PROCESS | 1683 | RSS: Main: 245567488 03:20:12 INFO - PROCESS | 1683 | 03:20:15 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:20:15 INFO - PROCESS | 1683 | RSS: Main: 244961280 03:20:15 INFO - PROCESS | 1683 | 03:20:17 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49270/tests/kraken/driver.html?testName=ai-astar) 03:20:17 INFO - PROCESS | 1683 | RSS: Main: 246968320 03:20:17 INFO - PROCESS | 1683 | 03:20:17 INFO - PROCESS | 1683 | __start_tp_report 03:20:17 INFO - PROCESS | 1683 | _x_x_mozilla_page_load 03:20:17 INFO - PROCESS | 1683 | _x_x_mozilla_page_load_details 03:20:17 INFO - PROCESS | 1683 | |i|pagename|runs| 03:20:17 INFO - PROCESS | 1683 | |0;ai-astar;114;96;122;116;126;188;161;114;114;114 03:20:17 INFO - PROCESS | 1683 | |1;audio-beat-detection;150;121;163;181;122;164;142;193;159;128 03:20:17 INFO - PROCESS | 1683 | |2;audio-dft;220;197;271;251;195;201;195;199;199;194 03:20:17 INFO - PROCESS | 1683 | |3;audio-fft;68;70;72;115;55;57;56;59;117;57 03:20:17 INFO - PROCESS | 1683 | |4;audio-oscillator;82;85;118;79;77;86;116;78;78;115 03:20:17 INFO - PROCESS | 1683 | |5;imaging-gaussian-blur;91;87;89;86;88;101;135;86;88;85 03:20:17 INFO - PROCESS | 1683 | |6;imaging-darkroom;102;101;96;143;95;91;97;111;113;120 03:20:17 INFO - PROCESS | 1683 | |7;imaging-desaturate;122;96;132;104;86;140;141;121;142;130 03:20:17 INFO - PROCESS | 1683 | |8;json-parse-financial;54;60;62;60;59;60;61;68;58;86 03:20:17 INFO - PROCESS | 1683 | |9;json-stringify-tinderbox;64;100;94;101;93;69;71;66;65;66 03:20:17 INFO - PROCESS | 1683 | |10;stanford-crypto-aes;84;77;81;83;82;83;82;82;83;84 03:20:17 INFO - PROCESS | 1683 | |11;stanford-crypto-ccm;128;141;139;111;131;147;118;131;138;119 03:20:17 INFO - PROCESS | 1683 | |12;stanford-crypto-pbkdf2;127;137;146;162;139;139;135;139;161;132 03:20:17 INFO - PROCESS | 1683 | |13;stanford-crypto-sha256-iterative;69;66;66;66;69;66;65;81;101;92 03:20:17 INFO - PROCESS | 1683 | __end_tp_report 03:20:17 INFO - PROCESS | 1683 | __start_cc_report 03:20:17 INFO - PROCESS | 1683 | _x_x_mozilla_cycle_collect,915 03:20:17 INFO - PROCESS | 1683 | __end_cc_report 03:20:17 INFO - PROCESS | 1683 | __startTimestamp1461234017772__endTimestamp 03:20:17 INFO - PROCESS | 1683 | 03:20:17 INFO - PROCESS | 1683 | ------- Summary: start ------- 03:20:17 INFO - PROCESS | 1683 | Number of tests: 14 03:20:17 INFO - PROCESS | 1683 | 03:20:17 INFO - PROCESS | 1683 | [#0] ai-astar Cycles:10 Average:126.50 Median:124.00 stddev:27.20 (21.9%) stddev-sans-first:28.47 03:20:17 INFO - PROCESS | 1683 | Values: 114.0 96.0 122.0 116.0 126.0 188.0 161.0 114.0 114.0 114.0 03:20:17 INFO - PROCESS | 1683 | 03:20:17 INFO - PROCESS | 1683 | [#1] audio-beat-detection Cycles:10 Average:152.30 Median:161.00 stddev:24.44 (15.2%) stddev-sans-first:25.91 03:20:17 INFO - PROCESS | 1683 | Values: 150.0 121.0 163.0 181.0 122.0 164.0 142.0 193.0 159.0 128.0 03:20:17 INFO - PROCESS | 1683 | 03:20:17 INFO - PROCESS | 1683 | [#2] audio-dft Cycles:10 Average:212.20 Median:200.00 stddev:27.19 (13.6%) stddev-sans-first:28.69 03:20:17 INFO - PROCESS | 1683 | Values: 220.0 197.0 271.0 251.0 195.0 201.0 195.0 199.0 199.0 194.0 03:20:17 INFO - PROCESS | 1683 | 03:20:17 INFO - PROCESS | 1683 | [#3] audio-fft Cycles:10 Average:72.60 Median:58.00 stddev:23.70 (40.9%) stddev-sans-first:25.08 03:20:17 INFO - PROCESS | 1683 | Values: 68.0 70.0 72.0 115.0 55.0 57.0 56.0 59.0 117.0 57.0 03:20:17 INFO - PROCESS | 1683 | 03:20:17 INFO - PROCESS | 1683 | [#4] audio-oscillator Cycles:10 Average:91.40 Median:78.50 stddev:17.48 (22.3%) stddev-sans-first:18.20 03:20:17 INFO - PROCESS | 1683 | Values: 82.0 85.0 118.0 79.0 77.0 86.0 116.0 78.0 78.0 115.0 03:20:17 INFO - PROCESS | 1683 | 03:20:17 INFO - PROCESS | 1683 | [#5] imaging-gaussian-blur Cycles:10 Average:93.60 Median:87.50 stddev:15.25 (17.4%) stddev-sans-first:16.14 03:20:17 INFO - PROCESS | 1683 | Values: 91.0 87.0 89.0 86.0 88.0 101.0 135.0 86.0 88.0 85.0 03:20:17 INFO - PROCESS | 1683 | 03:20:17 INFO - PROCESS | 1683 | [#6] imaging-darkroom Cycles:10 Average:106.90 Median:117.00 stddev:15.63 (13.4%) stddev-sans-first:16.48 03:20:17 INFO - PROCESS | 1683 | Values: 102.0 101.0 96.0 143.0 95.0 91.0 97.0 111.0 113.0 120.0 03:20:17 INFO - PROCESS | 1683 | 03:20:17 INFO - PROCESS | 1683 | [#7] imaging-desaturate Cycles:10 Average:121.40 Median:140.50 stddev:19.84 (14.1%) stddev-sans-first:21.04 03:20:17 INFO - PROCESS | 1683 | Values: 122.0 96.0 132.0 104.0 86.0 140.0 141.0 121.0 142.0 130.0 03:20:17 INFO - PROCESS | 1683 | 03:20:17 INFO - PROCESS | 1683 | [#8] json-parse-financial Cycles:10 Average:62.80 Median:60.50 stddev:8.87 (14.7%) stddev-sans-first:8.81 03:20:17 INFO - PROCESS | 1683 | Values: 54.0 60.0 62.0 60.0 59.0 60.0 61.0 68.0 58.0 86.0 03:20:17 INFO - PROCESS | 1683 | 03:20:17 INFO - PROCESS | 1683 | [#9] json-stringify-tinderbox Cycles:10 Average:78.90 Median:67.50 stddev:15.88 (23.5%) stddev-sans-first:15.90 03:20:17 INFO - PROCESS | 1683 | Values: 64.0 100.0 94.0 101.0 93.0 69.0 71.0 66.0 65.0 66.0 03:20:17 INFO - PROCESS | 1683 | 03:20:17 INFO - PROCESS | 1683 | [#10] stanford-crypto-aes Cycles:10 Average:82.10 Median:83.00 stddev:2.02 (2.4%) stddev-sans-first:2.03 03:20:17 INFO - PROCESS | 1683 | Values: 84.0 77.0 81.0 83.0 82.0 83.0 82.0 82.0 83.0 84.0 03:20:17 INFO - PROCESS | 1683 | 03:20:17 INFO - PROCESS | 1683 | [#11] stanford-crypto-ccm Cycles:10 Average:130.30 Median:134.50 stddev:11.48 (8.5%) stddev-sans-first:12.15 03:20:17 INFO - PROCESS | 1683 | Values: 128.0 141.0 139.0 111.0 131.0 147.0 118.0 131.0 138.0 119.0 03:20:17 INFO - PROCESS | 1683 | 03:20:17 INFO - PROCESS | 1683 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:141.70 Median:139.00 stddev:11.56 (8.3%) stddev-sans-first:10.97 03:20:17 INFO - PROCESS | 1683 | Values: 127.0 137.0 146.0 162.0 139.0 139.0 135.0 139.0 161.0 132.0 03:20:17 INFO - PROCESS | 1683 | 03:20:17 INFO - PROCESS | 1683 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:74.10 Median:67.50 stddev:12.86 (19.1%) stddev-sans-first:13.51 03:20:17 INFO - PROCESS | 1683 | Values: 69.0 66.0 66.0 66.0 69.0 66.0 65.0 81.0 101.0 92.0 03:20:17 INFO - PROCESS | 1683 | -------- Summary: end -------- 03:20:17 INFO - PROCESS | 1683 | 03:20:18 INFO - TEST-INFO | 1683: exit 0 03:20:18 INFO - TEST-OK | kraken | took 58397ms 03:20:18 INFO - SUITE-END | took 1169s 03:20:18 INFO - Completed test suite (00:19:29) 03:20:18 INFO - javascript benchmark 03:20:18 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2952.940941181176, 3263.9836800815992, 3413.9317213655713, 3519.3665140274748, 3569.0, 5601.215829783833, 5611.9438805611935, 5633.943660563393, 5636.605437619358, 5665.971670141644, 4846.836759177799, 5544.6118771686, 5620.522255608278, 5630.634008789436, 5647.604667673254, 5091.981603679251, 5130.538251557359, 5151.845444636649, 5177.119889618755, 5240.711760853171, 4653.208954477747, 4845.781939812699, 5154.8711282218055, 5198.414483582505, 5199.558037566811, 5093.668911520739, 5160.819371322004, 5164.173732202848, 5165.9225111623355, 5166.095933211692, 5170.6122040847085, 5177.689338639656, 5216.087184742655, 5219.5041471060185, 5230.320058392384, 4287.678424118172, 5037.395512538482, 5141.305923700327, 5174.560162386202, 5205.635605507616, 5478.616496845222, 5504.669719816784, 5532.0, 5564.582656300794, 5695.34503532095, 6117.694115294217, 6153.200083989098, 6182.258129024501, 6189.628622282632, 6209.348018458088, 6178.69106544671, 6196.0, 6205.100260462208, 6240.438360547527, 6244.4067813558095, 4716.575508204278, 5668.546516278688, 5758.7696492140685, 5767.826965191051, 5797.971010144923, 6196.406899707571, 6225.066240064027, 6232.968835155795, 6235.038356780493, 6263.843403914848, 6115.6330620162935, 6116.694165291718, 6120.418560236771, 6122.836661034389, 6129.754809807647, 6092.939070609325, 6111.774065234738, 6162.26052873658, 6163.106349579286, 6237.500999919996, 6074.42292982166, 6117.663528505975, 6130.785422510191, 6151.077338399186, 6204.441600255908, 6047.0, 6131.877362452815, 6218.160548326008, 6221.875562488815, 6239.937600623935, 4827.468978412372, 4883.4139903211135, 4889.193283108319, 4900.926486102711, 4930.654854160174, 4384.4519435070615, 4388.517263101056, 4398.142362239332, 4405.7797110144365, 4420.071784925201, 5613.382527921925, 5689.317281926113, 5693.5160511357, 5738.368779434259, 5754.136879468113, 6073.635581865102, 6109.283207920342, 6160.353162917829, 6191.659458729723, 6210.31686514483, 5741.052726300197, 5741.971290143606, 5758.74085666146, 5762.4525670061275, 5778.682172480554, 5246.0, 5341.439148889388, 5385.676859388449, 5394.163904594794, 5401.108817045222, 6205.193324867739, 6265.467435267871, 6280.05799130125, 6307.306196318493, 6321.620702757666, 6195.473384762346, 6208.286047104641, 6214.72033758491, 6237.438630523275, 6241.78153764616, 6129.693515324305, 6208.565400421927, 6304.432601065926, 6330.778422755181, 6338.524610654127, 6114.052321890114, 6130.233720784902, 6150.446459818638, 6154.3845615438095, 6157.599756015845, 6154.415330543591, 6154.569180157346, 6168.383161683796, 6170.784022559189, 6187.319394866651, 5887.735051922588, 6054.273487181566, 6064.04984423676, 6089.086637004485, 6113.938860611337, 4985.700857948535, 5139.97200559882, 5675.148727690715, 6093.542984276109, 6119.8776024478375, 5902.055671092605, 5929.644221346733, 5951.583389162717, 5957.791477298274, 5962.970185149046, 5665.773369065356, 5945.10823376497, 6024.849378765566, 6092.360302168208, 6115.969420152871, 5919.91120133207, 5968.552358573038, 5994.790182343597, 6001.099835024606, 6001.36985616504], "unit": "score", "name": "dojo.html", "value": 5626.2779133933}, {"lowerIsBetter": false, "replicates": [485.5096352683788, 492.6059152677857, 574.95932362424, 596.9373215812341, 613.9899864722531, 30172.54741178881, 39056.60943390569, 39079.609203907916, 39085.60914390855, 39271.214575708465, 40563.59436405635, 41013.17973640533, 41153.0, 41220.58779412205, 41259.349626014926, 9489.003654616286, 9631.422114673107, 9667.226621870268, 9670.129688328048, 9680.0, 9400.294977876652, 9613.279004074688, 9613.567389467491, 9626.518674066303, 9672.613095476172, 9603.18372938301, 9605.855912161323, 9675.032496750304, 9687.273454490905, 9688.079632434907, 9573.569189386495, 9622.422654640744, 9635.18100961419, 9639.228861691048, 9649.517524123767, 9660.130588247092, 9762.316637835354, 9804.117629413387, 9820.607175712963, 9825.263105267062, 39445.80277098596, 39573.0, 39825.80087099575, 39873.60126398728, 39909.0, 2737.397772490049, 3210.82340471274, 3360.781549199294, 3480.7215422766117, 3974.324364857981, 26935.787889544823, 27432.588511172147, 27657.585136222773, 27690.030848920393, 27766.722332776615, 2753.6420265365573, 2771.3764403009163, 2803.747662710366, 2803.971960280412, 2818.0, 432602.0, 438735.0, 439893.0, 440326.0, 442204.0, 66972.33027669661, 68040.31959680439, 68631.31368686249, 68703.0, 68712.3128768716, 84126.0, 84241.57879210687, 85284.14715852762, 85695.57152214323, 85823.0, 18669.159887805083, 18879.81120188808, 18887.150078246512, 18930.337438189596, 18935.147918343708, 14233.78649320261, 14239.003269771016, 14318.0, 14322.14067155974, 14332.49836255726, 23069.077236910336, 23194.84025798737, 23433.0, 23519.647205291592, 23586.0, 8972.327075469366, 9180.31147663928, 9207.76980575491, 9211.63153473867, 9219.354645174908, 989.1888651306004, 1085.7719878825378, 1163.6392718257368, 1188.6968822950093, 1250.3435696259355, 30438.0, 30499.08502744921, 30594.38811223763, 30880.53679194814, 31059.068227953197, 1080.956761729522, 1084.8969347911936, 1101.3281898042187, 1143.2683082826998, 1249.5126900508808, 12785.424655890507, 15170.620734481727, 15191.848081519265, 15872.285747141406, 15914.204289785464, 536594.3170284202, 536724.0, 539165.0, 544027.0, 546321.0, 61108.33349999014, 62167.689161553906, 62425.06362404567, 62597.37402626006, 62757.68621156865, 1305.1973036582433, 1460.9342579583945, 1477.1137317609348, 1498.2134379450877, 1502.6919481506266, 29800.701992979793, 30029.69970300269, 30156.547651784804, 30476.39047218999, 30548.541771873883, 53432.0, 56814.715926420104, 57225.14162287652, 57411.425885742276, 57622.0, 379788.0, 381448.0, 384738.0, 387046.0, 387618.0, 44813.0, 45161.77419112883, 46489.0, 46614.06771864476, 46706.53293467158, 44484.555154449336, 48295.551133466055, 50006.74996624994, 50066.24900626421, 51741.7412912933, 40314.59685403226, 41357.0, 41727.165456691306, 42287.36568951407, 42312.36531451969, 41188.1762364757, 41232.79383603183, 41249.98129218713, 41450.37824432696, 42030.0, 38501.6149838498, 38958.80520597379, 40914.0, 41290.967725807095, 42305.365419518115, 24755.62866556967, 34109.315778974466, 36018.4597231047, 36338.4549231767, 36482.8175859119, 26848.59727104056, 27144.0, 27205.91176352924, 27222.72777272202, 27361.042363517183], "unit": "score", "name": "ext.html", "value": 20811.655877795834}, {"lowerIsBetter": false, "replicates": [384.2430412088185, 384.9884503464895, 392.458407397791, 392.8546437818007, 398.51580329899167, 19513.414597562078, 21211.045502952365, 22056.448588785268, 22087.66868496974, 22116.33650990469, 19427.931463769488, 19669.60660786787, 21079.367618971417, 21117.0, 21406.464838379048, 5615.2700148980575, 5931.406859314077, 6128.754849806002, 6203.2245969253845, 6204.720787564571, 5794.565407594426, 5802.796902108427, 5818.44724751148, 5842.094475356326, 5852.502537284315, 5760.4815566599, 5838.562107841907, 6029.216201893748, 6081.148639190517, 6095.05526643371, 6000.639961602296, 6020.307664618537, 6043.335233124375, 6063.6361818290825, 6073.969630151821, 5664.0937450007805, 5698.0, 5771.855703607402, 5836.241288632493, 5856.238688970449, 12875.484980600859, 13297.53458628953, 13500.459981600725, 13838.169709817343, 13841.515546955809, 2075.937721868346, 2113.5984163009134, 2529.152733834168, 2566.7561581649716, 2883.3224192314788, 8711.695090671796, 9664.275179361506, 10298.9485052575, 11535.019523340443, 14332.0, 1372.9588112356646, 1703.9233234504354, 1711.5635512944243, 1741.2773698914934, 1744.145368769294, 78234.6088269555, 79176.60411697962, 100264.0, 100264.49867750614, 102430.0, 11332.376719280519, 11451.0, 11486.540538378538, 11562.364069976064, 11671.299722016705, 13061.412236449383, 13090.869091309156, 14236.145831250158, 14281.000329976801, 14295.142291462338, 8792.34057445694, 8944.86582701247, 8964.969028561669, 9071.546422678839, 9108.49903255314, 9129.634814607341, 9169.449833009907, 9175.174234318943, 9178.082191780768, 9264.675736349196, 3753.3431649461236, 4551.817927282872, 4592.357070010201, 4609.631229501699, 4624.930626040612, 1848.6672398968315, 1939.2533874458436, 1950.9612454984576, 1951.7462729845029, 2024.1459542045939, 817.9304759095425, 881.2553392383426, 894.1996912763041, 963.1909196275162, 1001.6327712672296, 19824.90087549553, 20286.391408257776, 20505.48736281605, 20861.68707469389, 20894.37316880496, 911.193593669594, 916.9128932751378, 920.6915683246053, 1006.2151521812998, 1062.192733522513, 9156.0, 11171.664850054349, 11258.493367798468, 11275.943620281847, 11279.154063445274, 474459.0, 512148.0, 520903.0, 621524.0, 653051.0, 120135.39932300457, 120555.39722301332, 123113.38443307726, 127111.45777084406, 131948.68051319363, 1013.7516308504464, 1051.7686109055996, 1080.8378743188428, 1086.21792309537, 1086.9293495922739, 11192.944035279772, 11339.773204535699, 11640.94179529097, 18458.538536536693, 18635.06824658789, 49354.0, 50102.0, 51651.48348516467, 51995.74002129965, 52552.47447525629, 74194.25805741873, 76711.23288767264, 77454.0, 78764.21235787569, 86662.0, 11914.40427978615, 12333.075019373404, 12346.197497162655, 12431.129820912449, 12578.748425031632, 12739.044571656977, 12911.5480958166, 13483.595492135251, 14118.647033824236, 14346.928265358607, 11820.113491488, 11914.285142891455, 11922.821157682814, 12110.031197504355, 12152.331621760888, 10289.125424339016, 11897.988670962719, 11913.821292680443, 11918.880811191777, 12024.278543287432, 8304.83390332202, 8320.677803532852, 8451.1548845115, 12084.335361555199, 12386.380680966096, 11456.739758626378, 11799.17405781587, 12414.62756117318, 12510.124291299522, 12700.682482938, 11181.72045698864, 11938.58214962472, 12247.387630618256, 12269.325187114437, 12371.566995155126], "unit": "score", "name": "jquery.html", "value": 9579.337423475112}, {"lowerIsBetter": false, "replicates": [1664.2843577261776, 1689.7127488326987, 2037.7962203779623, 2060.484878780305, 2070.6997485364614, 8196.91803081969, 8817.250533704642, 9001.009888912222, 9192.90807091928, 9213.815723685531, 8958.46249225047, 8973.0, 8989.59546820393, 9077.228435582983, 9102.635894564226, 2065.0500769645982, 2233.2630232023394, 2388.319328991238, 2494.1270555305587, 2509.6988361396657, 2333.4166458385403, 2467.3214865911837, 2570.974290257092, 2581.380468687511, 2592.5074235895213, 2523.49530093981, 2564.192279431982, 2565.397131674055, 2566.897324107043, 2577.5618144915315, 2516.848989060653, 2525.8231923765343, 2540.733223011585, 2574.4979728952862, 2583.8578878161693, 2027.2701827342146, 2246.3261021693424, 2456.914008009729, 2506.987465062663, 2555.1440267510407, 9065.818683626356, 9129.863052054225, 9133.771655708593, 9153.221976132038, 9167.358284920057, 5506.559475241971, 5590.937721832839, 5597.384287728347, 5597.748101335409, 5673.971630141864, 3625.5830579483168, 3701.796401197933, 3729.813509324523, 3746.19456816783, 3796.7152463565067, 1055.3931489393553, 1071.6344911227286, 1078.5793540519203, 1078.9352638841694, 1083.0523292119397, 12201.45093470796, 12290.631281061582, 12360.072994525357, 12371.75256494865, 12381.504739810396, 4908.828191013369, 4978.5270399312, 5042.168042272984, 5081.364829396325, 5091.465396133427, 10419.166466682798, 10485.9475702621, 10547.789044219226, 10558.52486638103, 10577.153827693766, 5539.750711217925, 5655.604107712421, 5673.687947162945, 5684.602077854511, 5751.281089863767, 4568.680192386501, 4943.653944223942, 4990.750462476862, 5027.572656324253, 5151.330327057459, 4086.591340865949, 4135.1316223592785, 4136.544980052192, 4141.834326626961, 4147.854825081107, 1365.7336819320335, 1380.3167432121165, 1385.736710025092, 1389.9513517027058, 1391.0540832233976, 1402.8877689784792, 1422.8434872164053, 1428.8785453236383, 1445.7975883376337, 1461.2036440139937, 8405.075441701409, 8453.281471074904, 8455.577221138918, 8475.70335038283, 8484.448510846774, 516.0813751522296, 520.3105884702709, 521.8512723873678, 525.876419041525, 529.9735013249399, 5843.620164689281, 6036.486898613579, 6237.438630523184, 6388.552801303864, 6401.743930242831, 10969.067629251604, 11198.0, 11329.09367250618, 11340.659780206606, 11387.032102271234, 10561.313514621525, 11010.449477526252, 11030.393328367018, 11103.888961110286, 11184.384858832842, 8668.176523230282, 8718.912810871938, 8734.95632521846, 8754.037055923844, 8785.989611194667, 6683.7660681875905, 8060.0, 8184.304334131665, 8326.209010144026, 8340.374471914509, 9534.95232523833, 9818.85271720939, 9842.458664773507, 9854.507274636097, 9863.852042219229, 9974.900250997687, 10157.542910568895, 10195.23535734808, 10204.642837500653, 10255.282130250811, 6337.366263373626, 7473.43949203801, 7708.383329333527, 7749.302562769378, 7760.223977602194, 8426.789330266793, 8468.788280292796, 8497.235248827388, 8525.232729054414, 8528.616212270586, 7360.300771426706, 7596.0, 7598.354139898171, 7616.9238307616215, 7641.197674244125, 7306.561606303639, 7395.630218489162, 7429.0, 7511.3615342696485, 7563.205863384485, 7963.362930965393, 8028.237317454832, 8061.435699500978, 8080.232377924088, 8099.987501562305, 7218.386437152901, 7260.165081015751, 7266.83730603101, 7323.231060738759, 7333.926660733325, 7353.742619008309, 7373.33639972405, 7396.852062958603, 7431.554106753612, 7442.0], "unit": "score", "name": "mootools.html", "value": 5003.239635495982}, {"lowerIsBetter": false, "replicates": [344.2495360114949, 346.3436787288089, 349.55780937114537, 353.2405328543631, 357.1660173494891, 6936.965315173417, 6967.0, 6971.930280697192, 6974.442044636429, 6994.755183568583, 6845.520813543054, 6852.2462529121885, 6908.20555636102, 6953.5827850329015, 6991.685374158163, 4796.880077998043, 4953.678010929278, 5052.0906236877345, 5057.41839688435, 5111.003354345913, 4757.977034937488, 5013.097642424362, 5047.949520504784, 5059.11465493539, 5068.960863023071, 4372.628326592244, 4979.30289759434, 4993.925091123636, 5006.374203224597, 5013.273075404064, 5018.548330650223, 5019.523145301208, 5050.318207042076, 5056.949430505703, 5058.494150584912, 4341.871113510479, 4400.1419723153995, 4401.163778882003, 4405.03089320349, 4415.381846541487, 5383.865403364947, 6430.3891130342545, 6648.700808463631, 6671.966640166816, 6727.831804204885, 6001.399860013964, 6006.159137720722, 6031.698415079229, 6049.788257411014, 6055.576109672281, 7516.549007059594, 7531.284527969834, 7548.320651141369, 7553.357964573018, 7573.242675732437, 4427.579379958899, 4686.922007938193, 4982.57648099912, 4985.202367621199, 4994.675346102492, 6364.586301890408, 7116.786496405116, 7846.136924938252, 7902.0, 7916.485428447132, 4906.8773280668265, 4918.11473934688, 5010.3737032870895, 5026.698398096126, 5029.245613157982, 4588.449386073693, 4802.855914322576, 5130.153524668388, 5186.870328241824, 5194.298769666047, 6005.969970150121, 6026.156338112668, 6043.123747056652, 6044.093385992049, 6061.333253342129, 5760.855978600484, 6093.268807743099, 6501.47988160946, 7190.928090719026, 7519.248075192437, 1687.485316978309, 1745.3716662001668, 1746.2665680414257, 1763.1096296370508, 1782.3494424534952, 950.9476978766235, 1147.9024282936043, 1164.132721122752, 1169.6783384569312, 1170.2744298534963, 6811.897821532681, 6815.045893574904, 6829.624370659562, 6840.6921688524135, 6854.897176542356, 7672.961635191788, 7680.577568233801, 7684.692612295557, 7685.76942691709, 7696.846063078707, 5564.610477266552, 6824.454043676494, 6845.349691779273, 6851.417629501449, 6869.416099631588, 3751.437284407306, 4062.695297852673, 4065.9796701016307, 4076.8369265229057, 4092.5907409258834, 7935.365170786324, 8043.758687239392, 8059.798505037304, 8073.354131669453, 8116.228958248957, 7999.440039197317, 8030.116687164407, 8092.0, 8127.512349259064, 8144.714934977247, 8169.101398846241, 8169.142240064826, 8183.345332373396, 8188.0, 8208.671653134046, 5702.7718891243885, 6947.062146610143, 7474.122462851732, 7782.649780759993, 7806.57063861493, 7586.317231449196, 7638.236176382317, 7663.348615367756, 7666.156722760604, 7672.0, 6497.772577959749, 8136.918630813616, 8149.633266502903, 8151.30713889326, 8162.469439486652, 4422.3808666786035, 4863.148948933852, 5066.08810414129, 5073.467285935071, 5096.955124199604, 7445.181030086795, 7772.067351917806, 7774.6890124394395, 7789.337906277803, 7809.2190780921455, 6448.25845027809, 7114.181869085121, 7495.950566920745, 7498.400127989638, 7504.212057733859, 7473.813154671177, 7483.139438964588, 7483.476156668981, 7495.17553069151, 7525.962370188114, 6381.202349706286, 7321.121465424183, 7323.6338183089565, 7340.229275925951, 7342.70629174827, 6863.862722745417, 7460.29127232912, 7520.8495830082, 7521.135069466863, 7545.7358992435, 7330.706771729071, 7344.11870575513, 7358.080239970004, 7361.963190184015, 7372.189059203591], "unit": "score", "name": "prototype.html", "value": 5397.14268772591}, {"lowerIsBetter": false, "replicates": [605.4883623338279, 606.5966132521874, 634.9047642853573, 636.7389370358154, 674.177503445796, 12488.687782805435, 12530.248185108889, 12943.870561294385, 14977.251137443138, 15226.847731522681, 12834.935825320883, 14242.145471271731, 14250.2162381069, 14258.429662813474, 14267.50063747769, 918.4443411735887, 948.4404201521102, 959.0505399654362, 976.5019839881676, 980.1423754215061, 802.6548584108831, 983.3018556824663, 984.4929861121528, 985.3152059318776, 990.0990099009903, 859.5358506406533, 979.8089372572351, 983.6065573770513, 1011.9291649584532, 1022.5296363672719, 966.6809952715622, 990.479998001048, 990.8612794208816, 995.4922989275449, 1006.2704539209088, 759.6999185321766, 761.0486891385768, 765.4450523370567, 773.7717373374868, 779.4426984705906, 15925.124118173495, 16122.274497647517, 16131.193440328054, 16226.269817858225, 16273.755893661486, 12891.290978996152, 12956.611301660965, 13043.739125217442, 13076.738465230643, 13108.803367949393, 10136.087752102272, 10366.533505992249, 10366.792664146751, 10368.170546356348, 10636.0, 3468.231063070931, 3508.561429821272, 3510.929781404383, 3555.6266592007723, 3592.2276710507367, 83386.58306708488, 84003.0, 84348.3130337396, 85938.0, 86286.13713862844, 8844.823103537894, 9027.954860225656, 9031.27749780016, 9043.728688139367, 9268.582913768896, 21846.672299915197, 22097.66853497199, 22130.114795408004, 22138.557228855334, 22147.224847130274, 6332.588381755171, 7310.597917114504, 7351.595662238521, 7411.332980031823, 7616.7334143305825, 4083.89790255246, 4103.692223083221, 4159.292920203573, 4187.644050255702, 4205.411242426063, 3603.081214290339, 3606.1886075632774, 3660.524131862841, 3664.0656632558525, 3669.559652841676, 635.2504045226584, 637.0603360043898, 643.2441880790053, 648.7859006527834, 668.9966550167316, 539.7867842202387, 548.8572971027562, 566.9914951275734, 587.1251834766254, 609.9634021958608, 7061.364477196974, 8421.873671894926, 8446.450980686235, 8512.106228846005, 8514.191151840565, 524.5934400839303, 549.7251374312843, 615.4092071611303, 619.0868469008177, 630.4168644004369, 2997.8800847965836, 3691.944982392203, 3809.733318667722, 3828.272628200633, 3837.884863454101, 76902.0, 97153.0284697158, 97189.5140524307, 97615.0, 99212.0, 70848.2915170852, 84111.5794421024, 84898.5755071233, 87156.56421717851, 87311.56344218238, 73464.63267683628, 73881.6305918467, 74414.6279268611, 74786.0, 75428.62285688537, 8562.357823163164, 8688.478691278291, 8815.338849586178, 8828.161324674145, 8985.730428087169, 48436.5156348432, 49349.506504935925, 51892.0, 52645.7367713159, 53598.73200634128, 71308.0, 74403.62798185974, 74510.88233676608, 74808.62595687204, 74831.2516874846, 11024.669259922215, 11292.717682057686, 11293.604723834625, 11465.828012579652, 11555.2489088209, 12142.514299427923, 12562.246265224116, 12595.622131336075, 12596.622101336974, 12608.36958152107, 10967.835482467928, 11096.389698566334, 11253.88746112561, 11486.597969071043, 11520.88479115198, 11694.532218711156, 11807.0, 11819.704507387383, 11852.881471185523, 11958.940205298917, 11359.716007099558, 11391.943040284745, 11947.044236460888, 11962.04303655688, 11991.76016479683, 9309.394889332172, 9362.110599493037, 9397.906020939703, 9526.809463810547, 9712.223022158352, 9608.95195524018, 9790.75523111928, 9812.85280720804, 9854.901450985399, 9870.605175793175], "unit": "score", "name": "yui.html", "value": 7018.960505176876}], "name": "dromaeo_css", "value": 7725.579900944463}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [114.0, 96.0, 122.0, 116.0, 126.0, 188.0, 161.0, 114.0, 114.0, 114.0], "unit": "score", "name": "ai-astar", "value": 126.5}, {"lowerIsBetter": true, "replicates": [150.0, 121.0, 163.0, 181.0, 122.0, 164.0, 142.0, 193.0, 159.0, 128.0], "unit": "score", "name": "audio-beat-detection", "value": 152.3}, {"lowerIsBetter": true, "replicates": [220.0, 197.0, 271.0, 251.0, 195.0, 201.0, 195.0, 199.0, 199.0, 194.0], "unit": "score", "name": "audio-dft", "value": 212.2}, {"lowerIsBetter": true, "replicates": [68.0, 70.0, 72.0, 115.0, 55.0, 57.0, 56.0, 59.0, 117.0, 57.0], "unit": "score", "name": "audio-fft", "value": 72.6}, {"lowerIsBetter": true, "replicates": [82.0, 85.0, 118.0, 79.0, 77.0, 86.0, 116.0, 78.0, 78.0, 115.0], "unit": "score", "name": "audio-oscillator", "value": 91.4}, {"lowerIsBetter": true, "replicates": [91.0, 87.0, 89.0, 86.0, 88.0, 101.0, 135.0, 86.0, 88.0, 85.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 93.6}, {"lowerIsBetter": true, "replicates": [102.0, 101.0, 96.0, 143.0, 95.0, 91.0, 97.0, 111.0, 113.0, 120.0], "unit": "score", "name": "imaging-darkroom", "value": 106.9}, {"lowerIsBetter": true, "replicates": [122.0, 96.0, 132.0, 104.0, 86.0, 140.0, 141.0, 121.0, 142.0, 130.0], "unit": "score", "name": "imaging-desaturate", "value": 121.4}, {"lowerIsBetter": true, "replicates": [54.0, 60.0, 62.0, 60.0, 59.0, 60.0, 61.0, 68.0, 58.0, 86.0], "unit": "score", "name": "json-parse-financial", "value": 62.8}, {"lowerIsBetter": true, "replicates": [64.0, 100.0, 94.0, 101.0, 93.0, 69.0, 71.0, 66.0, 65.0, 66.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 78.9}, {"lowerIsBetter": true, "replicates": [84.0, 77.0, 81.0, 83.0, 82.0, 83.0, 82.0, 82.0, 83.0, 84.0], "unit": "score", "name": "stanford-crypto-aes", "value": 82.1}, {"lowerIsBetter": true, "replicates": [128.0, 141.0, 139.0, 111.0, 131.0, 147.0, 118.0, 131.0, 138.0, 119.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 130.3}, {"lowerIsBetter": true, "replicates": [127.0, 137.0, 146.0, 162.0, 139.0, 139.0, 135.0, 139.0, 161.0, 132.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 141.7}, {"lowerIsBetter": true, "replicates": [69.0, 66.0, 66.0, 66.0, 69.0, 66.0, 65.0, 81.0, 101.0, 92.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 74.1}], "name": "kraken", "value": 1546.8}]} 03:20:18 INFO - Return code: 0 03:20:19 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 03:20:19 ERROR - # TBPL SUCCESS # 03:20:19 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:20:19 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:20:19 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:20:19 INFO - 2016-04-21 03:20:19.061 screenresolution[1688:11114] starting screenresolution argv=screenresolution get 03:20:19 INFO - 2016-04-21 03:20:19.064 screenresolution[1688:11114] Display 0: 1600x1200x32@60 03:20:19 INFO - 2016-04-21 03:20:19.070 screenresolution[1689:11117] starting screenresolution argv=screenresolution list 03:20:19 INFO - Available Modes on Display 0 03:20:19 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:20:19 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:20:19 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:20:19 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:20:19 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:20:19 INFO - Intel Iris: 03:20:19 INFO - Chipset Model: Intel Iris 03:20:19 INFO - Type: GPU 03:20:19 INFO - Bus: Built-In 03:20:19 INFO - VRAM (Dynamic, Max): 1536 MB 03:20:19 INFO - Vendor: Intel (0x8086) 03:20:19 INFO - Device ID: 0x0a2e 03:20:19 INFO - Revision ID: 0x0009 03:20:19 INFO - Displays: 03:20:19 INFO - Display: 03:20:19 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:20:19 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:20:19 INFO - Display Serial Number: 1600x1200 60 03:20:19 INFO - Main Display: Yes 03:20:19 INFO - Mirror: Off 03:20:19 INFO - Online: Yes 03:20:19 INFO - Rotation: Supported 03:20:19 INFO - Return code: 0 03:20:19 INFO - Running post-action listener: _resource_record_post_action 03:20:19 INFO - Running post-run listener: _resource_record_post_run 03:20:20 INFO - Total resource usage - Wall time: 1203s; CPU: 53.0%; Read bytes: 32542208; Write bytes: 666327552; Read time: 321; Write time: 2090 03:20:20 INFO - install - Wall time: 32s; CPU: 54.0%; Read bytes: 362146304; Write bytes: 363300352; Read time: 28196; Write time: 661 03:20:20 INFO - run-tests - Wall time: 1172s; CPU: 53.0%; Read bytes: 30760448; Write bytes: 301655040; Read time: 303; Write time: 1427 03:20:20 INFO - Running post-run listener: _upload_blobber_files 03:20:20 INFO - Blob upload gear active. 03:20:20 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:20:20 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 03:20:20 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', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:20:20 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 Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:20:20 INFO - (blobuploader) - INFO - Open directory for files ... 03:20:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:20:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:20:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:20:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:20:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:20:21 INFO - (blobuploader) - INFO - Done attempting. 03:20:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:20:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:20:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:20:22 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:20:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:20:22 INFO - (blobuploader) - INFO - Done attempting. 03:20:22 INFO - (blobuploader) - INFO - Iteration through files over. 03:20:22 INFO - Return code: 0 03:20:22 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:20:22 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:20:22 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/37f86c1253f7fb61fa91871e1b67f4f5ed3e7713fa43c1a7e4b9c9e9c217e6e7d2cd0da8061f759a6969ef77865a041a310ea50d56e6a99c9e31b29fb460a0b4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8cc8d434ed6d81197a7e8b94677ce134b3e207cd466dc524711de7579959233cc0f5336c6112c8386497da7775d65b1260539de05c101f5086dfff004122a9b9"} 03:20:22 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:20:22 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:20:22 INFO - Contents: 03:20:22 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/37f86c1253f7fb61fa91871e1b67f4f5ed3e7713fa43c1a7e4b9c9e9c217e6e7d2cd0da8061f759a6969ef77865a041a310ea50d56e6a99c9e31b29fb460a0b4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8cc8d434ed6d81197a7e8b94677ce134b3e207cd466dc524711de7579959233cc0f5336c6112c8386497da7775d65b1260539de05c101f5086dfff004122a9b9"} 03:20:22 INFO - Running post-run listener: copy_logs_to_upload_dir 03:20:22 INFO - Copying logs to upload dir... 03:20:22 INFO - mkdir: /builds/slave/test/build/upload/logs 03:20:22 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1259.552423 ========= master_lag: 0.44 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 59 secs) (at 2016-04-21 03:20:22.581841) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-21 03:20:22.585325) ========= 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.RADXpxaORO/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.VUVFzidAel/Listeners TMPDIR=/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/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/Mozilla-Aurora/sha512/37f86c1253f7fb61fa91871e1b67f4f5ed3e7713fa43c1a7e4b9c9e9c217e6e7d2cd0da8061f759a6969ef77865a041a310ea50d56e6a99c9e31b29fb460a0b4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8cc8d434ed6d81197a7e8b94677ce134b3e207cd466dc524711de7579959233cc0f5336c6112c8386497da7775d65b1260539de05c101f5086dfff004122a9b9"} build_url:https://queue.taskcluster.net/v1/task/QYA9JMn0QByLdkawb6hf5w/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011179 build_url: 'https://queue.taskcluster.net/v1/task/QYA9JMn0QByLdkawb6hf5w/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/37f86c1253f7fb61fa91871e1b67f4f5ed3e7713fa43c1a7e4b9c9e9c217e6e7d2cd0da8061f759a6969ef77865a041a310ea50d56e6a99c9e31b29fb460a0b4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8cc8d434ed6d81197a7e8b94677ce134b3e207cd466dc524711de7579959233cc0f5336c6112c8386497da7775d65b1260539de05c101f5086dfff004122a9b9"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-21 03:20:22.615904) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-21 03:20:22.616459) ========= 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.RADXpxaORO/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.VUVFzidAel/Listeners TMPDIR=/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/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.004982 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-21 03:20:22.666718) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-21 03:20:22.667041) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-21 03:20:22.667455) ========= ========= Total master_lag: 14.55 =========