builder: mozilla-aurora_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0196 starttime: 1460713833.83 results: success (0) buildid: 20160415004038 builduid: 67d6d06e83554bda87b9211ef3b633d1 revision: 4633816cde73beee6ed194e571c3a2ba14b15069 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-15 02:50:33.828628) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-15 02:50:33.830488) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-15 02:50:33.831169) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-15 02:50:33.858037) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 02:50:33.858297) ========= 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.CkmTW3Qzuf/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.KT4J6be3Pu/Listeners TMPDIR=/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/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-15 02:50:33-- 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% 27.8M=0s 2016-04-15 02:50:33 (27.8 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.088268 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 02:50:33.964961) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 02:50:33.965592) ========= 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.CkmTW3Qzuf/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.KT4J6be3Pu/Listeners TMPDIR=/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/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.026158 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 02:50:34.018321) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-15 02:50:34.019212) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 4633816cde73beee6ed194e571c3a2ba14b15069 --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 4633816cde73beee6ed194e571c3a2ba14b15069 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.CkmTW3Qzuf/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.KT4J6be3Pu/Listeners TMPDIR=/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/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-15 02:50:34,092 truncating revision to first 12 chars 2016-04-15 02:50:34,092 Setting DEBUG logging. 2016-04-15 02:50:34,092 attempt 1/10 2016-04-15 02:50:34,092 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/4633816cde73?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-15 02:50:35,151 unpacking tar archive at: mozilla-aurora-4633816cde73/testing/mozharness/ program finished with exit code 0 elapsedTime=1.307748 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-15 02:50:35.345175) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-15 02:50:35.345495) ========= script_repo_revision: 4633816cde73beee6ed194e571c3a2ba14b15069 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-15 02:50:35.347922) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-15 02:50:35.348214) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-15 02:50:35.362507) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2016-04-15 02:50:35.362807) ========= /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.CkmTW3Qzuf/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.KT4J6be3Pu/Listeners TMPDIR=/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/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:50:35 INFO - MultiFileLogger online at 20160415 02:50:35 in /builds/slave/test 02:50:35 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:50:35 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:50:35 INFO - {'append_to_log': False, 02:50:35 INFO - 'base_work_dir': '/builds/slave/test', 02:50:35 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 02:50:35 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:50:35 INFO - 'branch': 'Mozilla-Aurora', 02:50:35 INFO - 'buildbot_json_path': 'buildprops.json', 02:50:35 INFO - 'config_files': ('talos/mac_config.py',), 02:50:35 INFO - 'default_actions': ('clobber', 02:50:35 INFO - 'read-buildbot-config', 02:50:35 INFO - 'download-and-extract', 02:50:35 INFO - 'populate-webroot', 02:50:35 INFO - 'create-virtualenv', 02:50:35 INFO - 'install', 02:50:35 INFO - 'run-tests'), 02:50:35 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:50:35 INFO - 'download_minidump_stackwalk': True, 02:50:35 INFO - 'download_symbols': 'ondemand', 02:50:35 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:50:35 INFO - 'tooltool.py': '/tools/tooltool.py', 02:50:35 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:50:35 INFO - '/tools/misc-python/virtualenv.py')}, 02:50:35 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:50:35 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:50:35 INFO - 'installer_path': 'installer.exe', 02:50:35 INFO - 'log_level': 'info', 02:50:35 INFO - 'log_name': 'talos', 02:50:35 INFO - 'log_to_console': True, 02:50:35 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 02:50:35 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 02:50:35 INFO - 'opt_config_files': (), 02:50:35 INFO - 'pip_index': False, 02:50:35 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:50:35 INFO - 'cmd': ('bash', 02:50:35 INFO - '-c', 02:50:35 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:50:35 INFO - 'enabled': True, 02:50:35 INFO - 'halt_on_failure': False, 02:50:35 INFO - 'name': 'check_screen_resolution'},), 02:50:35 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:50:35 INFO - 'cmd': ('bash', 02:50:35 INFO - '-c', 02:50:35 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:50:35 INFO - 'enabled': True, 02:50:35 INFO - 'halt_on_failure': False, 02:50:35 INFO - 'name': 'check_screen_resolution'},), 02:50:35 INFO - 'run_cmd_checks_enabled': True, 02:50:35 INFO - 'sps_profile': False, 02:50:35 INFO - 'sps_profile_interval': 0, 02:50:35 INFO - 'suite': 'dromaeojs-e10s', 02:50:35 INFO - 'system_bits': '32', 02:50:35 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:50:35 INFO - 'title': 't-yosemite-r7-0196', 02:50:35 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:50:35 INFO - 'use_talos_json': True, 02:50:35 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:50:35 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:50:35 INFO - 'work_dir': 'build'} 02:50:35 INFO - ##### 02:50:35 INFO - ##### Running clobber step. 02:50:35 INFO - ##### 02:50:35 INFO - Running pre-action listener: _resource_record_pre_action 02:50:35 INFO - Running main action method: clobber 02:50:35 INFO - rmtree: /builds/slave/test/build 02:50:35 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:50:37 INFO - Running post-action listener: _resource_record_post_action 02:50:37 INFO - ##### 02:50:37 INFO - ##### Running read-buildbot-config step. 02:50:37 INFO - ##### 02:50:37 INFO - Running pre-action listener: _resource_record_pre_action 02:50:37 INFO - Running main action method: read_buildbot_config 02:50:37 INFO - Using buildbot properties: 02:50:37 INFO - { 02:50:37 INFO - "project": "", 02:50:37 INFO - "product": "firefox", 02:50:37 INFO - "script_repo_revision": "production", 02:50:37 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs-e10s", 02:50:37 INFO - "repository": "", 02:50:37 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs-e10s", 02:50:37 INFO - "buildid": "20160415004038", 02:50:37 INFO - "stage_platform": "macosx64", 02:50:37 INFO - "basedir": "/builds/slave/test", 02:50:37 INFO - "nightly_build": "True", 02:50:37 INFO - "buildnumber": 267, 02:50:37 INFO - "slavename": "t-yosemite-r7-0196", 02:50:37 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 02:50:37 INFO - "platform": "yosemite_r7", 02:50:37 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 02:50:37 INFO - "branch": "mozilla-aurora", 02:50:37 INFO - "repo_path": "releases/mozilla-aurora", 02:50:37 INFO - "revision": "4633816cde73beee6ed194e571c3a2ba14b15069", 02:50:37 INFO - "pgo_build": "False", 02:50:37 INFO - "builduid": "67d6d06e83554bda87b9211ef3b633d1", 02:50:37 INFO - "slavebuilddir": "test" 02:50:37 INFO - } 02:50:37 INFO - Found installer url https://queue.taskcluster.net/v1/task/M5bjiJmwSFy7BOoa7S64RA/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg. 02:50:37 INFO - Running post-action listener: _resource_record_post_action 02:50:37 INFO - ##### 02:50:37 INFO - ##### Running download-and-extract step. 02:50:37 INFO - ##### 02:50:37 INFO - Running pre-action listener: _resource_record_pre_action 02:50:37 INFO - Running main action method: download_and_extract 02:50:37 INFO - mkdir: /builds/slave/test/build/tests 02:50: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:50:37 INFO - https://queue.taskcluster.net/v1/task/M5bjiJmwSFy7BOoa7S64RA/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json matches https://queue.taskcluster.net 02:50:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M5bjiJmwSFy7BOoa7S64RA/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json 02:50:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M5bjiJmwSFy7BOoa7S64RA/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json 02:50:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M5bjiJmwSFy7BOoa7S64RA/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:50:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M5bjiJmwSFy7BOoa7S64RA/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:50:38 INFO - Downloaded 1277 bytes. 02:50:38 INFO - Reading from file /builds/slave/test/build/firefox-47.0a2.en-US.mac.test_packages.json 02:50:38 INFO - Using the following test package requirements: 02:50:38 INFO - {u'common': [u'firefox-47.0a2.en-US.mac.common.tests.zip'], 02:50:38 INFO - u'cppunittest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 02:50:38 INFO - u'firefox-47.0a2.en-US.mac.cppunittest.tests.zip'], 02:50:38 INFO - u'gtest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 02:50:38 INFO - u'firefox-47.0a2.en-US.mac.gtest.tests.zip'], 02:50:38 INFO - u'jittest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 02:50:38 INFO - u'jsshell-mac.zip'], 02:50:38 INFO - u'mochitest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 02:50:38 INFO - u'firefox-47.0a2.en-US.mac.mochitest.tests.zip'], 02:50:38 INFO - u'mozbase': [u'firefox-47.0a2.en-US.mac.common.tests.zip'], 02:50:38 INFO - u'reftest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 02:50:38 INFO - u'firefox-47.0a2.en-US.mac.reftest.tests.zip'], 02:50:38 INFO - u'talos': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 02:50:38 INFO - u'firefox-47.0a2.en-US.mac.talos.tests.zip'], 02:50:39 INFO - u'web-platform': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 02:50:39 INFO - u'firefox-47.0a2.en-US.mac.web-platform.tests.zip'], 02:50:39 INFO - u'webapprt': [u'firefox-47.0a2.en-US.mac.common.tests.zip'], 02:50:39 INFO - u'xpcshell': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 02:50:39 INFO - u'firefox-47.0a2.en-US.mac.xpcshell.tests.zip']} 02:50:39 INFO - Downloading packages: [u'firefox-47.0a2.en-US.mac.common.tests.zip'] for test suite category: common 02:50:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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:50:39 INFO - https://queue.taskcluster.net/v1/task/M5bjiJmwSFy7BOoa7S64RA/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 02:50:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M5bjiJmwSFy7BOoa7S64RA/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 02:50:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M5bjiJmwSFy7BOoa7S64RA/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 02:50:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M5bjiJmwSFy7BOoa7S64RA/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:50:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M5bjiJmwSFy7BOoa7S64RA/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:50:42 INFO - Downloaded 17911146 bytes. 02:50:42 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:50:42 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:50:45 INFO - Return code: 0 02:50:45 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:50:45 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:50:45 INFO - https://queue.taskcluster.net/v1/task/M5bjiJmwSFy7BOoa7S64RA/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 02:50:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M5bjiJmwSFy7BOoa7S64RA/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 02:50:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M5bjiJmwSFy7BOoa7S64RA/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 02:50:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M5bjiJmwSFy7BOoa7S64RA/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:50:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M5bjiJmwSFy7BOoa7S64RA/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:50:47 INFO - Downloaded 17911146 bytes. 02:50:47 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:50:47 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:50:51 INFO - Return code: 0 02:50:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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:50:51 INFO - https://queue.taskcluster.net/v1/task/M5bjiJmwSFy7BOoa7S64RA/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 02:50:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M5bjiJmwSFy7BOoa7S64RA/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip 02:50:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M5bjiJmwSFy7BOoa7S64RA/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip 02:50:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M5bjiJmwSFy7BOoa7S64RA/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:50:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M5bjiJmwSFy7BOoa7S64RA/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:50:52 INFO - Downloaded 10845168 bytes. 02:50:52 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:50:52 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:50:52 INFO - Return code: 0 02:50: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:50:52 INFO - https://queue.taskcluster.net/v1/task/M5bjiJmwSFy7BOoa7S64RA/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg matches https://queue.taskcluster.net 02:50:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M5bjiJmwSFy7BOoa7S64RA/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 02:50:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M5bjiJmwSFy7BOoa7S64RA/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 02:50:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M5bjiJmwSFy7BOoa7S64RA/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a2.en-US.mac.dmg 02:50:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M5bjiJmwSFy7BOoa7S64RA/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:50:58 INFO - Downloaded 115310490 bytes. 02:50:58 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/M5bjiJmwSFy7BOoa7S64RA/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 02:50:58 INFO - mkdir: /builds/slave/test/properties 02:50:58 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:50:58 INFO - Writing to file /builds/slave/test/properties/build_url 02:50:58 INFO - Contents: 02:50:58 INFO - build_url:https://queue.taskcluster.net/v1/task/M5bjiJmwSFy7BOoa7S64RA/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 02:50:59 INFO - Running post-action listener: _resource_record_post_action 02:50:59 INFO - Running post-action listener: set_extra_try_arguments 02:50:59 INFO - ##### 02:50:59 INFO - ##### Running populate-webroot step. 02:50:59 INFO - ##### 02:50:59 INFO - Running pre-action listener: _resource_record_pre_action 02:50:59 INFO - Running main action method: populate_webroot 02:50:59 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:50:59 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:50:59 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:50:59 INFO - '--tppagecycles', 02:50:59 INFO - '7'], 02:50:59 INFO - 'tests': ['tsvgm']}}, 02:50:59 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 02:50:59 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 02:50:59 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:50:59 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 02:50:59 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 02:50:59 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:50:59 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:50:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:50:59 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:50:59 INFO - 'talos_options': ['--e10s'], 02:50:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:50:59 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:50:59 INFO - 'tests': ['damp', 'tps']}, 02:50:59 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:50:59 INFO - 'talos_options': ['--e10s'], 02:50:59 INFO - 'tests': ['damp', 'tps']}, 02:50:59 INFO - 'g3': {'tests': ['dromaeo_dom']}, 02:50:59 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:50:59 INFO - 'other': {'tests': ['a11yr', 02:50:59 INFO - 'ts_paint', 02:50:59 INFO - 'tpaint', 02:50:59 INFO - 'sessionrestore', 02:50:59 INFO - 'sessionrestore_no_auto_restore', 02:50:59 INFO - 'tabpaint']}, 02:50:59 INFO - 'other-e10s': {'talos_options': ['--e10s'], 02:50:59 INFO - 'tests': ['a11yr', 02:50:59 INFO - 'ts_paint', 02:50:59 INFO - 'tpaint', 02:50:59 INFO - 'sessionrestore', 02:50:59 INFO - 'sessionrestore_no_auto_restore', 02:50:59 INFO - 'tabpaint']}, 02:50:59 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 02:50:59 INFO - 'tests': ['a11yr', 02:50:59 INFO - 'ts_paint', 02:50:59 INFO - 'tpaint', 02:50:59 INFO - 'sessionrestore', 02:50:59 INFO - 'sessionrestore_no_auto_restore', 02:50:59 INFO - 'tabpaint']}, 02:50:59 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 02:50:59 INFO - 'tests': ['a11yr', 02:50:59 INFO - 'ts_paint', 02:50:59 INFO - 'tpaint', 02:50:59 INFO - 'sessionrestore', 02:50:59 INFO - 'sessionrestore_no_auto_restore', 02:50:59 INFO - 'tabpaint']}, 02:50:59 INFO - 'other_l64': {'tests': ['a11yr', 02:50:59 INFO - 'ts_paint', 02:50:59 INFO - 'tpaint', 02:50:59 INFO - 'sessionrestore', 02:50:59 INFO - 'sessionrestore_no_auto_restore', 02:50:59 INFO - 'tabpaint']}, 02:50:59 INFO - 'other_nol64': {'tests': ['a11yr', 02:50:59 INFO - 'ts_paint', 02:50:59 INFO - 'tpaint', 02:50:59 INFO - 'sessionrestore', 02:50:59 INFO - 'sessionrestore_no_auto_restore', 02:50:59 INFO - 'tabpaint']}, 02:50:59 INFO - 'svgr': {'tests': ['tsvgx', 02:50:59 INFO - 'tsvgr_opacity', 02:50:59 INFO - 'tart', 02:50:59 INFO - 'tscrollx', 02:50:59 INFO - 'cart']}, 02:50:59 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 02:50:59 INFO - 'tests': ['tsvgx', 02:50:59 INFO - 'tsvgr_opacity', 02:50:59 INFO - 'tart', 02:50:59 INFO - 'tscrollx', 02:50:59 INFO - 'cart']}, 02:50:59 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:50:59 INFO - 'tests': ['tp5o']}, 02:50:59 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:50:59 INFO - 'talos_options': ['--e10s'], 02:50:59 INFO - 'tests': ['tp5o']}, 02:50:59 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:50:59 INFO - 'talos_options': ['--xperf_path', 02:50:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:50:59 INFO - 'tests': ['tp5n']}, 02:50:59 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:50:59 INFO - 'talos_options': ['--e10s', 02:50:59 INFO - '--xperf_path', 02:50:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:50:59 INFO - 'tests': ['tp5n']}}, 02:50:59 INFO - 'talos.zip': {'path': '', 02:50:59 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:50:59 INFO - Running post-action listener: _resource_record_post_action 02:50:59 INFO - ##### 02:50:59 INFO - ##### Running create-virtualenv step. 02:50:59 INFO - ##### 02:50:59 INFO - Running pre-action listener: _resource_record_pre_action 02:50:59 INFO - Running main action method: create_virtualenv 02:50:59 INFO - Creating virtualenv /builds/slave/test/build/venv 02:50:59 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:50:59 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:50:59 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:50:59 INFO - Using real prefix '/tools/python27' 02:50:59 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:51:00 INFO - Installing distribute.............................................................................................................................................................................................done. 02:51:03 INFO - Installing pip.................done. 02:51:03 INFO - Return code: 0 02:51:03 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:51:03 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:51:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:51:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:51:03 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:51:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:51:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:51:03 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 0x10ba74a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ba7b4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb4b9d84200>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b918d30>, '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 0x10b77cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b90fb20>, '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.CkmTW3Qzuf/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.KT4J6be3Pu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/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:51:03 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:51:03 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:51:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CkmTW3Qzuf/Render', 02:51:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:51:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:51:03 INFO - 'HOME': '/Users/cltbld', 02:51:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:51:03 INFO - 'LOGNAME': 'cltbld', 02:51:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:51:03 INFO - 'MOZ_NO_REMOTE': '1', 02:51:03 INFO - 'NO_EM_RESTART': '1', 02:51:03 INFO - 'PAGER': '/bin/cat', 02:51:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:51:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:51:03 INFO - 'PWD': '/builds/slave/test', 02:51:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:51:03 INFO - 'SHELL': '/bin/bash', 02:51:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KT4J6be3Pu/Listeners', 02:51:03 INFO - 'TMPDIR': '/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/', 02:51:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:51:03 INFO - 'USER': 'cltbld', 02:51:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:51:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:51:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:51:03 INFO - 'XPC_FLAGS': '0x0', 02:51:03 INFO - 'XPC_SERVICE_NAME': '0', 02:51:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:51:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:51:03 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:51:03 INFO - Cleaning up... 02:51:03 INFO - Return code: 0 02:51:03 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 02:51:03 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:51:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:51:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:51:03 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:51:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:51:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:51:03 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 0x10ba74a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ba7b4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb4b9d84200>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b918d30>, '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 0x10b77cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b90fb20>, '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.CkmTW3Qzuf/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.KT4J6be3Pu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/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:51:03 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:51:03 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:51:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CkmTW3Qzuf/Render', 02:51:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:51:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:51:03 INFO - 'HOME': '/Users/cltbld', 02:51:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:51:03 INFO - 'LOGNAME': 'cltbld', 02:51:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:51:03 INFO - 'MOZ_NO_REMOTE': '1', 02:51:03 INFO - 'NO_EM_RESTART': '1', 02:51:03 INFO - 'PAGER': '/bin/cat', 02:51:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:51:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:51:03 INFO - 'PWD': '/builds/slave/test', 02:51:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:51:03 INFO - 'SHELL': '/bin/bash', 02:51:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KT4J6be3Pu/Listeners', 02:51:03 INFO - 'TMPDIR': '/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/', 02:51:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:51:03 INFO - 'USER': 'cltbld', 02:51:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:51:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:51:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:51:03 INFO - 'XPC_FLAGS': '0x0', 02:51:03 INFO - 'XPC_SERVICE_NAME': '0', 02:51:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:51:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:51:03 INFO - Downloading/unpacking psutil>=0.7.1 02:51:03 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:51:03 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:51:03 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:51:03 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:51:03 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:51:03 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:51:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:51:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:51:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:51:06 INFO - Installing collected packages: psutil 02:51:06 INFO - Running setup.py install for psutil 02:51:06 INFO - building 'psutil._psutil_osx' extension 02:51:06 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:51:07 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:51:07 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:51:07 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:51:07 INFO - building 'psutil._psutil_posix' extension 02:51:07 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:51:07 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 02:51:07 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 02:51:07 INFO - ^ 02:51:07 INFO - 1 warning generated. 02:51:07 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:51:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:51:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:51:07 INFO - Successfully installed psutil 02:51:07 INFO - Cleaning up... 02:51:08 INFO - Return code: 0 02:51:08 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 02:51:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:51:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:51:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:51:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:51:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:51:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:51:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10ba74a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ba7b4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb4b9d84200>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b918d30>, '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 0x10b77cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b90fb20>, '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.CkmTW3Qzuf/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.KT4J6be3Pu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/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:51:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 02:51:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 02:51:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CkmTW3Qzuf/Render', 02:51:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:51:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:51:08 INFO - 'HOME': '/Users/cltbld', 02:51:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:51:08 INFO - 'LOGNAME': 'cltbld', 02:51:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:51:08 INFO - 'MOZ_NO_REMOTE': '1', 02:51:08 INFO - 'NO_EM_RESTART': '1', 02:51:08 INFO - 'PAGER': '/bin/cat', 02:51:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:51:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:51:08 INFO - 'PWD': '/builds/slave/test', 02:51:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:51:08 INFO - 'SHELL': '/bin/bash', 02:51:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KT4J6be3Pu/Listeners', 02:51:08 INFO - 'TMPDIR': '/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/', 02:51:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:51:08 INFO - 'USER': 'cltbld', 02:51:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:51:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:51:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:51:08 INFO - 'XPC_FLAGS': '0x0', 02:51:08 INFO - 'XPC_SERVICE_NAME': '0', 02:51:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:51:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:51:08 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 02:51:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:51:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:51:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:51:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:51:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:51:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:51:10 INFO - Downloading mozsystemmonitor-0.0.tar.gz 02:51:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:51:10 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:51:10 INFO - Installing collected packages: mozsystemmonitor 02:51:10 INFO - Running setup.py install for mozsystemmonitor 02:51:10 INFO - Successfully installed mozsystemmonitor 02:51:10 INFO - Cleaning up... 02:51:11 INFO - Return code: 0 02:51:11 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:51: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')]} 02:51:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:51:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:51: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')]} 02:51:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:51:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:51: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', '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 0x10ba74a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ba7b4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb4b9d84200>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b918d30>, '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 0x10b77cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b90fb20>, '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.CkmTW3Qzuf/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.KT4J6be3Pu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/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:51: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 02:51: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 blobuploader==1.2.4 02:51:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CkmTW3Qzuf/Render', 02:51:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:51:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:51:11 INFO - 'HOME': '/Users/cltbld', 02:51:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:51:11 INFO - 'LOGNAME': 'cltbld', 02:51:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:51:11 INFO - 'MOZ_NO_REMOTE': '1', 02:51:11 INFO - 'NO_EM_RESTART': '1', 02:51:11 INFO - 'PAGER': '/bin/cat', 02:51:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:51:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:51:11 INFO - 'PWD': '/builds/slave/test', 02:51:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:51:11 INFO - 'SHELL': '/bin/bash', 02:51:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KT4J6be3Pu/Listeners', 02:51:11 INFO - 'TMPDIR': '/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/', 02:51:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:51:11 INFO - 'USER': 'cltbld', 02:51:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:51:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:51:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:51:11 INFO - 'XPC_FLAGS': '0x0', 02:51:11 INFO - 'XPC_SERVICE_NAME': '0', 02:51:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:51:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:51:11 INFO - Downloading/unpacking blobuploader==1.2.4 02:51: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 02:51: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 02:51: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 02:51: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 02:51: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 02:51: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 02:51:13 INFO - Downloading blobuploader-1.2.4.tar.gz 02:51:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:51:13 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:51: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 02:51: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 02:51: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 02:51: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 02:51: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 02:51: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 02:51:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:51:14 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:51: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 02:51: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 02:51: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 02:51: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 02:51: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 02:51: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 02:51:14 INFO - Downloading docopt-0.6.1.tar.gz 02:51:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:51:15 INFO - Installing collected packages: blobuploader, requests, docopt 02:51:15 INFO - Running setup.py install for blobuploader 02:51:15 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:51:15 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:51:15 INFO - Running setup.py install for requests 02:51:15 INFO - Running setup.py install for docopt 02:51:15 INFO - Successfully installed blobuploader requests docopt 02:51:15 INFO - Cleaning up... 02:51:15 INFO - Return code: 0 02:51:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:51:15 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:51:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:51:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:51:15 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:51:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:51:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:51:15 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 0x10ba74a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ba7b4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb4b9d84200>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b918d30>, '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 0x10b77cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b90fb20>, '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.CkmTW3Qzuf/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.KT4J6be3Pu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/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:51:15 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:51:15 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:51:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CkmTW3Qzuf/Render', 02:51:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:51:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:51:15 INFO - 'HOME': '/Users/cltbld', 02:51:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:51:15 INFO - 'LOGNAME': 'cltbld', 02:51:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:51:15 INFO - 'MOZ_NO_REMOTE': '1', 02:51:15 INFO - 'NO_EM_RESTART': '1', 02:51:15 INFO - 'PAGER': '/bin/cat', 02:51:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:51:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:51:15 INFO - 'PWD': '/builds/slave/test', 02:51:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:51:15 INFO - 'SHELL': '/bin/bash', 02:51:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KT4J6be3Pu/Listeners', 02:51:15 INFO - 'TMPDIR': '/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/', 02:51:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:51:15 INFO - 'USER': 'cltbld', 02:51:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:51:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:51:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:51:15 INFO - 'XPC_FLAGS': '0x0', 02:51:15 INFO - 'XPC_SERVICE_NAME': '0', 02:51:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:51:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:51:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:51:16 INFO - Running setup.py (path:/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/pip-GwmoFL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:51:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:51:16 INFO - Running setup.py (path:/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/pip-DK_Ic1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:51:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:51:16 INFO - Running setup.py (path:/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/pip-5DLfVD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:51:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:51:16 INFO - Running setup.py (path:/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/pip-7O51j3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:51:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:51:16 INFO - Running setup.py (path:/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/pip-bUk3Bl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:51:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:51:16 INFO - Running setup.py (path:/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/pip-bqsjbW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:51:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:51:16 INFO - Running setup.py (path:/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/pip-lWVgKh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:51:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:51:16 INFO - Running setup.py (path:/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/pip-Iezenh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:51:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:51:17 INFO - Running setup.py (path:/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/pip-CYGFf9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:51:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:51:17 INFO - Running setup.py (path:/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/pip-GoTRtr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:51:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:51:17 INFO - Running setup.py (path:/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/pip-zO3lhF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:51:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:51:17 INFO - Running setup.py (path:/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/pip-1r_hd_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:51:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:51:17 INFO - Running setup.py (path:/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/pip-bREeeS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:51:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:51:17 INFO - Running setup.py (path:/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/pip-Qh2oF_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:51:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:51:17 INFO - Running setup.py (path:/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/pip-tc3q9A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:51:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:51:17 INFO - Running setup.py (path:/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/pip-hJW1W6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:51:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:51:17 INFO - Running setup.py (path:/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/pip-d7LCp8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:51:17 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:51:17 INFO - Running setup.py install for manifestparser 02:51:18 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:51:18 INFO - Running setup.py install for mozcrash 02:51:18 INFO - Running setup.py install for mozdebug 02:51:18 INFO - Running setup.py install for mozdevice 02:51:18 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:51:18 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:51:18 INFO - Running setup.py install for mozfile 02:51:18 INFO - Running setup.py install for mozhttpd 02:51:18 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:51:18 INFO - Running setup.py install for mozinfo 02:51:18 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:51:18 INFO - Running setup.py install for mozInstall 02:51:19 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:51:19 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:51:19 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:51:19 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:51:19 INFO - Running setup.py install for mozleak 02:51:19 INFO - Running setup.py install for mozlog 02:51:19 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:51:19 INFO - Running setup.py install for moznetwork 02:51:19 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:51:19 INFO - Running setup.py install for mozprocess 02:51:19 INFO - Running setup.py install for mozprofile 02:51:19 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:51:19 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:51:19 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:51:19 INFO - Running setup.py install for mozrunner 02:51:20 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:51:20 INFO - Running setup.py install for mozscreenshot 02:51:20 INFO - Running setup.py install for moztest 02:51:20 INFO - Running setup.py install for mozversion 02:51:20 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:51:20 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:51:20 INFO - Cleaning up... 02:51:20 INFO - Return code: 0 02:51:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:51:20 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:51:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:51:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:51:20 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:51:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:51:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:51:20 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 0x10ba74a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ba7b4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb4b9d84200>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b918d30>, '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 0x10b77cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b90fb20>, '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.CkmTW3Qzuf/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.KT4J6be3Pu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/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:51:20 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 02:51:20 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 02:51:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CkmTW3Qzuf/Render', 02:51:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:51:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:51:20 INFO - 'HOME': '/Users/cltbld', 02:51:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:51:20 INFO - 'LOGNAME': 'cltbld', 02:51:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:51:20 INFO - 'MOZ_NO_REMOTE': '1', 02:51:20 INFO - 'NO_EM_RESTART': '1', 02:51:20 INFO - 'PAGER': '/bin/cat', 02:51:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:51:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:51:20 INFO - 'PWD': '/builds/slave/test', 02:51:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:51:20 INFO - 'SHELL': '/bin/bash', 02:51:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KT4J6be3Pu/Listeners', 02:51:20 INFO - 'TMPDIR': '/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/', 02:51:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:51:20 INFO - 'USER': 'cltbld', 02:51:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:51:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:51:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:51:20 INFO - 'XPC_FLAGS': '0x0', 02:51:20 INFO - 'XPC_SERVICE_NAME': '0', 02:51:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:51:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:51:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:51:20 INFO - Running setup.py (path:/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/pip-utF2M4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:51:20 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)) 02:51:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:51:20 INFO - Running setup.py (path:/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/pip-UaX3lZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:51:21 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)) 02:51:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:51:21 INFO - Running setup.py (path:/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/pip-6pLSgf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:51:21 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)) 02:51:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:51:21 INFO - Running setup.py (path:/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/pip-3HdkMT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:51:21 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)) 02:51:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:51:21 INFO - Running setup.py (path:/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/pip-icGU8U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:51:21 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)) 02:51:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:51:21 INFO - Running setup.py (path:/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/pip-p4VlGa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:51:21 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)) 02:51:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:51:21 INFO - Running setup.py (path:/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/pip-dKl86S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:51:21 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)) 02:51:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:51:21 INFO - Running setup.py (path:/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/pip-4OP6hh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:51:21 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)) 02:51:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:51:21 INFO - Running setup.py (path:/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/pip-9R5V_n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:51:21 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)) 02:51:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:51:21 INFO - Running setup.py (path:/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/pip-RXyUQD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:51:21 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)) 02:51:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:51:21 INFO - Running setup.py (path:/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/pip-zWp0xi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:51:21 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)) 02:51:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:51:21 INFO - Running setup.py (path:/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/pip-K9YKgu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:51:22 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)) 02:51:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:51:22 INFO - Running setup.py (path:/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/pip-Bh0ZZJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:51:22 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)) 02:51:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:51:22 INFO - Running setup.py (path:/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/pip-bZZKCo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:51:22 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)) 02:51:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:51:22 INFO - Running setup.py (path:/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/pip-ynCtc1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:51:22 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)) 02:51:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:51:22 INFO - Running setup.py (path:/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/pip-gRmozB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:51:22 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)) 02:51:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:51:22 INFO - Running setup.py (path:/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/pip-jt5uyJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:51:22 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)) 02:51:22 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)) 02:51:22 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)) 02:51:22 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)) 02:51:22 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)) 02:51:22 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)) 02:51:22 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:51:22 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:51:22 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:51:22 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:51:22 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:51:22 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:51:22 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:51:25 INFO - Downloading blessings-1.6.tar.gz 02:51:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:51:25 INFO - Installing collected packages: blessings 02:51:25 INFO - Running setup.py install for blessings 02:51:25 INFO - Successfully installed blessings 02:51:25 INFO - Cleaning up... 02:51:25 INFO - Return code: 0 02:51:25 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:51:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:51:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:51:25 INFO - Reading from file tmpfile_stdout 02:51:25 INFO - Current package versions: 02:51:25 INFO - blessings == 1.6 02:51:25 INFO - blobuploader == 1.2.4 02:51:25 INFO - docopt == 0.6.1 02:51:25 INFO - manifestparser == 1.1 02:51:25 INFO - mozInstall == 1.12 02:51:25 INFO - mozcrash == 0.17 02:51:25 INFO - mozdebug == 0.1 02:51:25 INFO - mozdevice == 0.48 02:51:25 INFO - mozfile == 1.2 02:51:25 INFO - mozhttpd == 0.7 02:51:25 INFO - mozinfo == 0.9 02:51:25 INFO - mozleak == 0.1 02:51:25 INFO - mozlog == 3.1 02:51:25 INFO - moznetwork == 0.27 02:51:25 INFO - mozprocess == 0.22 02:51:25 INFO - mozprofile == 0.28 02:51:25 INFO - mozrunner == 6.11 02:51:25 INFO - mozscreenshot == 0.1 02:51:25 INFO - mozsystemmonitor == 0.0 02:51:25 INFO - moztest == 0.7 02:51:25 INFO - mozversion == 1.4 02:51:25 INFO - psutil == 3.1.1 02:51:25 INFO - requests == 1.2.3 02:51:25 INFO - wsgiref == 0.1.2 02:51:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:51: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:51:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:51:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:51: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:51:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:51:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:51:25 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 0x10ba74a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ba7b4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb4b9d84200>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b918d30>, '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 0x10b77cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b90fb20>, '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.CkmTW3Qzuf/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.KT4J6be3Pu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/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:51:25 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 02:51:25 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 02:51:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CkmTW3Qzuf/Render', 02:51:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:51:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:51:25 INFO - 'HOME': '/Users/cltbld', 02:51:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:51:25 INFO - 'LOGNAME': 'cltbld', 02:51:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:51:25 INFO - 'MOZ_NO_REMOTE': '1', 02:51:25 INFO - 'NO_EM_RESTART': '1', 02:51:25 INFO - 'PAGER': '/bin/cat', 02:51:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:51:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:51:25 INFO - 'PWD': '/builds/slave/test', 02:51:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:51:25 INFO - 'SHELL': '/bin/bash', 02:51:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KT4J6be3Pu/Listeners', 02:51:25 INFO - 'TMPDIR': '/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/', 02:51:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:51:25 INFO - 'USER': 'cltbld', 02:51:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:51:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:51:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:51:25 INFO - 'XPC_FLAGS': '0x0', 02:51:25 INFO - 'XPC_SERVICE_NAME': '0', 02:51:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:51:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:51:25 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)) 02:51:25 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)) 02:51:25 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)) 02:51:25 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)) 02:51:25 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)) 02:51:25 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)) 02:51:25 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)) 02:51:25 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)) 02:51:25 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)) 02:51:25 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)) 02:51:25 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)) 02:51:25 INFO - Cleaning up... 02:51:25 INFO - Return code: 0 02:51:25 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:51: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:51:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:51:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:51: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:51:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:51:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:51:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ba74a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ba7b4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb4b9d84200>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b918d30>, '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 0x10b77cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b90fb20>, '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.CkmTW3Qzuf/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.KT4J6be3Pu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/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:51:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 02:51:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 02:51:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CkmTW3Qzuf/Render', 02:51:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:51:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:51:25 INFO - 'HOME': '/Users/cltbld', 02:51:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:51:25 INFO - 'LOGNAME': 'cltbld', 02:51:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:51:25 INFO - 'MOZ_NO_REMOTE': '1', 02:51:25 INFO - 'NO_EM_RESTART': '1', 02:51:25 INFO - 'PAGER': '/bin/cat', 02:51:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:51:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:51:25 INFO - 'PWD': '/builds/slave/test', 02:51:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:51:25 INFO - 'SHELL': '/bin/bash', 02:51:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KT4J6be3Pu/Listeners', 02:51:25 INFO - 'TMPDIR': '/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/', 02:51:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:51:25 INFO - 'USER': 'cltbld', 02:51:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:51:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:51:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:51:25 INFO - 'XPC_FLAGS': '0x0', 02:51:25 INFO - 'XPC_SERVICE_NAME': '0', 02:51:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:51:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:51:26 INFO - Downloading/unpacking jsonschema 02:51:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:51:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:51:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:51:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:51:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:51:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:51:28 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:51:28 INFO - Downloading/unpacking functools32 (from jsonschema) 02:51:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:51:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:51:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:51:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:51:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:51:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:51:28 INFO - Downloading functools32-3.2.3-2.tar.gz 02:51:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:51:29 INFO - warning: no files found matching '*.txt' 02:51:29 INFO - no previously-included directories found matching 'build' 02:51:29 INFO - no previously-included directories found matching 'dist' 02:51:29 INFO - no previously-included directories found matching '.git*' 02:51:29 INFO - Installing collected packages: jsonschema, functools32 02:51:29 INFO - Running setup.py install for functools32 02:51:29 INFO - warning: no files found matching '*.txt' 02:51:29 INFO - no previously-included directories found matching 'build' 02:51:29 INFO - no previously-included directories found matching 'dist' 02:51:29 INFO - no previously-included directories found matching '.git*' 02:51:29 INFO - Successfully installed jsonschema functools32 02:51:29 INFO - Cleaning up... 02:51:29 INFO - Return code: 0 02:51:29 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 02:51:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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:51:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:51:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:51:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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:51:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:51:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:51:29 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 0x10ba74a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ba7b4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb4b9d84200>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b918d30>, '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 0x10b77cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b90fb20>, '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.CkmTW3Qzuf/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.KT4J6be3Pu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/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:51:29 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 02:51:29 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 02:51:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CkmTW3Qzuf/Render', 02:51:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:51:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:51:29 INFO - 'HOME': '/Users/cltbld', 02:51:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:51:29 INFO - 'LOGNAME': 'cltbld', 02:51:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:51:29 INFO - 'MOZ_NO_REMOTE': '1', 02:51:29 INFO - 'NO_EM_RESTART': '1', 02:51:29 INFO - 'PAGER': '/bin/cat', 02:51:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:51:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:51:29 INFO - 'PWD': '/builds/slave/test', 02:51:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:51:29 INFO - 'SHELL': '/bin/bash', 02:51:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KT4J6be3Pu/Listeners', 02:51:29 INFO - 'TMPDIR': '/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/', 02:51:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:51:29 INFO - 'USER': 'cltbld', 02:51:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:51:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:51:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:51:29 INFO - 'XPC_FLAGS': '0x0', 02:51:29 INFO - 'XPC_SERVICE_NAME': '0', 02:51:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:51:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:51:29 INFO - Downloading/unpacking flake8 02:51:29 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:51:29 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:51:29 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:51:29 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:51:29 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:51:29 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:51:32 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 02:51:32 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 02:51:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:51:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:51:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:51:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:51:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:51:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:51:32 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 02:51:32 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 02:51:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:51:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:51:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:51:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:51:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:51:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:51:32 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 02:51:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:51:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:51:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:51:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:51:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:51:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:51:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 02:51:33 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:51:33 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:51:33 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:51:33 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:51:33 INFO - no previously-included directories found matching 'docs/_build' 02:51:33 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 02:51:33 INFO - Running setup.py install for pep8 02:51:33 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:51:33 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:51:33 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:51:33 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:51:33 INFO - no previously-included directories found matching 'docs/_build' 02:51:33 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 02:51:33 INFO - Successfully installed flake8 mccabe pyflakes pep8 02:51:33 INFO - Cleaning up... 02:51:33 INFO - Return code: 0 02:51:33 INFO - Running post-action listener: _resource_record_post_action 02:51:33 INFO - Running post-action listener: _start_resource_monitoring 02:51:33 INFO - Starting resource monitoring. 02:51:33 INFO - ##### 02:51:33 INFO - ##### Running install step. 02:51:33 INFO - ##### 02:51:33 INFO - Running pre-action listener: _resource_record_pre_action 02:51:33 INFO - Running main action method: install 02:51:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:51:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:51:33 INFO - Reading from file tmpfile_stdout 02:51:33 INFO - Detecting whether we're running mozinstall >=1.0... 02:51:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:51:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:51:34 INFO - Reading from file tmpfile_stdout 02:51:34 INFO - Output received: 02:51:34 INFO - Usage: mozinstall [options] installer 02:51:34 INFO - Options: 02:51:34 INFO - -h, --help show this help message and exit 02:51:34 INFO - -d DEST, --destination=DEST 02:51:34 INFO - Directory to install application into. [default: 02:51:34 INFO - "/builds/slave/test"] 02:51:34 INFO - --app=APP Application being installed. [default: firefox] 02:51:34 INFO - mkdir: /builds/slave/test/build/application 02:51:34 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'] 02:51:34 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 02:52:05 INFO - Reading from file tmpfile_stdout 02:52:05 INFO - Output received: 02:52:05 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 02:52:05 INFO - Running post-action listener: _resource_record_post_action 02:52:05 INFO - ##### 02:52:05 INFO - ##### Running run-tests step. 02:52:05 INFO - ##### 02:52:05 INFO - Running pre-action listener: _resource_record_pre_action 02:52:05 INFO - Running main action method: run_tests 02:52:05 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:52:05 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:52:05 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:52:05 INFO - 2016-04-15 02:52:05.957 screenresolution[1634:7469] starting screenresolution argv=screenresolution get 02:52:05 INFO - 2016-04-15 02:52:05.959 screenresolution[1634:7469] Display 0: 1600x1200x32@60 02:52:05 INFO - 2016-04-15 02:52:05.965 screenresolution[1635:7471] starting screenresolution argv=screenresolution list 02:52:05 INFO - Available Modes on Display 0 02:52:05 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:52:05 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:52:05 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:52:05 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:52:06 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:52:06 INFO - Intel Iris: 02:52:06 INFO - Chipset Model: Intel Iris 02:52:06 INFO - Type: GPU 02:52:06 INFO - Bus: Built-In 02:52:06 INFO - VRAM (Dynamic, Max): 1536 MB 02:52:06 INFO - Vendor: Intel (0x8086) 02:52:06 INFO - Device ID: 0x0a2e 02:52:06 INFO - Revision ID: 0x0009 02:52:06 INFO - Displays: 02:52:06 INFO - Display: 02:52:06 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:52:06 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:52:06 INFO - Display Serial Number: 1600x1200 60 02:52:06 INFO - Main Display: Yes 02:52:06 INFO - Mirror: Off 02:52:06 INFO - Online: Yes 02:52:06 INFO - Rotation: Supported 02:52:06 INFO - Return code: 0 02:52:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:52:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:52:06 INFO - Python 2.7.3 02:52:06 INFO - Return code: 0 02:52:06 INFO - grabbing minidump binary from tooltool 02:52:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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:52:06 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 0x10b918d30>, '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 0x10b77cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b90fb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:52:06 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 02:52:06 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 02:52:06 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:52:06 INFO - Return code: 0 02:52:06 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 02:52:06 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:52:06 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:52:06 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 02:52:06 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:52:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 02:52:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 02:52:07 INFO - Return code: 0 02:52:07 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/M5bjiJmwSFy7BOoa7S64RA/artifacts/public/build/firefox-47.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0196', '--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 02:52:07 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/M5bjiJmwSFy7BOoa7S64RA/artifacts/public/build/firefox-47.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0196 --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 02:52:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CkmTW3Qzuf/Render', 02:52:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:52:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:52:07 INFO - 'HOME': '/Users/cltbld', 02:52:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:52:07 INFO - 'LOGNAME': 'cltbld', 02:52:07 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:52:07 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 02:52:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:52:07 INFO - 'MOZ_NO_REMOTE': '1', 02:52:07 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:52:07 INFO - 'NO_EM_RESTART': '1', 02:52:07 INFO - 'PAGER': '/bin/cat', 02:52:07 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:52:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:52:07 INFO - 'PWD': '/builds/slave/test', 02:52:07 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:52:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:52:07 INFO - 'SHELL': '/bin/bash', 02:52:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KT4J6be3Pu/Listeners', 02:52:07 INFO - 'TMPDIR': '/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/', 02:52:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:52:07 INFO - 'USER': 'cltbld', 02:52:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:52:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:52:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:52:07 INFO - 'XPC_FLAGS': '0x0', 02:52:07 INFO - 'XPC_SERVICE_NAME': '0', 02:52:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:52:07 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/M5bjiJmwSFy7BOoa7S64RA/artifacts/public/build/firefox-47.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0196', '--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 02:52:07 INFO - mozversion application_buildid: 20160415004038 02:52:07 INFO - mozversion application_changeset: 4633816cde73beee6ed194e571c3a2ba14b15069 02:52:07 INFO - mozversion application_display_name: FirefoxDeveloperEdition 02:52:07 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:52:07 INFO - mozversion application_name: Firefox 02:52:07 INFO - mozversion application_remotingname: firefox-dev 02:52:07 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:52:07 INFO - mozversion application_vendor: Mozilla 02:52:07 INFO - mozversion application_version: 47.0a2 02:52:07 INFO - mozversion platform_buildid: 20160415004038 02:52:07 INFO - mozversion platform_changeset: 4633816cde73beee6ed194e571c3a2ba14b15069 02:52:07 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:52:07 INFO - mozversion platform_version: 47.0a2 02:52:07 INFO - using testdate: 1460713927 02:52:07 INFO - actual date: 1460713927 02:52:07 INFO - starting webserver on 'localhost:49276' 02:52:07 INFO - SUITE-START | Running 2 tests 02:52:07 INFO - TEST-START | dromaeo_css 02:52:07 INFO - operating with platform_type : mac_ 02:52:07 INFO - Initialising browser for dromaeo_css test... 02:52:07 INFO - TEST-INFO | started process 1653 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/tmptNCdQB/profile http://localhost:49276/getInfo.html) 02:52:10 INFO - PROCESS | 1653 | __metrics Screen width/height:1600/1200 02:52:10 INFO - PROCESS | 1653 | colorDepth:24 02:52:10 INFO - PROCESS | 1653 | Browser inner width/height: 1024/689 02:52:10 INFO - PROCESS | 1653 | __metrics 02:52:10 ERROR - PROCESS | 1653 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 02:52:11 INFO - TEST-INFO | 1653: exit 0 02:52:11 INFO - Browser initialized. 02:52:11 INFO - Running cycle 1/1 for dromaeo_css test... 02:52:11 INFO - TEST-INFO | started process 1657 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/tmptNCdQB/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:52:23 INFO - PROCESS | 1657 | RSS: Main: 217317376 02:52:23 INFO - PROCESS | 1657 | 02:53:12 INFO - PROCESS | 1657 | 1460713992923 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] 02:55:24 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49276/tests/dromaeo/cssquery-ext.html) 02:55:25 INFO - PROCESS | 1657 | RSS: Main: 229429248 02:55:25 INFO - PROCESS | 1657 | 02:58:27 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-ext.html (next: http://localhost:49276/tests/dromaeo/cssquery-jquery.html) 02:58:27 INFO - PROCESS | 1657 | RSS: Main: 240078848 02:58:27 INFO - PROCESS | 1657 | 03:01:29 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49276/tests/dromaeo/cssquery-mootools.html) 03:01:30 INFO - PROCESS | 1657 | RSS: Main: 242245632 03:01:30 INFO - PROCESS | 1657 | 03:04:31 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49276/tests/dromaeo/cssquery-prototype.html) 03:04:32 INFO - PROCESS | 1657 | RSS: Main: 244465664 03:04:32 INFO - PROCESS | 1657 | 03:07:35 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49276/tests/dromaeo/cssquery-yui.html) 03:07:35 INFO - PROCESS | 1657 | RSS: Main: 246489088 03:07:35 INFO - PROCESS | 1657 | 03:10:37 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-yui.html (next: http://localhost:49276/tests/dromaeo/cssquery-dojo.html) 03:10:38 INFO - PROCESS | 1657 | RSS: Main: 248119296 03:10:38 INFO - PROCESS | 1657 | 03:10:38 INFO - PROCESS | 1657 | __start_tp_report 03:10:38 INFO - PROCESS | 1657 | _x_x_mozilla_page_load 03:10:38 INFO - PROCESS | 1657 | _x_x_mozilla_page_load_details 03:10:38 INFO - PROCESS | 1657 | |i|pagename|runs| 03:10:38 INFO - PROCESS | 1657 | |0;dojo.html;3299.2246821996832;3543.131932676496;3581.086822860171;3583.2833433313344;3604.261126469074;5871.530277577795;5896.204012458317;5906.2912450506;5908.586398952069;5925.674087925162;5856.882862342762;5880.88263229986;5932.792352267671;5953.166556682068;5978.9701051494685;5255.737213139338;5317.41508434072;5331.680099194042;5376.569874410038;5430.3755068167275;5252.921206181911;5342.786288548454;5374.650647707906;5376.704281264549;5381.865453363677;5410.3507579090565;5413.485718856722;5417.891642167155;5425.782968681248;5444.50999410053;5317.441668624797;5361.571074314045;5407.351117865842;5414.810481633124;5466.644668096561;5266.131088370415;5332.9733351333;5359.169328754049;5380.273663055476;5388.084025715638;5021.57316628087;5179.637425380225;5773.191753154561;5851.76592936282;5920.171176035358;6116.73144005934;6142.188054523926;6188.690565471754;6194.070889366586;6212.440880320748;6297.779577714758;6301.590396624205;6314.463270622003;6314.778982735628;6324.968375158095;5862.14998825168;5956.404359564009;6033.064874944391;6068.120122582201;6077.878442431127;6370.331115232834;6454.903176452357;6460.709268082947;6465.676716164267;6478.967605161944;6189.907151392733;6201.348858369896;6206.162168107247;6243.8126856194385;6244.937550624436;6160.568760186744;6241.18864547615;6291.339409362043;6303;6347.365263473615;6238.906416403757;6256.718447669775;6282.937170628326;6284.340144284875;6325.778597749057;6169.56813023084;6262.46769024638;6280.434760871543;6284.025975973731;6284.308726040132;4890.364252647133;4937.185364414903;4970.925436118461;4988.027334669705;5029.7736601853;4031.7782521960985;4323.7621930793475;4481.708688935209;4496.9100617988115;4514.954850451519;4979.904421027368;5893.528517718572;5961.4038596140035;5979.9801100444;5984.132300816357;6125.113363430769;6248.250209974832;6326.620402775849;6349.492040636738;6352.428281454691;5871.1486834409625;5881.558883083786;5922.111683247461;5935.347111817697;5958.64248145104;5381.623286369917;5485.6434331768305;5488.396276409591;5501.229827824108;5521.033819081645;5376.73116344189;5554.91667624986;6504.121943537656;6519.119918810995;6563.474922006323;6356.618602883842;6358.459530939922;6362.840928976812;6372.490200783834;6377.7130029147875;6009.248843894513;6427.935720642734;6544.2474115475425;6546.574472659262;6581.111549940888;6173.074038894202;6211.13044173807;6247.468965137832;6265.185525881606;6283.403076707706;6176.969115154396;6311.211098612674;6352.36476352361;6353.237611486651;6356.364363563792;6124.479419249235;6132.938670613236;6149.907751383822;6163.753449861955;6194.907076393948;5238.397584277857;6110.725017374318;6141.486007784364;6146.631202127886;6165.691715414301;5976.61152025117;6135.417135372132;6138.109974053648;6158.7228574715145;6170.753169873155;6046.667433291212;6128.105930682329;6134.478569321479;6182.443580077635;6217.564770466024;6103.298120716175;6146.631202127886;6150.938490615215;6156.322804491592;6166.352532984151 03:10:38 INFO - PROCESS | 1657 | |1;ext.html;451.5078564364842;541.9593530485212;604.3956043956044;623.6538721009838;642.3159335307897;41186;41604.79197604016;41638;41701.9574510637;41774.791126044365;36207.2758544829;43079.56920430795;43130.35304470435;43655.56344436554;43805.12389752203;9681.273904457175;9940.105390514853;9945.850812237823;9946.254030947672;9949.900500995005;9845.45849978251;9952.303338766289;9984.35101718386;10033.097021268084;10074;9931.851022234672;9945.254105942047;9997.600095996151;10003.449810260432;10059.295849290516;9888.851667224997;9899.554520046615;9946.055124763136;9985.650502232387;10019.74950626233;9878.110970012662;9953.601855925754;9957.203423726158;9965.950170249174;9998.350107243079;39757.40363894515;39760.602393975976;39967.8001609993;40148.397774033416;40170.79914600438;3295.5221492883397;3835.6544442957997;3909.8045097745285;3959.148783011666;4013.5585085640555;28671.283217919718;29439;29449.55825662617;29682.406351873058;29881;2758.434520923206;2811.9718802812117;2842.9289267768263;2849.544072948339;2855.11491437655;504140;511189;511657;513917;515079;67622;67745;68003.65998169978;68252;68300.97548536776;61518;76783.61608192035;77000.22999769931;77930;78077.21922780813;18292.908535457238;18358.08209589515;18562;18665;18681;14112.506062287976;14166.433342666178;14192;14205;14226.217558034201;19475.80524194768;19737;20265.480088993383;22418.32745017652;22478.876056197125;8149.877751833727;9435;9576.281778866613;9613.375130616627;9636.951815240878;964.6189755046718;980.2648013989508;1129.4239937631703;1136.335243882338;1146.140394703972;27433.31416714598;27836.443271134463;28486;28925.566116508267;30735.69264307373;1018.5162048027128;1061.6655753437642;1140.3500004997072;1148.9540418383172;1176.2178151529308;13702.383392747151;14211;14972.925135374471;16623.83376166247;16667.583310417336;646655;681204;768598.1570092114;772140;775658;61104;61253;61259;61948;62219;1562.6952744214996;1565.4833904811385;1567.2085596773557;1574.4882913053304;1584.049570257836;23195;25317.74682253154;27193.45613087767;28900.277493062;29684.970116137043;50794;50859;51191.2321315188;51406;51624.741876290376;485069;487967;491252;493836;494463;28981.7101828979;32750;33514.83242583869;33618;34166;43682;44033;44846.77576612096;45085;45654.31518527291;36840;37244.25511489701;37411.8627091248;37521.62478375291;37590.248195036496;36878.44682329821;37275;37290;37290.440643389826;37583.62416375801;36536.08659783527;36915.63084369122;37909.81045094757;38661.6133838658;40584.59415405808;28809.855950720113;32041.35917281688;32644.51033234456;33680.3263934715;33824.66175338314;25816.870915646054;25854;25874;26090.60864087002;26257 03:10:38 INFO - PROCESS | 1657 | |2;jquery.html;345.939460594396;375.3806219737433;383.96736277416426;384.50398985308954;384.98845034648934;19997.100130494127;20532.281370152028;20569.074391652375;21184.364469065935;21305.893470532625;21337.786622133775;21568;21575.13699452024;21597.67603485949;21859.344219673396;5857.26784151981;6134.110553969672;6143.846403839895;6146.815595532141;6156.322804491502;5728.283964504437;6027.487663548603;6073.724517851235;6085.969570152165;6086.269647642289;5962.642241465526;5995.580309378345;6008.158857759917;6018.037114061729;6027.457528822405;5745.741441635137;5930.940690593082;5979.491743201811;6017.097435384705;6025.939740602582;5674.687892165929;5723.399043100456;5732.856678583069;5736.42635736423;5785.739641716133;13481.325933703276;13823.51617693376;13859;23728.169514066925;25894.96420143192;2091.6757902525133;2200.2959053103014;2250.2011785816126;2352.929412117639;2798.210019717586;10333.844992325121;10398.636047738293;11016.614418495394;14769.630759230999;15217.239138043053;1792.9103544822706;1806.385828818195;1886.2455017992775;1901.4010586665295;2019.3538067818304;94422;96653.5167324166;99407;99728.50407243897;100442;9709.951450242845;11482.770344593062;11518.654440366634;11650;11742.236754610924;11565.479553420117;11580.305181689126;14181.574552763434;14237.21695306768;14326.928365358106;9020.188183063556;9055.501947392957;9128.3153763468;9179.908200918038;9362.485063321446;9424.539196424565;9448.244140468745;9461.290403219647;9464.1009104135;9512.571934262836;4123.670106391482;4549.340345649928;4661.766911654404;4702.576768090888;4738;1952.8828270303827;1973.8124878136555;2005.4084045206698;2008.4777957731096;2015.5666531695756;824.5341382119084;885.6059053721033;899.8740176375313;919.3059240273551;1039.6465201831413;17455.476335709947;20752.584948300948;21240.575188496452;21685;21821;1016.6492560066913;1022.6471867205802;1039.9480025998669;1061.2465149743614;1097.5938902605926;11139.777204455866;11529.538818447169;11553.537858485566;11564.479598418091;11576.536938522533;644569;652761;671885;673099;679429;124093;124298;126592.10111848329;130500;131747;1045.9424731639833;1067.3009178987775;1076.101455284846;1077.9568817247223;1093.578972095733;18777.49780017568;18820.905895470434;19619.607607847476;19739;19754.209831606575;50924;52248;52358;55902.60243493945;57505;67958;69596.6520167396;69949.30050699631;77457;80959.78560321718;8059.919400805917;8260.05009423924;8326.62530186131;8479.049818541647;8479.067302596586;9486.430814150897;12627.74744505123;13771.242581658105;13813.861861381258;14226.217558034408;11351.602693905674;11810.114241431755;11991;12168.695782605506;12232.755344892874;11683.240589361665;11793.938545530944;11824.881751182378;11857;11920.225185362924;11922.225055371373;11937.940310298392;12127.272363658209;12127.878721213028;12134.211276267015;8287;8313.210245026712;8372.87440688378;8546;8605.440646357967;11699.23954942926;11856.288622682667;12010.09924255667;12052.638420847388;12068.974137198436 03:10:38 INFO - PROCESS | 1657 | |3;mootools.html;1653.1734132933534;1677.060845926281;1885.7077153041284;1920.923163073477;2026.9898650506746;8496.192861678146;9198.494082825442;9231.584578693959;9471.81056378873;9475.573599188036;7810.765677029684;7968.601569921495;9203.677871274507;9246.953765231165;9335.579898904549;2601.9609705854427;2621.777148942342;2624.8950041998296;2629.618705287732;2633.4338117304774;2454.7667971542764;2496.500699860026;2624.5669464538328;2630.2109367189764;2642.762151406373;2133.455968727972;2228.4763080676107;2594.9351266218305;2638.4459263554677;2645.232882464083;2593.247958092151;2618.1360151150266;2627.04112998756;2630.605409188618;2634.7221597525186;2606.452644944564;2631.8289311194712;2634.6838379394403;2652.4960257551;2656.628072069912;9416.717498475056;9445.622175112987;9456.385334953275;9468.857967130498;9483.762905927339;5841.211436456067;5925.466707996301;5947.464728174485;5988.401159883977;6024.698765061773;3771.29430193851;3824.7513911595934;3848.230353929225;3867.8646247381207;3879.35990561557;1077.5905156040653;1085.93484390936;1087.896649818266;1127.5489804078352;1139.8746137924904;12383.814242786455;12408.317542535156;12483.251004939733;12504.187227830162;12514.18657787241;5169;5177.119889618773;5222.399424066205;5224.817131400383;5238.030964271622;10899.455027248607;10940.12479001678;10976.341419514854;10982.670519884416;11011.724706882393;5910.054391297372;5958.165856780054;5972.761089556456;5989.520838332923;5990.101484777319;4723.102610503994;5126.564242039469;5200.037992971313;5257.553107985787;5258.237555554423;3405.8297085145646;3542.5748910130433;4190.350495673115;4236.4704411948505;4252.957470425318;1391.846896841367;1393.909395889264;1394.2958805803207;1403.5929580421564;1404.1504889541884;1394.7280280345235;1427.1009264163717;1430.612306063117;1450.6155868694805;1454.4836583013089;8626.353023523261;8806.911930880737;8807.163319484638;8811.911880881109;8842.159994800611;518.4866981688177;521.4498703867381;523.4712939930697;525.4430303877901;533.1975377057504;6441.355864413521;6445.45213656835;6487.772927947593;6545.4436372907885;6602.669866506655;11204.607838725606;11562.76874462506;11587.246828956091;11651.825222621668;11715;10756.623518176826;11177.273477223955;11386.975172234374;11504.42477876103;11517.25137866036;8735.301175905912;8881.42270752399;8916.73249802507;8972.41679290857;8991.775205619912;8424.115467875785;8478.491290522588;8644.481331120152;8687.087855775053;8718.43330183536;9970.252231082553;10094.242931780293;10098.89901101009;10157;10271.7432064199;9050.230730387992;10170.135538479311;10690.518926648476;10791.97476239756;10796.730081748019;7238.52949558277;7707.730229441942;7709.9614501927135;7967.203279671987;8012.198780122174;7392.667329970272;8186;8738.956305218688;8764.868526972228;8836.513991730517;7037.859242815218;7810.726624568113;7814.843703126019;7844.529328240324;7897.763067107996;6676.198856137295;7205.927940720526;7681.539107653559;7715;7860.84278314419;7529;7928.127905930459;8267;8325.125861784425;8337.124601916712;7433.776986690408;7435.182129965808;7454.813629659302;7467.402607791255;7499.9250007501405;7318.890216646861;7335.706571737071;7364.5581265124265;7369.96315018443;7375 03:10:38 INFO - PROCESS | 1657 | |4;prototype.html;334.24460718775566;341.1777615945572;341.76589036509995;343.07883333250226;350.9350770107529;6907.68915398807;6918.308169183079;6939.791806245808;6954.687039083241;6965.930340696592;6030.823989322084;6502.7724029658975;6896.24141344453;6914.757983470579;6936.445084393249;4854.538818812207;4946.060248552763;5022.04581129586;5041.319421878036;5150.866809301957;5038.899222015558;5066.062778385992;5069.797208111671;5070.61970352225;5081.8475445736685;5030.0694371541385;5052.9747351263195;5078.365204349457;5111.258867464216;5145.768440420171;5089.618278629117;5106.387233532;5113;5118.0019896120275;5124.103281925667;4377.9781101094295;4387.539308372607;4391.736495810262;4392.34114882767;4405.096955124224;6381.117570316767;6469.870602587969;6581.670916454158;6637.601743895381;6655.500837437163;5909.37951515089;5959.986802243629;5963.373845746178;5970.761169553256;5975.521958243374;6318.684065796691;6994.755183568602;7324.194338622748;7330.67011984462;7369.926300736977;4881.414230292387;4896.926546101811;4906;4920.458749537548;4924.80300787968;6530.575512591667;7532.246775322479;7747.806304842367;7760.185180556016;7767.572783496849;4580.519045500241;4798.928016079762;4811.566958973709;4831.903361932742;4832.9275060874115;4840.709557426566;4884.55905507876;4904.485029071896;4905;4932.062908047459;5845.590808643354;5846.41535846412;5848.064309710426;5849.795257165979;5854.443827836349;7331.193568707438;7337.33963943237;7337.88993165103;7341.229170936975;7358.043454351007;1681.4115059729243;1700.3538655310904;1701.6001239708658;1704.2330951072067;1708.6582683463357;1053.2153545608417;1081.8323159910226;1082.9729256768644;1083.8916108389255;1086.8315411111291;5595.664260144405;6593.637349945799;6662.267150613428;6723.562968407038;6753.12209412783;7318.121825380988;7558.773236802905;7565.735199268;7605.619719014027;7611.3910887128895;6633.668316584248;6825.556338838059;6832.931670683329;6869.313068693091;6888.380045795802;4044.6157615026527;4047.3928910663635;4077.6330130288416;4091.97954010234;4100.835966561363;8066.798330041678;8077.394195435366;8084.151164127799;8096.392770542115;8098.595070246464;7690.538567685957;7937.206279372017;7947.3244774194845;7978.401619878532;7988.520688758693;7982.241687039722;8027.39794515402;8033.879491807627;8036.83926321482;8041.7989550260545;7691.1539730628465;7691.461597688108;7703.268189521987;7713.4600577959;7732.922670773445;7525.736599219001;7529.435292353205;7538.09542854861;7566.697332106654;7576.962115189389;7677.347425468898;8053.436259462016;8072.717454889051;8084.514929104273;8108.148644392254;4780.928286075642;4803.991161856049;4823.831165909317;4830.565249127595;4838.95161048385;7641.732539361095;7648.770536883902;7662.425318101276;7666.731664391719;7699.230076992256;7144.821379465555;7346.5592064476305;7365.742199023009;7384;7397.741079062207;7331.193568707331;7356.632168391452;7364.96317518409;7365.594892280976;7369.631518424165;7095.290470952863;7166.928330716834;7176.282371762782;7204.4956853019785;7208.855822883618;7358.264173582813;7359.153697324662;7372.741954031798;7373.446991475768;7375.852482950419;5168.8449346519665;6507.837304067436;6916.135483064617;7116.146062472537;7128 03:10:38 INFO - PROCESS | 1657 | |5;yui.html;634.5019159959431;672.7409947170338;704.8414106825965;713.4078714666826;747.9925200747995;15453;15655.765163522556;15686.21568921555;15687.843121568781;17176.96938183707;16903.91548042258;16962.660746785055;17000;17026.574335641617;17048.744268835977;784.1022029775903;971.4414211828192;987.8765154355706;994.303987208953;995.1342332171022;826.3843436639712;977.5894124467741;993.7366597851575;995.4027583449945;997.9301448898543;1013.3615822032147;1035.9171266298679;1037.704254287528;1039.2257767962878;1043.6503771236644;1010.1867996262969;1025.0313453786175;1030.2736570717625;1032.5766435761338;1033.4729288063068;745.4111252110825;760.3726925286661;772.8879312499712;775.5540564175565;776.1772521127623;15932.601684957968;15977.760333595006;16044.75932861008;16099.356025758956;16115.677686446206;12802.679933001657;12937.094403391766;12951.222926624432;13010.479580816756;13147.802782958262;10172.491375431198;10291.433971131584;10568.471576421149;10594.099501542378;10743.97932196448;3465.0990742407157;3505.964940350589;3511.0520159556777;3519.1905861651962;3625.401808701561;87726;87737;88815.55592222062;88903;89005.55497222472;9474.289428292906;9480.288978326653;9551.14039736427;9703.07820757027;9704.932457429677;18067;21976.670349944765;22296.331110066723;22321.330360089225;22341;7565.546067235983;7694.961525192338;7873.724419645399;7930.206979302024;7978.481398709066;4138;4158.604932531404;4207.474065741782;4225.830966761357;4399.450068741407;3680.429533422324;3711.109333759878;3718.9628103718615;3724.832382542792;3731.8320675569666;643.8486955565438;652.9804105876831;658.3482352471115;659.6371995402509;667.7395815631908;442.6635756824836;547.5728931433488;563.4421922296897;606.3633185155569;624.6064979063161;8163.755087347389;8486.660533578712;8541.444806087584;8642.796086997902;8664.653413863502;485.24059846340367;601.7021574320739;611.1566038866335;612.9632222066601;615.8852477016615;3485.5294535237927;3898.9610103899167;3941.9605803941595;4019.959800402017;4034.3948407738485;72302;83922.58038709767;94801;97910.5104474473;104380;75774.10564735926;76815.61592192003;81176.18823811687;83752.58123709343;84158;49532.99999999928;76429.9428022884;77535.22464775393;78443;79052.60473697595;7101.579684063105;7796.961015194887;7999.040115186215;8003.5197888126895;8232.993825005295;43105.784471077444;53159.46840531545;53931;54491.45508544864;54506;68357;68930;69694.65152674407;70761.29238707547;70907.22731931537;9573.760655983657;9725.708228753148;10119.544620492243;10450.268481206243;11365.31808091517;11900.642980710592;12085;12112;12393.132480726623;12694.746105078031;11720.413979301171;11757.059435245332;11882.108841836724;11982.340971246666;12247.632571022526;11729.41352932367;11738.94130529342;11947.82078268844;11960.34218117977;11963.64109076729;11558.190926635054;11841.23032002917;11867.643970680894;12157.635270941886;12213.75572488563;9901;9979;9991.800163996824;10180.302095563984;10254.487275636338;9948.35335703177;10231.744206394602;10239.590416383558;10248.743781405525;10273 03:10:38 INFO - PROCESS | 1657 | __end_tp_report 03:10:38 INFO - PROCESS | 1657 | __start_cc_report 03:10:38 INFO - PROCESS | 1657 | _x_x_mozilla_cycle_collect,371 03:10:38 INFO - PROCESS | 1657 | __end_cc_report 03:10:38 INFO - PROCESS | 1657 | __startTimestamp1460715038253__endTimestamp 03:10:38 INFO - PROCESS | 1657 | 03:10:38 INFO - PROCESS | 1657 | ------- Summary: start ------- 03:10:38 INFO - PROCESS | 1657 | Number of tests: 6 03:10:38 INFO - PROCESS | 1657 | 03:10:38 INFO - PROCESS | 1657 | [#0] dojo.html Cycles:165 Average:5830.49 Median:6110.73 stddev:642.49 (10.5%) stddev-sans-first:613.01 03:10:38 INFO - PROCESS | 1657 | Values: 3299.2 3543.1 3581.1 3583.3 3604.3 5871.5 5896.2 5906.3 5908.6 5925.7 5856.9 5880.9 5932.8 5953.2 5979.0 5255.7 5317.4 5331.7 5376.6 5430.4 5252.9 5342.8 5374.7 5376.7 5381.9 5410.4 5413.5 5417.9 5425.8 5444.5 5317.4 5361.6 5407.4 5414.8 5466.6 5266.1 5333.0 5359.2 5380.3 5388.1 5021.6 5179.6 5773.2 5851.8 5920.2 6116.7 6142.2 6188.7 6194.1 6212.4 6297.8 6301.6 6314.5 6314.8 6325.0 5862.1 5956.4 6033.1 6068.1 6077.9 6370.3 6454.9 6460.7 6465.7 6479.0 6189.9 6201.3 6206.2 6243.8 6244.9 6160.6 6241.2 6291.3 6303.0 6347.4 6238.9 6256.7 6282.9 6284.3 6325.8 6169.6 6262.5 6280.4 6284.0 6284.3 4890.4 4937.2 4970.9 4988.0 5029.8 4031.8 4323.8 4481.7 4496.9 4515.0 4979.9 5893.5 5961.4 5980.0 5984.1 6125.1 6248.3 6326.6 6349.5 6352.4 5871.1 5881.6 5922.1 5935.3 5958.6 5381.6 5485.6 5488.4 5501.2 5521.0 5376.7 5554.9 6504.1 6519.1 6563.5 6356.6 6358.5 6362.8 6372.5 6377.7 6009.2 6427.9 6544.2 6546.6 6581.1 6173.1 6211.1 6247.5 6265.2 6283.4 6177.0 6311.2 6352.4 6353.2 6356.4 6124.5 6132.9 6149.9 6163.8 6194.9 5238.4 6110.7 6141.5 6146.6 6165.7 5976.6 6135.4 6138.1 6158.7 6170.8 6046.7 6128.1 6134.5 6182.4 6217.6 6103.3 6146.6 6150.9 6156.3 6166.4 03:10:38 INFO - PROCESS | 1657 | 03:10:38 INFO - PROCESS | 1657 | [#1] ext.html Cycles:180 Average:71693.63 Median:3934.48 stddev:157317.99 (3998.4%) stddev-sans-first:157668.37 03:10:38 INFO - PROCESS | 1657 | Values: 451.5 542.0 604.4 623.7 642.3 41186.0 41604.8 41638.0 41702.0 41774.8 36207.3 43079.6 43130.4 43655.6 43805.1 9681.3 9940.1 9945.9 9946.3 9949.9 9845.5 9952.3 9984.4 10033.1 10074.0 9931.9 9945.3 9997.6 10003.4 10059.3 9888.9 9899.6 9946.1 9985.7 10019.7 9878.1 9953.6 9957.2 9966.0 9998.4 39757.4 39760.6 39967.8 40148.4 40170.8 3295.5 3835.7 3909.8 3959.1 4013.6 28671.3 29439.0 29449.6 29682.4 29881.0 2758.4 2812.0 2842.9 2849.5 2855.1 504140.0 511189.0 511657.0 513917.0 515079.0 67622.0 67745.0 68003.7 68252.0 68301.0 61518.0 76783.6 77000.2 77930.0 78077.2 18292.9 18358.1 18562.0 18665.0 18681.0 14112.5 14166.4 14192.0 14205.0 14226.2 19475.8 19737.0 20265.5 22418.3 22478.9 8149.9 9435.0 9576.3 9613.4 9637.0 964.6 980.3 1129.4 1136.3 1146.1 27433.3 27836.4 28486.0 28925.6 30735.7 1018.5 1061.7 1140.4 1149.0 1176.2 13702.4 14211.0 14972.9 16623.8 16667.6 646655.0 681204.0 768598.2 772140.0 775658.0 61104.0 61253.0 61259.0 61948.0 62219.0 1562.7 1565.5 1567.2 1574.5 1584.0 23195.0 25317.7 27193.5 28900.3 29685.0 50794.0 50859.0 51191.2 51406.0 51624.7 485069.0 487967.0 491252.0 493836.0 494463.0 28981.7 32750.0 33514.8 33618.0 34166.0 43682.0 44033.0 44846.8 45085.0 45654.3 36840.0 37244.3 37411.9 37521.6 37590.2 36878.4 37275.0 37290.0 37290.4 37583.6 36536.1 36915.6 37909.8 38661.6 40584.6 28809.9 32041.4 32644.5 33680.3 33824.7 25816.9 25854.0 25874.0 26090.6 26257.0 03:10:38 INFO - PROCESS | 1657 | 03:10:38 INFO - PROCESS | 1657 | [#2] jquery.html Cycles:180 Average:36258.44 Median:21641.34 stddev:109886.52 (507.8%) stddev-sans-first:110161.69 03:10:38 INFO - PROCESS | 1657 | Values: 345.9 375.4 384.0 384.5 385.0 19997.1 20532.3 20569.1 21184.4 21305.9 21337.8 21568.0 21575.1 21597.7 21859.3 5857.3 6134.1 6143.8 6146.8 6156.3 5728.3 6027.5 6073.7 6086.0 6086.3 5962.6 5995.6 6008.2 6018.0 6027.5 5745.7 5930.9 5979.5 6017.1 6025.9 5674.7 5723.4 5732.9 5736.4 5785.7 13481.3 13823.5 13859.0 23728.2 25895.0 2091.7 2200.3 2250.2 2352.9 2798.2 10333.8 10398.6 11016.6 14769.6 15217.2 1792.9 1806.4 1886.2 1901.4 2019.4 94422.0 96653.5 99407.0 99728.5 100442.0 9710.0 11482.8 11518.7 11650.0 11742.2 11565.5 11580.3 14181.6 14237.2 14326.9 9020.2 9055.5 9128.3 9179.9 9362.5 9424.5 9448.2 9461.3 9464.1 9512.6 4123.7 4549.3 4661.8 4702.6 4738.0 1952.9 1973.8 2005.4 2008.5 2015.6 824.5 885.6 899.9 919.3 1039.6 17455.5 20752.6 21240.6 21685.0 21821.0 1016.6 1022.6 1039.9 1061.2 1097.6 11139.8 11529.5 11553.5 11564.5 11576.5 644569.0 652761.0 671885.0 673099.0 679429.0 124093.0 124298.0 126592.1 130500.0 131747.0 1045.9 1067.3 1076.1 1078.0 1093.6 18777.5 18820.9 19619.6 19739.0 19754.2 50924.0 52248.0 52358.0 55902.6 57505.0 67958.0 69596.7 69949.3 77457.0 80959.8 8059.9 8260.1 8326.6 8479.0 8479.1 9486.4 12627.7 13771.2 13813.9 14226.2 11351.6 11810.1 11991.0 12168.7 12232.8 11683.2 11793.9 11824.9 11857.0 11920.2 11922.2 11937.9 12127.3 12127.9 12134.2 8287.0 8313.2 8372.9 8546.0 8605.4 11699.2 11856.3 12010.1 12052.6 12069.0 03:10:38 INFO - PROCESS | 1657 | 03:10:38 INFO - PROCESS | 1657 | [#3] mootools.html Cycles:180 Average:6390.45 Median:5223.61 stddev:3398.90 (65.1%) stddev-sans-first:3389.78 03:10:38 INFO - PROCESS | 1657 | Values: 1653.2 1677.1 1885.7 1920.9 2027.0 8496.2 9198.5 9231.6 9471.8 9475.6 7810.8 7968.6 9203.7 9247.0 9335.6 2602.0 2621.8 2624.9 2629.6 2633.4 2454.8 2496.5 2624.6 2630.2 2642.8 2133.5 2228.5 2594.9 2638.4 2645.2 2593.2 2618.1 2627.0 2630.6 2634.7 2606.5 2631.8 2634.7 2652.5 2656.6 9416.7 9445.6 9456.4 9468.9 9483.8 5841.2 5925.5 5947.5 5988.4 6024.7 3771.3 3824.8 3848.2 3867.9 3879.4 1077.6 1085.9 1087.9 1127.5 1139.9 12383.8 12408.3 12483.3 12504.2 12514.2 5169.0 5177.1 5222.4 5224.8 5238.0 10899.5 10940.1 10976.3 10982.7 11011.7 5910.1 5958.2 5972.8 5989.5 5990.1 4723.1 5126.6 5200.0 5257.6 5258.2 3405.8 3542.6 4190.4 4236.5 4253.0 1391.8 1393.9 1394.3 1403.6 1404.2 1394.7 1427.1 1430.6 1450.6 1454.5 8626.4 8806.9 8807.2 8811.9 8842.2 518.5 521.4 523.5 525.4 533.2 6441.4 6445.5 6487.8 6545.4 6602.7 11204.6 11562.8 11587.2 11651.8 11715.0 10756.6 11177.3 11387.0 11504.4 11517.3 8735.3 8881.4 8916.7 8972.4 8991.8 8424.1 8478.5 8644.5 8687.1 8718.4 9970.3 10094.2 10098.9 10157.0 10271.7 9050.2 10170.1 10690.5 10792.0 10796.7 7238.5 7707.7 7710.0 7967.2 8012.2 7392.7 8186.0 8739.0 8764.9 8836.5 7037.9 7810.7 7814.8 7844.5 7897.8 6676.2 7205.9 7681.5 7715.0 7860.8 7529.0 7928.1 8267.0 8325.1 8337.1 7433.8 7435.2 7454.8 7467.4 7499.9 7318.9 7335.7 7364.6 7370.0 7375.0 03:10:38 INFO - PROCESS | 1657 | 03:10:38 INFO - PROCESS | 1657 | [#4] prototype.html Cycles:180 Average:6016.22 Median:6738.34 stddev:1923.69 (28.5%) stddev-sans-first:1881.22 03:10:38 INFO - PROCESS | 1657 | Values: 334.2 341.2 341.8 343.1 350.9 6907.7 6918.3 6939.8 6954.7 6965.9 6030.8 6502.8 6896.2 6914.8 6936.4 4854.5 4946.1 5022.0 5041.3 5150.9 5038.9 5066.1 5069.8 5070.6 5081.8 5030.1 5053.0 5078.4 5111.3 5145.8 5089.6 5106.4 5113.0 5118.0 5124.1 4378.0 4387.5 4391.7 4392.3 4405.1 6381.1 6469.9 6581.7 6637.6 6655.5 5909.4 5960.0 5963.4 5970.8 5975.5 6318.7 6994.8 7324.2 7330.7 7369.9 4881.4 4896.9 4906.0 4920.5 4924.8 6530.6 7532.2 7747.8 7760.2 7767.6 4580.5 4798.9 4811.6 4831.9 4832.9 4840.7 4884.6 4904.5 4905.0 4932.1 5845.6 5846.4 5848.1 5849.8 5854.4 7331.2 7337.3 7337.9 7341.2 7358.0 1681.4 1700.4 1701.6 1704.2 1708.7 1053.2 1081.8 1083.0 1083.9 1086.8 5595.7 6593.6 6662.3 6723.6 6753.1 7318.1 7558.8 7565.7 7605.6 7611.4 6633.7 6825.6 6832.9 6869.3 6888.4 4044.6 4047.4 4077.6 4092.0 4100.8 8066.8 8077.4 8084.2 8096.4 8098.6 7690.5 7937.2 7947.3 7978.4 7988.5 7982.2 8027.4 8033.9 8036.8 8041.8 7691.2 7691.5 7703.3 7713.5 7732.9 7525.7 7529.4 7538.1 7566.7 7577.0 7677.3 8053.4 8072.7 8084.5 8108.1 4780.9 4804.0 4823.8 4830.6 4839.0 7641.7 7648.8 7662.4 7666.7 7699.2 7144.8 7346.6 7365.7 7384.0 7397.7 7331.2 7356.6 7365.0 7365.6 7369.6 7095.3 7166.9 7176.3 7204.5 7208.9 7358.3 7359.2 7372.7 7373.4 7375.9 5168.8 6507.8 6916.1 7116.1 7128.0 03:10:38 INFO - PROCESS | 1657 | 03:10:38 INFO - PROCESS | 1657 | [#5] yui.html Cycles:180 Average:18937.03 Median:2421.06 stddev:26643.18 (1100.5%) stddev-sans-first:26682.47 03:10:38 INFO - PROCESS | 1657 | Values: 634.5 672.7 704.8 713.4 748.0 15453.0 15655.8 15686.2 15687.8 17177.0 16903.9 16962.7 17000.0 17026.6 17048.7 784.1 971.4 987.9 994.3 995.1 826.4 977.6 993.7 995.4 997.9 1013.4 1035.9 1037.7 1039.2 1043.7 1010.2 1025.0 1030.3 1032.6 1033.5 745.4 760.4 772.9 775.6 776.2 15932.6 15977.8 16044.8 16099.4 16115.7 12802.7 12937.1 12951.2 13010.5 13147.8 10172.5 10291.4 10568.5 10594.1 10744.0 3465.1 3506.0 3511.1 3519.2 3625.4 87726.0 87737.0 88815.6 88903.0 89005.6 9474.3 9480.3 9551.1 9703.1 9704.9 18067.0 21976.7 22296.3 22321.3 22341.0 7565.5 7695.0 7873.7 7930.2 7978.5 4138.0 4158.6 4207.5 4225.8 4399.5 3680.4 3711.1 3719.0 3724.8 3731.8 643.8 653.0 658.3 659.6 667.7 442.7 547.6 563.4 606.4 624.6 8163.8 8486.7 8541.4 8642.8 8664.7 485.2 601.7 611.2 613.0 615.9 3485.5 3899.0 3942.0 4020.0 4034.4 72302.0 83922.6 94801.0 97910.5 104380.0 75774.1 76815.6 81176.2 83752.6 84158.0 49533.0 76429.9 77535.2 78443.0 79052.6 7101.6 7797.0 7999.0 8003.5 8233.0 43105.8 53159.5 53931.0 54491.5 54506.0 68357.0 68930.0 69694.7 70761.3 70907.2 9573.8 9725.7 10119.5 10450.3 11365.3 11900.6 12085.0 12112.0 12393.1 12694.7 11720.4 11757.1 11882.1 11982.3 12247.6 11729.4 11738.9 11947.8 11960.3 11963.6 11558.2 11841.2 11867.6 12157.6 12213.8 9901.0 9979.0 9991.8 10180.3 10254.5 9948.4 10231.7 10239.6 10248.7 10273.0 03:10:38 INFO - PROCESS | 1657 | -------- Summary: end -------- 03:10:38 INFO - PROCESS | 1657 | 03:10:38 INFO - TEST-INFO | 1657: exit 0 03:10:38 INFO - TEST-OK | dromaeo_css | took 1111054ms 03:10:38 INFO - TEST-START | kraken 03:10:38 INFO - operating with platform_type : mac_ 03:10:38 INFO - Initialising browser for kraken test... 03:10:38 INFO - TEST-INFO | started process 1668 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/tmpcGnWJ5/profile http://localhost:49276/getInfo.html) 03:10:41 INFO - PROCESS | 1668 | __metrics Screen width/height:1600/1200 03:10:41 INFO - PROCESS | 1668 | colorDepth:24 03:10:41 INFO - PROCESS | 1668 | Browser inner width/height: 1024/689 03:10:41 INFO - PROCESS | 1668 | __metrics 03:10:41 ERROR - PROCESS | 1668 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 03:10:42 INFO - TEST-INFO | 1668: exit 0 03:10:42 INFO - Browser initialized. 03:10:42 INFO - Running cycle 1/1 for kraken test... 03:10:42 INFO - TEST-INFO | started process 1672 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/tmpcGnWJ5/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:10:54 INFO - PROCESS | 1672 | RSS: Main: 217673728 03:10:54 INFO - PROCESS | 1672 | 03:10:56 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49276/tests/kraken/driver.html?testName=audio-beat-detection) 03:10:57 INFO - PROCESS | 1672 | RSS: Main: 230543360 03:10:57 INFO - PROCESS | 1672 | 03:11:00 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49276/tests/kraken/driver.html?testName=audio-dft) 03:11:00 INFO - PROCESS | 1672 | RSS: Main: 239181824 03:11:00 INFO - PROCESS | 1672 | 03:11:03 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49276/tests/kraken/driver.html?testName=audio-fft) 03:11:04 INFO - PROCESS | 1672 | RSS: Main: 242827264 03:11:04 INFO - PROCESS | 1672 | 03:11:06 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49276/tests/kraken/driver.html?testName=audio-oscillator) 03:11:07 INFO - PROCESS | 1672 | RSS: Main: 243740672 03:11:07 INFO - PROCESS | 1672 | 03:11:09 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49276/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:11:09 INFO - PROCESS | 1672 | RSS: Main: 243802112 03:11:09 INFO - PROCESS | 1672 | 03:11:12 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49276/tests/kraken/driver.html?testName=imaging-darkroom) 03:11:12 INFO - PROCESS | 1672 | RSS: Main: 243793920 03:11:12 INFO - PROCESS | 1672 | 03:11:15 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49276/tests/kraken/driver.html?testName=imaging-desaturate) 03:11:16 INFO - PROCESS | 1672 | RSS: Main: 243576832 03:11:16 INFO - PROCESS | 1672 | 03:11:19 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49276/tests/kraken/driver.html?testName=json-parse-financial) 03:11:20 INFO - PROCESS | 1672 | RSS: Main: 243863552 03:11:20 INFO - PROCESS | 1672 | 03:11:21 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49276/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:11:22 INFO - PROCESS | 1672 | RSS: Main: 244523008 03:11:22 INFO - PROCESS | 1672 | 03:11:24 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:11:24 INFO - PROCESS | 1672 | RSS: Main: 244637696 03:11:24 INFO - PROCESS | 1672 | 03:11:26 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:11:27 INFO - PROCESS | 1672 | RSS: Main: 244953088 03:11:27 INFO - PROCESS | 1672 | 03:11:30 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:11:30 INFO - PROCESS | 1672 | RSS: Main: 245456896 03:11:30 INFO - PROCESS | 1672 | 03:11:33 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:11:33 INFO - PROCESS | 1672 | RSS: Main: 245538816 03:11:33 INFO - PROCESS | 1672 | 03:11:35 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49276/tests/kraken/driver.html?testName=ai-astar) 03:11:35 INFO - PROCESS | 1672 | RSS: Main: 246898688 03:11:35 INFO - PROCESS | 1672 | 03:11:35 INFO - PROCESS | 1672 | __start_tp_report 03:11:35 INFO - PROCESS | 1672 | _x_x_mozilla_page_load 03:11:35 INFO - PROCESS | 1672 | _x_x_mozilla_page_load_details 03:11:35 INFO - PROCESS | 1672 | |i|pagename|runs| 03:11:35 INFO - PROCESS | 1672 | |0;ai-astar;116;107;114;115;114;129;112;93;166;169 03:11:35 INFO - PROCESS | 1672 | |1;audio-beat-detection;147;122;158;146;122;142;119;148;148;121 03:11:35 INFO - PROCESS | 1672 | |2;audio-dft;195;191;198;199;198;199;195;192;199;216 03:11:35 INFO - PROCESS | 1672 | |3;audio-fft;65;75;70;117;56;56;57;61;150;85 03:11:35 INFO - PROCESS | 1672 | |4;audio-oscillator;85;78;122;78;82;82;120;80;80;120 03:11:35 INFO - PROCESS | 1672 | |5;imaging-gaussian-blur;89;88;89;88;89;87;98;117;89;88 03:11:35 INFO - PROCESS | 1672 | |6;imaging-darkroom;95;96;94;94;97;95;149;97;112;122 03:11:35 INFO - PROCESS | 1672 | |7;imaging-desaturate;91;101;144;91;119;144;101;92;122;145 03:11:35 INFO - PROCESS | 1672 | |8;json-parse-financial;56;62;58;58;60;61;58;67;55;55 03:11:35 INFO - PROCESS | 1672 | |9;json-stringify-tinderbox;62;67;68;70;72;70;70;67;68;67 03:11:35 INFO - PROCESS | 1672 | |10;stanford-crypto-aes;82;83;85;104;74;97;109;109;105;86 03:11:35 INFO - PROCESS | 1672 | |11;stanford-crypto-ccm;121;124;138;132;116;123;119;122;132;132 03:11:35 INFO - PROCESS | 1672 | |12;stanford-crypto-pbkdf2;126;140;175;172;169;125;134;133;138;144 03:11:35 INFO - PROCESS | 1672 | |13;stanford-crypto-sha256-iterative;90;76;60;73;64;55;78;94;97;94 03:11:35 INFO - PROCESS | 1672 | __end_tp_report 03:11:35 INFO - PROCESS | 1672 | __start_cc_report 03:11:35 INFO - PROCESS | 1672 | _x_x_mozilla_cycle_collect,925 03:11:35 INFO - PROCESS | 1672 | __end_cc_report 03:11:35 INFO - PROCESS | 1672 | __startTimestamp1460715095983__endTimestamp 03:11:35 INFO - PROCESS | 1672 | 03:11:35 INFO - PROCESS | 1672 | ------- Summary: start ------- 03:11:35 INFO - PROCESS | 1672 | Number of tests: 14 03:11:35 INFO - PROCESS | 1672 | 03:11:35 INFO - PROCESS | 1672 | [#0] ai-astar Cycles:10 Average:123.50 Median:122.50 stddev:24.83 (20.3%) stddev-sans-first:26.19 03:11:35 INFO - PROCESS | 1672 | Values: 116.0 107.0 114.0 115.0 114.0 129.0 112.0 93.0 166.0 169.0 03:11:35 INFO - PROCESS | 1672 | 03:11:35 INFO - PROCESS | 1672 | [#1] audio-beat-detection Cycles:10 Average:137.30 Median:146.50 stddev:14.60 (10.0%) stddev-sans-first:15.06 03:11:35 INFO - PROCESS | 1672 | Values: 147.0 122.0 158.0 146.0 122.0 142.0 119.0 148.0 148.0 121.0 03:11:35 INFO - PROCESS | 1672 | 03:11:35 INFO - PROCESS | 1672 | [#2] audio-dft Cycles:10 Average:198.20 Median:198.50 stddev:6.91 (3.5%) stddev-sans-first:7.23 03:11:35 INFO - PROCESS | 1672 | Values: 195.0 191.0 198.0 199.0 198.0 199.0 195.0 192.0 199.0 216.0 03:11:35 INFO - PROCESS | 1672 | 03:11:35 INFO - PROCESS | 1672 | [#3] audio-fft Cycles:10 Average:79.20 Median:63.00 stddev:31.05 (49.3%) stddev-sans-first:32.51 03:11:35 INFO - PROCESS | 1672 | Values: 65.0 75.0 70.0 117.0 56.0 56.0 57.0 61.0 150.0 85.0 03:11:35 INFO - PROCESS | 1672 | 03:11:35 INFO - PROCESS | 1672 | [#4] audio-oscillator Cycles:10 Average:92.70 Median:80.00 stddev:19.41 (24.3%) stddev-sans-first:20.39 03:11:35 INFO - PROCESS | 1672 | Values: 85.0 78.0 122.0 78.0 82.0 82.0 120.0 80.0 80.0 120.0 03:11:35 INFO - PROCESS | 1672 | 03:11:35 INFO - PROCESS | 1672 | [#5] imaging-gaussian-blur Cycles:10 Average:92.20 Median:89.00 stddev:9.25 (10.4%) stddev-sans-first:9.74 03:11:35 INFO - PROCESS | 1672 | Values: 89.0 88.0 89.0 88.0 89.0 87.0 98.0 117.0 89.0 88.0 03:11:35 INFO - PROCESS | 1672 | 03:11:35 INFO - PROCESS | 1672 | [#6] imaging-darkroom Cycles:10 Average:105.10 Median:95.00 stddev:18.03 (19.0%) stddev-sans-first:18.75 03:11:35 INFO - PROCESS | 1672 | Values: 95.0 96.0 94.0 94.0 97.0 95.0 149.0 97.0 112.0 122.0 03:11:35 INFO - PROCESS | 1672 | 03:11:35 INFO - PROCESS | 1672 | [#7] imaging-desaturate Cycles:10 Average:115.00 Median:144.50 stddev:22.90 (15.8%) stddev-sans-first:22.58 03:11:35 INFO - PROCESS | 1672 | Values: 91.0 101.0 144.0 91.0 119.0 144.0 101.0 92.0 122.0 145.0 03:11:35 INFO - PROCESS | 1672 | 03:11:35 INFO - PROCESS | 1672 | [#8] json-parse-financial Cycles:10 Average:59.00 Median:59.00 stddev:3.68 (6.2%) stddev-sans-first:3.74 03:11:35 INFO - PROCESS | 1672 | Values: 56.0 62.0 58.0 58.0 60.0 61.0 58.0 67.0 55.0 55.0 03:11:35 INFO - PROCESS | 1672 | 03:11:35 INFO - PROCESS | 1672 | [#9] json-stringify-tinderbox Cycles:10 Average:68.10 Median:69.00 stddev:2.73 (4.0%) stddev-sans-first:1.79 03:11:35 INFO - PROCESS | 1672 | Values: 62.0 67.0 68.0 70.0 72.0 70.0 70.0 67.0 68.0 67.0 03:11:35 INFO - PROCESS | 1672 | 03:11:35 INFO - PROCESS | 1672 | [#10] stanford-crypto-aes Cycles:10 Average:93.40 Median:82.50 stddev:12.85 (15.6%) stddev-sans-first:12.95 03:11:35 INFO - PROCESS | 1672 | Values: 82.0 83.0 85.0 104.0 74.0 97.0 109.0 109.0 105.0 86.0 03:11:35 INFO - PROCESS | 1672 | 03:11:35 INFO - PROCESS | 1672 | [#11] stanford-crypto-ccm Cycles:10 Average:125.90 Median:128.00 stddev:7.11 (5.6%) stddev-sans-first:7.32 03:11:35 INFO - PROCESS | 1672 | Values: 121.0 124.0 138.0 132.0 116.0 123.0 119.0 122.0 132.0 132.0 03:11:35 INFO - PROCESS | 1672 | 03:11:35 INFO - PROCESS | 1672 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:145.60 Median:142.00 stddev:19.16 (13.5%) stddev-sans-first:18.96 03:11:35 INFO - PROCESS | 1672 | Values: 126.0 140.0 175.0 172.0 169.0 125.0 134.0 133.0 138.0 144.0 03:11:35 INFO - PROCESS | 1672 | 03:11:35 INFO - PROCESS | 1672 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:78.10 Median:84.00 stddev:15.26 (18.2%) stddev-sans-first:15.56 03:11:35 INFO - PROCESS | 1672 | Values: 90.0 76.0 60.0 73.0 64.0 55.0 78.0 94.0 97.0 94.0 03:11:35 INFO - PROCESS | 1672 | -------- Summary: end -------- 03:11:35 INFO - PROCESS | 1672 | 03:11:36 INFO - TEST-INFO | 1672: exit 0 03:11:36 INFO - TEST-OK | kraken | took 57987ms 03:11:36 INFO - SUITE-END | took 1169s 03:11:37 INFO - Completed test suite (00:19:29) 03:11:37 INFO - javascript benchmark 03:11:37 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3299.2246821996832, 3543.131932676496, 3581.086822860171, 3583.2833433313344, 3604.261126469074, 5871.530277577795, 5896.204012458317, 5906.2912450506, 5908.586398952069, 5925.674087925162, 5856.882862342762, 5880.88263229986, 5932.792352267671, 5953.166556682068, 5978.9701051494685, 5255.737213139338, 5317.41508434072, 5331.680099194042, 5376.569874410038, 5430.3755068167275, 5252.921206181911, 5342.786288548454, 5374.650647707906, 5376.704281264549, 5381.865453363677, 5410.3507579090565, 5413.485718856722, 5417.891642167155, 5425.782968681248, 5444.50999410053, 5317.441668624797, 5361.571074314045, 5407.351117865842, 5414.810481633124, 5466.644668096561, 5266.131088370415, 5332.9733351333, 5359.169328754049, 5380.273663055476, 5388.084025715638, 5021.57316628087, 5179.637425380225, 5773.191753154561, 5851.76592936282, 5920.171176035358, 6116.73144005934, 6142.188054523926, 6188.690565471754, 6194.070889366586, 6212.440880320748, 6297.779577714758, 6301.590396624205, 6314.463270622003, 6314.778982735628, 6324.968375158095, 5862.14998825168, 5956.404359564009, 6033.064874944391, 6068.120122582201, 6077.878442431127, 6370.331115232834, 6454.903176452357, 6460.709268082947, 6465.676716164267, 6478.967605161944, 6189.907151392733, 6201.348858369896, 6206.162168107247, 6243.8126856194385, 6244.937550624436, 6160.568760186744, 6241.18864547615, 6291.339409362043, 6303.0, 6347.365263473615, 6238.906416403757, 6256.718447669775, 6282.937170628326, 6284.340144284875, 6325.778597749057, 6169.56813023084, 6262.46769024638, 6280.434760871543, 6284.025975973731, 6284.308726040132, 4890.364252647133, 4937.185364414903, 4970.925436118461, 4988.027334669705, 5029.7736601853, 4031.7782521960985, 4323.7621930793475, 4481.708688935209, 4496.9100617988115, 4514.954850451519, 4979.904421027368, 5893.528517718572, 5961.4038596140035, 5979.9801100444, 5984.132300816357, 6125.113363430769, 6248.250209974832, 6326.620402775849, 6349.492040636738, 6352.428281454691, 5871.1486834409625, 5881.558883083786, 5922.111683247461, 5935.347111817697, 5958.64248145104, 5381.623286369917, 5485.6434331768305, 5488.396276409591, 5501.229827824108, 5521.033819081645, 5376.73116344189, 5554.91667624986, 6504.121943537656, 6519.119918810995, 6563.474922006323, 6356.618602883842, 6358.459530939922, 6362.840928976812, 6372.490200783834, 6377.7130029147875, 6009.248843894513, 6427.935720642734, 6544.2474115475425, 6546.574472659262, 6581.111549940888, 6173.074038894202, 6211.13044173807, 6247.468965137832, 6265.185525881606, 6283.403076707706, 6176.969115154396, 6311.211098612674, 6352.36476352361, 6353.237611486651, 6356.364363563792, 6124.479419249235, 6132.938670613236, 6149.907751383822, 6163.753449861955, 6194.907076393948, 5238.397584277857, 6110.725017374318, 6141.486007784364, 6146.631202127886, 6165.691715414301, 5976.61152025117, 6135.417135372132, 6138.109974053648, 6158.7228574715145, 6170.753169873155, 6046.667433291212, 6128.105930682329, 6134.478569321479, 6182.443580077635, 6217.564770466024, 6103.298120716175, 6146.631202127886, 6150.938490615215, 6156.322804491592, 6166.352532984151], "unit": "score", "name": "dojo.html", "value": 5791.261532751173}, {"lowerIsBetter": false, "replicates": [451.5078564364842, 541.9593530485212, 604.3956043956044, 623.6538721009838, 642.3159335307897, 41186.0, 41604.79197604016, 41638.0, 41701.9574510637, 41774.791126044365, 36207.2758544829, 43079.56920430795, 43130.35304470435, 43655.56344436554, 43805.12389752203, 9681.273904457175, 9940.105390514853, 9945.850812237823, 9946.254030947672, 9949.900500995005, 9845.45849978251, 9952.303338766289, 9984.35101718386, 10033.097021268084, 10074.0, 9931.851022234672, 9945.254105942047, 9997.600095996151, 10003.449810260432, 10059.295849290516, 9888.851667224997, 9899.554520046615, 9946.055124763136, 9985.650502232387, 10019.74950626233, 9878.110970012662, 9953.601855925754, 9957.203423726158, 9965.950170249174, 9998.350107243079, 39757.40363894515, 39760.602393975976, 39967.8001609993, 40148.397774033416, 40170.79914600438, 3295.5221492883397, 3835.6544442957997, 3909.8045097745285, 3959.148783011666, 4013.5585085640555, 28671.283217919718, 29439.0, 29449.55825662617, 29682.406351873058, 29881.0, 2758.434520923206, 2811.9718802812117, 2842.9289267768263, 2849.544072948339, 2855.11491437655, 504140.0, 511189.0, 511657.0, 513917.0, 515079.0, 67622.0, 67745.0, 68003.65998169978, 68252.0, 68300.97548536776, 61518.0, 76783.61608192035, 77000.22999769931, 77930.0, 78077.21922780813, 18292.908535457238, 18358.08209589515, 18562.0, 18665.0, 18681.0, 14112.506062287976, 14166.433342666178, 14192.0, 14205.0, 14226.217558034201, 19475.80524194768, 19737.0, 20265.480088993383, 22418.32745017652, 22478.876056197125, 8149.877751833727, 9435.0, 9576.281778866613, 9613.375130616627, 9636.951815240878, 964.6189755046718, 980.2648013989508, 1129.4239937631703, 1136.335243882338, 1146.140394703972, 27433.31416714598, 27836.443271134463, 28486.0, 28925.566116508267, 30735.69264307373, 1018.5162048027128, 1061.6655753437642, 1140.3500004997072, 1148.9540418383172, 1176.2178151529308, 13702.383392747151, 14211.0, 14972.925135374471, 16623.83376166247, 16667.583310417336, 646655.0, 681204.0, 768598.1570092114, 772140.0, 775658.0, 61104.0, 61253.0, 61259.0, 61948.0, 62219.0, 1562.6952744214996, 1565.4833904811385, 1567.2085596773557, 1574.4882913053304, 1584.049570257836, 23195.0, 25317.74682253154, 27193.45613087767, 28900.277493062, 29684.970116137043, 50794.0, 50859.0, 51191.2321315188, 51406.0, 51624.741876290376, 485069.0, 487967.0, 491252.0, 493836.0, 494463.0, 28981.7101828979, 32750.0, 33514.83242583869, 33618.0, 34166.0, 43682.0, 44033.0, 44846.77576612096, 45085.0, 45654.31518527291, 36840.0, 37244.25511489701, 37411.8627091248, 37521.62478375291, 37590.248195036496, 36878.44682329821, 37275.0, 37290.0, 37290.440643389826, 37583.62416375801, 36536.08659783527, 36915.63084369122, 37909.81045094757, 38661.6133838658, 40584.59415405808, 28809.855950720113, 32041.35917281688, 32644.51033234456, 33680.3263934715, 33824.66175338314, 25816.870915646054, 25854.0, 25874.0, 26090.60864087002, 26257.0], "unit": "score", "name": "ext.html", "value": 20750.38542025928}, {"lowerIsBetter": false, "replicates": [345.939460594396, 375.3806219737433, 383.96736277416426, 384.50398985308954, 384.98845034648934, 19997.100130494127, 20532.281370152028, 20569.074391652375, 21184.364469065935, 21305.893470532625, 21337.786622133775, 21568.0, 21575.13699452024, 21597.67603485949, 21859.344219673396, 5857.26784151981, 6134.110553969672, 6143.846403839895, 6146.815595532141, 6156.322804491502, 5728.283964504437, 6027.487663548603, 6073.724517851235, 6085.969570152165, 6086.269647642289, 5962.642241465526, 5995.580309378345, 6008.158857759917, 6018.037114061729, 6027.457528822405, 5745.741441635137, 5930.940690593082, 5979.491743201811, 6017.097435384705, 6025.939740602582, 5674.687892165929, 5723.399043100456, 5732.856678583069, 5736.42635736423, 5785.739641716133, 13481.325933703276, 13823.51617693376, 13859.0, 23728.169514066925, 25894.96420143192, 2091.6757902525133, 2200.2959053103014, 2250.2011785816126, 2352.929412117639, 2798.210019717586, 10333.844992325121, 10398.636047738293, 11016.614418495394, 14769.630759230999, 15217.239138043053, 1792.9103544822706, 1806.385828818195, 1886.2455017992775, 1901.4010586665295, 2019.3538067818304, 94422.0, 96653.5167324166, 99407.0, 99728.50407243897, 100442.0, 9709.951450242845, 11482.770344593062, 11518.654440366634, 11650.0, 11742.236754610924, 11565.479553420117, 11580.305181689126, 14181.574552763434, 14237.21695306768, 14326.928365358106, 9020.188183063556, 9055.501947392957, 9128.3153763468, 9179.908200918038, 9362.485063321446, 9424.539196424565, 9448.244140468745, 9461.290403219647, 9464.1009104135, 9512.571934262836, 4123.670106391482, 4549.340345649928, 4661.766911654404, 4702.576768090888, 4738.0, 1952.8828270303827, 1973.8124878136555, 2005.4084045206698, 2008.4777957731096, 2015.5666531695756, 824.5341382119084, 885.6059053721033, 899.8740176375313, 919.3059240273551, 1039.6465201831413, 17455.476335709947, 20752.584948300948, 21240.575188496452, 21685.0, 21821.0, 1016.6492560066913, 1022.6471867205802, 1039.9480025998669, 1061.2465149743614, 1097.5938902605926, 11139.777204455866, 11529.538818447169, 11553.537858485566, 11564.479598418091, 11576.536938522533, 644569.0, 652761.0, 671885.0, 673099.0, 679429.0, 124093.0, 124298.0, 126592.10111848329, 130500.0, 131747.0, 1045.9424731639833, 1067.3009178987775, 1076.101455284846, 1077.9568817247223, 1093.578972095733, 18777.49780017568, 18820.905895470434, 19619.607607847476, 19739.0, 19754.209831606575, 50924.0, 52248.0, 52358.0, 55902.60243493945, 57505.0, 67958.0, 69596.6520167396, 69949.30050699631, 77457.0, 80959.78560321718, 8059.919400805917, 8260.05009423924, 8326.62530186131, 8479.049818541647, 8479.067302596586, 9486.430814150897, 12627.74744505123, 13771.242581658105, 13813.861861381258, 14226.217558034408, 11351.602693905674, 11810.114241431755, 11991.0, 12168.695782605506, 12232.755344892874, 11683.240589361665, 11793.938545530944, 11824.881751182378, 11857.0, 11920.225185362924, 11922.225055371373, 11937.940310298392, 12127.272363658209, 12127.878721213028, 12134.211276267015, 8287.0, 8313.210245026712, 8372.87440688378, 8546.0, 8605.440646357967, 11699.23954942926, 11856.288622682667, 12010.09924255667, 12052.638420847388, 12068.974137198436], "unit": "score", "name": "jquery.html", "value": 9749.583140538078}, {"lowerIsBetter": false, "replicates": [1653.1734132933534, 1677.060845926281, 1885.7077153041284, 1920.923163073477, 2026.9898650506746, 8496.192861678146, 9198.494082825442, 9231.584578693959, 9471.81056378873, 9475.573599188036, 7810.765677029684, 7968.601569921495, 9203.677871274507, 9246.953765231165, 9335.579898904549, 2601.9609705854427, 2621.777148942342, 2624.8950041998296, 2629.618705287732, 2633.4338117304774, 2454.7667971542764, 2496.500699860026, 2624.5669464538328, 2630.2109367189764, 2642.762151406373, 2133.455968727972, 2228.4763080676107, 2594.9351266218305, 2638.4459263554677, 2645.232882464083, 2593.247958092151, 2618.1360151150266, 2627.04112998756, 2630.605409188618, 2634.7221597525186, 2606.452644944564, 2631.8289311194712, 2634.6838379394403, 2652.4960257551, 2656.628072069912, 9416.717498475056, 9445.622175112987, 9456.385334953275, 9468.857967130498, 9483.762905927339, 5841.211436456067, 5925.466707996301, 5947.464728174485, 5988.401159883977, 6024.698765061773, 3771.29430193851, 3824.7513911595934, 3848.230353929225, 3867.8646247381207, 3879.35990561557, 1077.5905156040653, 1085.93484390936, 1087.896649818266, 1127.5489804078352, 1139.8746137924904, 12383.814242786455, 12408.317542535156, 12483.251004939733, 12504.187227830162, 12514.18657787241, 5169.0, 5177.119889618773, 5222.399424066205, 5224.817131400383, 5238.030964271622, 10899.455027248607, 10940.12479001678, 10976.341419514854, 10982.670519884416, 11011.724706882393, 5910.054391297372, 5958.165856780054, 5972.761089556456, 5989.520838332923, 5990.101484777319, 4723.102610503994, 5126.564242039469, 5200.037992971313, 5257.553107985787, 5258.237555554423, 3405.8297085145646, 3542.5748910130433, 4190.350495673115, 4236.4704411948505, 4252.957470425318, 1391.846896841367, 1393.909395889264, 1394.2958805803207, 1403.5929580421564, 1404.1504889541884, 1394.7280280345235, 1427.1009264163717, 1430.612306063117, 1450.6155868694805, 1454.4836583013089, 8626.353023523261, 8806.911930880737, 8807.163319484638, 8811.911880881109, 8842.159994800611, 518.4866981688177, 521.4498703867381, 523.4712939930697, 525.4430303877901, 533.1975377057504, 6441.355864413521, 6445.45213656835, 6487.772927947593, 6545.4436372907885, 6602.669866506655, 11204.607838725606, 11562.76874462506, 11587.246828956091, 11651.825222621668, 11715.0, 10756.623518176826, 11177.273477223955, 11386.975172234374, 11504.42477876103, 11517.25137866036, 8735.301175905912, 8881.42270752399, 8916.73249802507, 8972.41679290857, 8991.775205619912, 8424.115467875785, 8478.491290522588, 8644.481331120152, 8687.087855775053, 8718.43330183536, 9970.252231082553, 10094.242931780293, 10098.89901101009, 10157.0, 10271.7432064199, 9050.230730387992, 10170.135538479311, 10690.518926648476, 10791.97476239756, 10796.730081748019, 7238.52949558277, 7707.730229441942, 7709.9614501927135, 7967.203279671987, 8012.198780122174, 7392.667329970272, 8186.0, 8738.956305218688, 8764.868526972228, 8836.513991730517, 7037.859242815218, 7810.726624568113, 7814.843703126019, 7844.529328240324, 7897.763067107996, 6676.198856137295, 7205.927940720526, 7681.539107653559, 7715.0, 7860.84278314419, 7529.0, 7928.127905930459, 8267.0, 8325.125861784425, 8337.124601916712, 7433.776986690408, 7435.182129965808, 7454.813629659302, 7467.402607791255, 7499.9250007501405, 7318.890216646861, 7335.706571737071, 7364.5581265124265, 7369.96315018443, 7375.0], "unit": "score", "name": "mootools.html", "value": 5121.449009572952}, {"lowerIsBetter": false, "replicates": [334.24460718775566, 341.1777615945572, 341.76589036509995, 343.07883333250226, 350.9350770107529, 6907.68915398807, 6918.308169183079, 6939.791806245808, 6954.687039083241, 6965.930340696592, 6030.823989322084, 6502.7724029658975, 6896.24141344453, 6914.757983470579, 6936.445084393249, 4854.538818812207, 4946.060248552763, 5022.04581129586, 5041.319421878036, 5150.866809301957, 5038.899222015558, 5066.062778385992, 5069.797208111671, 5070.61970352225, 5081.8475445736685, 5030.0694371541385, 5052.9747351263195, 5078.365204349457, 5111.258867464216, 5145.768440420171, 5089.618278629117, 5106.387233532, 5113.0, 5118.0019896120275, 5124.103281925667, 4377.9781101094295, 4387.539308372607, 4391.736495810262, 4392.34114882767, 4405.096955124224, 6381.117570316767, 6469.870602587969, 6581.670916454158, 6637.601743895381, 6655.500837437163, 5909.37951515089, 5959.986802243629, 5963.373845746178, 5970.761169553256, 5975.521958243374, 6318.684065796691, 6994.755183568602, 7324.194338622748, 7330.67011984462, 7369.926300736977, 4881.414230292387, 4896.926546101811, 4906.0, 4920.458749537548, 4924.80300787968, 6530.575512591667, 7532.246775322479, 7747.806304842367, 7760.185180556016, 7767.572783496849, 4580.519045500241, 4798.928016079762, 4811.566958973709, 4831.903361932742, 4832.9275060874115, 4840.709557426566, 4884.55905507876, 4904.485029071896, 4905.0, 4932.062908047459, 5845.590808643354, 5846.41535846412, 5848.064309710426, 5849.795257165979, 5854.443827836349, 7331.193568707438, 7337.33963943237, 7337.88993165103, 7341.229170936975, 7358.043454351007, 1681.4115059729243, 1700.3538655310904, 1701.6001239708658, 1704.2330951072067, 1708.6582683463357, 1053.2153545608417, 1081.8323159910226, 1082.9729256768644, 1083.8916108389255, 1086.8315411111291, 5595.664260144405, 6593.637349945799, 6662.267150613428, 6723.562968407038, 6753.12209412783, 7318.121825380988, 7558.773236802905, 7565.735199268, 7605.619719014027, 7611.3910887128895, 6633.668316584248, 6825.556338838059, 6832.931670683329, 6869.313068693091, 6888.380045795802, 4044.6157615026527, 4047.3928910663635, 4077.6330130288416, 4091.97954010234, 4100.835966561363, 8066.798330041678, 8077.394195435366, 8084.151164127799, 8096.392770542115, 8098.595070246464, 7690.538567685957, 7937.206279372017, 7947.3244774194845, 7978.401619878532, 7988.520688758693, 7982.241687039722, 8027.39794515402, 8033.879491807627, 8036.83926321482, 8041.7989550260545, 7691.1539730628465, 7691.461597688108, 7703.268189521987, 7713.4600577959, 7732.922670773445, 7525.736599219001, 7529.435292353205, 7538.09542854861, 7566.697332106654, 7576.962115189389, 7677.347425468898, 8053.436259462016, 8072.717454889051, 8084.514929104273, 8108.148644392254, 4780.928286075642, 4803.991161856049, 4823.831165909317, 4830.565249127595, 4838.95161048385, 7641.732539361095, 7648.770536883902, 7662.425318101276, 7666.731664391719, 7699.230076992256, 7144.821379465555, 7346.5592064476305, 7365.742199023009, 7384.0, 7397.741079062207, 7331.193568707331, 7356.632168391452, 7364.96317518409, 7365.594892280976, 7369.631518424165, 7095.290470952863, 7166.928330716834, 7176.282371762782, 7204.4956853019785, 7208.855822883618, 7358.264173582813, 7359.153697324662, 7372.741954031798, 7373.446991475768, 7375.852482950419, 5168.8449346519665, 6507.837304067436, 6916.135483064617, 7116.146062472537, 7128.0], "unit": "score", "name": "prototype.html", "value": 5369.097068388183}, {"lowerIsBetter": false, "replicates": [634.5019159959431, 672.7409947170338, 704.8414106825965, 713.4078714666826, 747.9925200747995, 15453.0, 15655.765163522556, 15686.21568921555, 15687.843121568781, 17176.96938183707, 16903.91548042258, 16962.660746785055, 17000.0, 17026.574335641617, 17048.744268835977, 784.1022029775903, 971.4414211828192, 987.8765154355706, 994.303987208953, 995.1342332171022, 826.3843436639712, 977.5894124467741, 993.7366597851575, 995.4027583449945, 997.9301448898543, 1013.3615822032147, 1035.9171266298679, 1037.704254287528, 1039.2257767962878, 1043.6503771236644, 1010.1867996262969, 1025.0313453786175, 1030.2736570717625, 1032.5766435761338, 1033.4729288063068, 745.4111252110825, 760.3726925286661, 772.8879312499712, 775.5540564175565, 776.1772521127623, 15932.601684957968, 15977.760333595006, 16044.75932861008, 16099.356025758956, 16115.677686446206, 12802.679933001657, 12937.094403391766, 12951.222926624432, 13010.479580816756, 13147.802782958262, 10172.491375431198, 10291.433971131584, 10568.471576421149, 10594.099501542378, 10743.97932196448, 3465.0990742407157, 3505.964940350589, 3511.0520159556777, 3519.1905861651962, 3625.401808701561, 87726.0, 87737.0, 88815.55592222062, 88903.0, 89005.55497222472, 9474.289428292906, 9480.288978326653, 9551.14039736427, 9703.07820757027, 9704.932457429677, 18067.0, 21976.670349944765, 22296.331110066723, 22321.330360089225, 22341.0, 7565.546067235983, 7694.961525192338, 7873.724419645399, 7930.206979302024, 7978.481398709066, 4138.0, 4158.604932531404, 4207.474065741782, 4225.830966761357, 4399.450068741407, 3680.429533422324, 3711.109333759878, 3718.9628103718615, 3724.832382542792, 3731.8320675569666, 643.8486955565438, 652.9804105876831, 658.3482352471115, 659.6371995402509, 667.7395815631908, 442.6635756824836, 547.5728931433488, 563.4421922296897, 606.3633185155569, 624.6064979063161, 8163.755087347389, 8486.660533578712, 8541.444806087584, 8642.796086997902, 8664.653413863502, 485.24059846340367, 601.7021574320739, 611.1566038866335, 612.9632222066601, 615.8852477016615, 3485.5294535237927, 3898.9610103899167, 3941.9605803941595, 4019.959800402017, 4034.3948407738485, 72302.0, 83922.58038709767, 94801.0, 97910.5104474473, 104380.0, 75774.10564735926, 76815.61592192003, 81176.18823811687, 83752.58123709343, 84158.0, 49532.99999999928, 76429.9428022884, 77535.22464775393, 78443.0, 79052.60473697595, 7101.579684063105, 7796.961015194887, 7999.040115186215, 8003.5197888126895, 8232.993825005295, 43105.784471077444, 53159.46840531545, 53931.0, 54491.45508544864, 54506.0, 68357.0, 68930.0, 69694.65152674407, 70761.29238707547, 70907.22731931537, 9573.760655983657, 9725.708228753148, 10119.544620492243, 10450.268481206243, 11365.31808091517, 11900.642980710592, 12085.0, 12112.0, 12393.132480726623, 12694.746105078031, 11720.413979301171, 11757.059435245332, 11882.108841836724, 11982.340971246666, 12247.632571022526, 11729.41352932367, 11738.94130529342, 11947.82078268844, 11960.34218117977, 11963.64109076729, 11558.190926635054, 11841.23032002917, 11867.643970680894, 12157.635270941886, 12213.75572488563, 9901.0, 9979.0, 9991.800163996824, 10180.302095563984, 10254.487275636338, 9948.35335703177, 10231.744206394602, 10239.590416383558, 10248.743781405525, 10273.0], "unit": "score", "name": "yui.html", "value": 7140.885879750345}], "name": "dromaeo_css", "value": 7827.882156710254}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [116.0, 107.0, 114.0, 115.0, 114.0, 129.0, 112.0, 93.0, 166.0, 169.0], "unit": "score", "name": "ai-astar", "value": 123.5}, {"lowerIsBetter": true, "replicates": [147.0, 122.0, 158.0, 146.0, 122.0, 142.0, 119.0, 148.0, 148.0, 121.0], "unit": "score", "name": "audio-beat-detection", "value": 137.3}, {"lowerIsBetter": true, "replicates": [195.0, 191.0, 198.0, 199.0, 198.0, 199.0, 195.0, 192.0, 199.0, 216.0], "unit": "score", "name": "audio-dft", "value": 198.2}, {"lowerIsBetter": true, "replicates": [65.0, 75.0, 70.0, 117.0, 56.0, 56.0, 57.0, 61.0, 150.0, 85.0], "unit": "score", "name": "audio-fft", "value": 79.2}, {"lowerIsBetter": true, "replicates": [85.0, 78.0, 122.0, 78.0, 82.0, 82.0, 120.0, 80.0, 80.0, 120.0], "unit": "score", "name": "audio-oscillator", "value": 92.7}, {"lowerIsBetter": true, "replicates": [89.0, 88.0, 89.0, 88.0, 89.0, 87.0, 98.0, 117.0, 89.0, 88.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 92.2}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 94.0, 94.0, 97.0, 95.0, 149.0, 97.0, 112.0, 122.0], "unit": "score", "name": "imaging-darkroom", "value": 105.1}, {"lowerIsBetter": true, "replicates": [91.0, 101.0, 144.0, 91.0, 119.0, 144.0, 101.0, 92.0, 122.0, 145.0], "unit": "score", "name": "imaging-desaturate", "value": 115.0}, {"lowerIsBetter": true, "replicates": [56.0, 62.0, 58.0, 58.0, 60.0, 61.0, 58.0, 67.0, 55.0, 55.0], "unit": "score", "name": "json-parse-financial", "value": 59.0}, {"lowerIsBetter": true, "replicates": [62.0, 67.0, 68.0, 70.0, 72.0, 70.0, 70.0, 67.0, 68.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.1}, {"lowerIsBetter": true, "replicates": [82.0, 83.0, 85.0, 104.0, 74.0, 97.0, 109.0, 109.0, 105.0, 86.0], "unit": "score", "name": "stanford-crypto-aes", "value": 93.4}, {"lowerIsBetter": true, "replicates": [121.0, 124.0, 138.0, 132.0, 116.0, 123.0, 119.0, 122.0, 132.0, 132.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 125.9}, {"lowerIsBetter": true, "replicates": [126.0, 140.0, 175.0, 172.0, 169.0, 125.0, 134.0, 133.0, 138.0, 144.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 145.6}, {"lowerIsBetter": true, "replicates": [90.0, 76.0, 60.0, 73.0, 64.0, 55.0, 78.0, 94.0, 97.0, 94.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 78.1}], "name": "kraken", "value": 1513.3000000000002}]} 03:11:37 INFO - Return code: 0 03:11:37 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 03:11:37 ERROR - # TBPL SUCCESS # 03:11:37 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:11:37 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:11:37 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:11:37 INFO - 2016-04-15 03:11:37.269 screenresolution[1677:10360] starting screenresolution argv=screenresolution get 03:11:37 INFO - 2016-04-15 03:11:37.272 screenresolution[1677:10360] Display 0: 1600x1200x32@60 03:11:37 INFO - 2016-04-15 03:11:37.278 screenresolution[1678:10363] starting screenresolution argv=screenresolution list 03:11:37 INFO - Available Modes on Display 0 03:11:37 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:11:37 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:11:37 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:11:37 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:11:37 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:11:37 INFO - Intel Iris: 03:11:37 INFO - Chipset Model: Intel Iris 03:11:37 INFO - Type: GPU 03:11:37 INFO - Bus: Built-In 03:11:37 INFO - VRAM (Dynamic, Max): 1536 MB 03:11:37 INFO - Vendor: Intel (0x8086) 03:11:37 INFO - Device ID: 0x0a2e 03:11:37 INFO - Revision ID: 0x0009 03:11:37 INFO - Displays: 03:11:37 INFO - Display: 03:11:37 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:11:37 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:11:37 INFO - Display Serial Number: 1600x1200 60 03:11:37 INFO - Main Display: Yes 03:11:37 INFO - Mirror: Off 03:11:37 INFO - Online: Yes 03:11:37 INFO - Rotation: Supported 03:11:37 INFO - Return code: 0 03:11:37 INFO - Running post-action listener: _resource_record_post_action 03:11:37 INFO - Running post-run listener: _resource_record_post_run 03:11:38 INFO - Total resource usage - Wall time: 1203s; CPU: 53.0%; Read bytes: 37225984; Write bytes: 665759232; Read time: 392; Write time: 1853 03:11:38 INFO - install - Wall time: 32s; CPU: 55.0%; Read bytes: 360544768; Write bytes: 353252864; Read time: 28191; Write time: 629 03:11:38 INFO - run-tests - Wall time: 1172s; CPU: 53.0%; Read bytes: 35403264; Write bytes: 301328384; Read time: 371; Write time: 1189 03:11:38 INFO - Running post-run listener: _upload_blobber_files 03:11:38 INFO - Blob upload gear active. 03:11:38 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:11:38 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:11:38 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:11:38 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:11:38 INFO - (blobuploader) - INFO - Open directory for files ... 03:11:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:11:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:11:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:11:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:11:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:11:40 INFO - (blobuploader) - INFO - Done attempting. 03:11:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:11:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:11:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:11:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:11:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:11:41 INFO - (blobuploader) - INFO - Done attempting. 03:11:41 INFO - (blobuploader) - INFO - Iteration through files over. 03:11:41 INFO - Return code: 0 03:11:41 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:11:41 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:11:41 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/33f3efbefad8d7ebd6cda643e95883caa90ddd8cf397c5b17b98342f49c008f5dbccde96ddaa028c5d29f9a5e91afbb58ce838380dcaba61b01c03dde695d2c4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5816ad353d2c8cf4678ced1ba74afaffbffdbdc42581a2dadc62a53435a8f71aafbd1e792f465059d01a463544cedce40a248f28571529894a966f647f3f13b4"} 03:11:41 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:11:41 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:11:41 INFO - Contents: 03:11:41 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/33f3efbefad8d7ebd6cda643e95883caa90ddd8cf397c5b17b98342f49c008f5dbccde96ddaa028c5d29f9a5e91afbb58ce838380dcaba61b01c03dde695d2c4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5816ad353d2c8cf4678ced1ba74afaffbffdbdc42581a2dadc62a53435a8f71aafbd1e792f465059d01a463544cedce40a248f28571529894a966f647f3f13b4"} 03:11:41 INFO - Running post-run listener: copy_logs_to_upload_dir 03:11:41 INFO - Copying logs to upload dir... 03:11:41 INFO - mkdir: /builds/slave/test/build/upload/logs 03:11:41 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1265.941413 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2016-04-15 03:11:41.341800) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-15 03:11:41.345925) ========= 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.CkmTW3Qzuf/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.KT4J6be3Pu/Listeners TMPDIR=/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/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/33f3efbefad8d7ebd6cda643e95883caa90ddd8cf397c5b17b98342f49c008f5dbccde96ddaa028c5d29f9a5e91afbb58ce838380dcaba61b01c03dde695d2c4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5816ad353d2c8cf4678ced1ba74afaffbffdbdc42581a2dadc62a53435a8f71aafbd1e792f465059d01a463544cedce40a248f28571529894a966f647f3f13b4"} build_url:https://queue.taskcluster.net/v1/task/M5bjiJmwSFy7BOoa7S64RA/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010993 build_url: 'https://queue.taskcluster.net/v1/task/M5bjiJmwSFy7BOoa7S64RA/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/33f3efbefad8d7ebd6cda643e95883caa90ddd8cf397c5b17b98342f49c008f5dbccde96ddaa028c5d29f9a5e91afbb58ce838380dcaba61b01c03dde695d2c4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5816ad353d2c8cf4678ced1ba74afaffbffdbdc42581a2dadc62a53435a8f71aafbd1e792f465059d01a463544cedce40a248f28571529894a966f647f3f13b4"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-15 03:11:41.374779) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 03:11:41.375165) ========= 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.CkmTW3Qzuf/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.KT4J6be3Pu/Listeners TMPDIR=/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/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.005079 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 03:11:41.424579) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-15 03:11:41.424909) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-15 03:11:41.425297) ========= ========= Total master_lag: 0.16 =========