builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0258 starttime: 1468010897.41 results: success (0) buildid: 20160708120026 builduid: d4f7ecca9c474fa799b61c6c8c49a443 revision: a5bbe665a0d9677fadcd2a11b14818fd81209968 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-08 13:48:17.415005) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-08 13:48:17.415713) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-08 13:48:17.415994) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-08 13:48:17.460295) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 13:48:17.460570) ========= 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.nhXhCgx2Mr/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.CGcZYFE7uZ/Listeners TMPDIR=/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/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-07-08 13:48:17-- 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% 159M=0s 2016-07-08 13:48:17 (159 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.457777 ========= master_lag: 0.06 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 13:48:17.976875) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 13:48:17.977151) ========= 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.nhXhCgx2Mr/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.CGcZYFE7uZ/Listeners TMPDIR=/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/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.026589 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 13:48:18.032581) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 13:48:18.032941) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev a5bbe665a0d9677fadcd2a11b14818fd81209968 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev a5bbe665a0d9677fadcd2a11b14818fd81209968 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.nhXhCgx2Mr/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.CGcZYFE7uZ/Listeners TMPDIR=/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/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-07-08 13:48:18,113 truncating revision to first 12 chars 2016-07-08 13:48:18,113 Setting DEBUG logging. 2016-07-08 13:48:18,113 attempt 1/10 2016-07-08 13:48:18,113 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/a5bbe665a0d9?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-08 13:48:18,781 unpacking tar archive at: mozilla-central-a5bbe665a0d9/testing/mozharness/ program finished with exit code 0 elapsedTime=0.934382 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 13:48:18.989774) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-08 13:48:18.990110) ========= script_repo_revision: a5bbe665a0d9677fadcd2a11b14818fd81209968 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-08 13:48:18.990896) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-08 13:48:18.991181) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-08 13:48:19.010055) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 27 secs) (at 2016-07-08 13:48:19.010357) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.nhXhCgx2Mr/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.CGcZYFE7uZ/Listeners TMPDIR=/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/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 13:48:19 INFO - MultiFileLogger online at 20160708 13:48:19 in /builds/slave/test 13:48:19 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 13:48:19 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:48:19 INFO - {'append_to_log': False, 13:48:19 INFO - 'base_work_dir': '/builds/slave/test', 13:48:19 INFO - 'blob_upload_branch': 'Firefox', 13:48:19 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:48:19 INFO - 'branch': 'Firefox', 13:48:19 INFO - 'buildbot_json_path': 'buildprops.json', 13:48:19 INFO - 'config_files': ('talos/mac_config.py',), 13:48:19 INFO - 'default_actions': ('clobber', 13:48:19 INFO - 'read-buildbot-config', 13:48:19 INFO - 'download-and-extract', 13:48:19 INFO - 'populate-webroot', 13:48:19 INFO - 'create-virtualenv', 13:48:19 INFO - 'install', 13:48:19 INFO - 'run-tests'), 13:48:19 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:48:19 INFO - 'download_minidump_stackwalk': True, 13:48:19 INFO - 'download_symbols': 'ondemand', 13:48:19 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:48:19 INFO - 'tooltool.py': '/tools/tooltool.py', 13:48:19 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:48:19 INFO - '/tools/misc-python/virtualenv.py')}, 13:48:19 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:48:19 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:48:19 INFO - 'installer_path': 'installer.exe', 13:48:19 INFO - 'log_level': 'info', 13:48:19 INFO - 'log_name': 'talos', 13:48:19 INFO - 'log_to_console': True, 13:48:19 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 13:48:19 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 13:48:19 INFO - 'opt_config_files': (), 13:48:19 INFO - 'pip_index': False, 13:48:19 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 13:48:19 INFO - 'cmd': ('bash', 13:48:19 INFO - '-c', 13:48:19 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 13:48:19 INFO - 'enabled': True, 13:48:19 INFO - 'halt_on_failure': False, 13:48:19 INFO - 'name': 'check_screen_resolution'},), 13:48:19 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 13:48:19 INFO - 'cmd': ('bash', 13:48:19 INFO - '-c', 13:48:19 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 13:48:19 INFO - 'enabled': True, 13:48:19 INFO - 'halt_on_failure': False, 13:48:19 INFO - 'name': 'check_screen_resolution'},), 13:48:19 INFO - 'run_cmd_checks_enabled': True, 13:48:19 INFO - 'sps_profile': False, 13:48:19 INFO - 'sps_profile_interval': 0, 13:48:19 INFO - 'suite': 'dromaeojs-e10s', 13:48:19 INFO - 'system_bits': '32', 13:48:19 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:48:19 INFO - 'title': 't-yosemite-r7-0258', 13:48:19 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:48:19 INFO - 'use_talos_json': True, 13:48:19 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:48:19 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:48:19 INFO - 'work_dir': 'build'} 13:48:19 INFO - ##### 13:48:19 INFO - ##### Running clobber step. 13:48:19 INFO - ##### 13:48:19 INFO - Running pre-action listener: _resource_record_pre_action 13:48:19 INFO - Running main action method: clobber 13:48:19 INFO - rmtree: /builds/slave/test/build 13:48:19 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:48:20 INFO - Running post-action listener: _resource_record_post_action 13:48:20 INFO - ##### 13:48:20 INFO - ##### Finished clobber step (success) 13:48:20 INFO - ##### 13:48:20 INFO - ##### 13:48:20 INFO - ##### Running read-buildbot-config step. 13:48:20 INFO - ##### 13:48:20 INFO - Running pre-action listener: _resource_record_pre_action 13:48:20 INFO - Running main action method: read_buildbot_config 13:48:20 INFO - Using buildbot properties: 13:48:20 INFO - { 13:48:20 INFO - "project": "", 13:48:20 INFO - "product": "firefox", 13:48:20 INFO - "script_repo_revision": "production", 13:48:20 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 13:48:20 INFO - "repository": "", 13:48:20 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 13:48:20 INFO - "buildid": "20160708120026", 13:48:20 INFO - "pgo_build": "False", 13:48:20 INFO - "basedir": "/builds/slave/test", 13:48:20 INFO - "buildnumber": 47, 13:48:20 INFO - "slavename": "t-yosemite-r7-0258", 13:48:20 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 13:48:20 INFO - "platform": "yosemite_r7", 13:48:20 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 13:48:20 INFO - "branch": "mozilla-central", 13:48:20 INFO - "repo_path": "mozilla-central", 13:48:20 INFO - "revision": "a5bbe665a0d9677fadcd2a11b14818fd81209968", 13:48:20 INFO - "stage_platform": "macosx64", 13:48:20 INFO - "builduid": "d4f7ecca9c474fa799b61c6c8c49a443", 13:48:20 INFO - "slavebuilddir": "test" 13:48:20 INFO - } 13:48:20 INFO - Found installer url https://queue.taskcluster.net/v1/task/dePeT9xHSWCSRTVsfFMfKg/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg. 13:48:20 INFO - Running post-action listener: _resource_record_post_action 13:48:20 INFO - ##### 13:48:20 INFO - ##### Finished read-buildbot-config step (success) 13:48:20 INFO - ##### 13:48:20 INFO - ##### 13:48:20 INFO - ##### Running download-and-extract step. 13:48:20 INFO - ##### 13:48:20 INFO - Running pre-action listener: _resource_record_pre_action 13:48:20 INFO - Running main action method: download_and_extract 13:48:20 INFO - mkdir: /builds/slave/test/build/tests 13:48: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')]} 13:48:20 INFO - https://queue.taskcluster.net/v1/task/dePeT9xHSWCSRTVsfFMfKg/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 13:48:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dePeT9xHSWCSRTVsfFMfKg/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json 13:48:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dePeT9xHSWCSRTVsfFMfKg/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json 13:48:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dePeT9xHSWCSRTVsfFMfKg/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.mac.test_packages.json 13:48:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dePeT9xHSWCSRTVsfFMfKg/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.mac.test_packages.json'}, attempt #1 13:48:31 INFO - Downloaded 1199 bytes. 13:48:31 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.mac.test_packages.json 13:48:31 INFO - Using the following test package requirements: 13:48:31 INFO - {u'common': [u'firefox-50.0a1.en-US.mac.common.tests.zip'], 13:48:31 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 13:48:31 INFO - u'firefox-50.0a1.en-US.mac.cppunittest.tests.zip'], 13:48:31 INFO - u'gtest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 13:48:31 INFO - u'firefox-50.0a1.en-US.mac.gtest.tests.zip'], 13:48:31 INFO - u'jittest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 13:48:31 INFO - u'jsshell-mac.zip'], 13:48:31 INFO - u'mochitest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 13:48:31 INFO - u'firefox-50.0a1.en-US.mac.mochitest.tests.zip'], 13:48:31 INFO - u'mozbase': [u'firefox-50.0a1.en-US.mac.common.tests.zip'], 13:48:31 INFO - u'reftest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 13:48:31 INFO - u'firefox-50.0a1.en-US.mac.reftest.tests.zip'], 13:48:31 INFO - u'talos': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 13:48:31 INFO - u'firefox-50.0a1.en-US.mac.talos.tests.zip'], 13:48:31 INFO - u'web-platform': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 13:48:31 INFO - u'firefox-50.0a1.en-US.mac.web-platform.tests.zip'], 13:48:31 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 13:48:31 INFO - u'firefox-50.0a1.en-US.mac.xpcshell.tests.zip']} 13:48:31 INFO - Downloading packages: [u'firefox-50.0a1.en-US.mac.common.tests.zip'] for test suite category: common 13:48:31 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')]} 13:48:31 INFO - https://queue.taskcluster.net/v1/task/dePeT9xHSWCSRTVsfFMfKg/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 13:48:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dePeT9xHSWCSRTVsfFMfKg/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 13:48:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dePeT9xHSWCSRTVsfFMfKg/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 13:48:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dePeT9xHSWCSRTVsfFMfKg/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip 13:48:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dePeT9xHSWCSRTVsfFMfKg/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip'}, attempt #1 13:48:34 INFO - Downloaded 18806320 bytes. 13:48:34 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 13:48:34 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 13:48:37 INFO - Return code: 0 13:48:37 INFO - Downloading packages: [u'firefox-50.0a1.en-US.mac.common.tests.zip', u'firefox-50.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 13:48: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')]} 13:48:37 INFO - https://queue.taskcluster.net/v1/task/dePeT9xHSWCSRTVsfFMfKg/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 13:48:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dePeT9xHSWCSRTVsfFMfKg/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 13:48:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dePeT9xHSWCSRTVsfFMfKg/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 13:48:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dePeT9xHSWCSRTVsfFMfKg/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip 13:48:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dePeT9xHSWCSRTVsfFMfKg/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip'}, attempt #1 13:48:50 INFO - Downloaded 18806320 bytes. 13:48:50 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 13:48:50 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 13:48:53 INFO - Return code: 0 13:48:53 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')]} 13:48:53 INFO - https://queue.taskcluster.net/v1/task/dePeT9xHSWCSRTVsfFMfKg/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 13:48:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dePeT9xHSWCSRTVsfFMfKg/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip 13:48:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dePeT9xHSWCSRTVsfFMfKg/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip 13:48:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dePeT9xHSWCSRTVsfFMfKg/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.mac.talos.tests.zip 13:48:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dePeT9xHSWCSRTVsfFMfKg/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.talos.tests.zip'}, attempt #1 13:48:54 INFO - Downloaded 14403333 bytes. 13:48:54 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 13:48:54 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 13:48:55 INFO - Return code: 0 13:48:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 13:48:55 INFO - https://queue.taskcluster.net/v1/task/dePeT9xHSWCSRTVsfFMfKg/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 13:48:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dePeT9xHSWCSRTVsfFMfKg/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 13:48:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dePeT9xHSWCSRTVsfFMfKg/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 13:48:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dePeT9xHSWCSRTVsfFMfKg/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg 13:48:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dePeT9xHSWCSRTVsfFMfKg/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg'}, attempt #1 13:48:59 INFO - Downloaded 112482485 bytes. 13:48:59 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/dePeT9xHSWCSRTVsfFMfKg/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 13:48:59 INFO - mkdir: /builds/slave/test/properties 13:48:59 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:48:59 INFO - Writing to file /builds/slave/test/properties/build_url 13:48:59 INFO - Contents: 13:48:59 INFO - build_url:https://queue.taskcluster.net/v1/task/dePeT9xHSWCSRTVsfFMfKg/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 13:49:00 INFO - Running post-action listener: _resource_record_post_action 13:49:00 INFO - Running post-action listener: set_extra_try_arguments 13:49:00 INFO - ##### 13:49:00 INFO - ##### Finished download-and-extract step (success) 13:49:00 INFO - ##### 13:49:00 INFO - ##### 13:49:00 INFO - ##### Running populate-webroot step. 13:49:00 INFO - ##### 13:49:00 INFO - Running pre-action listener: _resource_record_pre_action 13:49:00 INFO - Running main action method: populate_webroot 13:49:00 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:49:00 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:49:00 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:49:00 INFO - '--tppagecycles', 13:49:00 INFO - '7'], 13:49:00 INFO - 'tests': ['tsvgm']}}, 13:49:00 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:49:00 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:49:00 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:49:00 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:49:00 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:49:00 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:49:00 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:49:00 INFO - 'talos_options': ['--disable-e10s'], 13:49:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:49:00 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:49:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:49:00 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:49:00 INFO - 'talos_options': ['--disable-e10s'], 13:49:00 INFO - 'tests': ['damp', 'tps']}, 13:49:00 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:49:00 INFO - 'tests': ['damp', 'tps']}, 13:49:00 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:49:00 INFO - 'tests': ['dromaeo_dom']}, 13:49:00 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:49:00 INFO - 'g4': {'talos_options': ['--disable-e10s'], 13:49:00 INFO - 'tests': ['basic_compositor_video']}, 13:49:00 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 13:49:00 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:49:00 INFO - 'tests': ['a11yr', 13:49:00 INFO - 'ts_paint', 13:49:00 INFO - 'tpaint', 13:49:00 INFO - 'sessionrestore', 13:49:00 INFO - 'sessionrestore_no_auto_restore', 13:49:00 INFO - 'tabpaint']}, 13:49:00 INFO - 'other-e10s': {'tests': ['a11yr', 13:49:00 INFO - 'ts_paint', 13:49:00 INFO - 'tpaint', 13:49:00 INFO - 'sessionrestore', 13:49:00 INFO - 'sessionrestore_no_auto_restore', 13:49:00 INFO - 'tabpaint']}, 13:49:00 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:49:00 INFO - 'ts_paint', 13:49:00 INFO - 'tpaint', 13:49:00 INFO - 'sessionrestore', 13:49:00 INFO - 'sessionrestore_no_auto_restore', 13:49:00 INFO - 'tabpaint']}, 13:49:00 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:49:00 INFO - 'ts_paint', 13:49:00 INFO - 'tpaint', 13:49:00 INFO - 'sessionrestore', 13:49:00 INFO - 'sessionrestore_no_auto_restore', 13:49:00 INFO - 'tabpaint']}, 13:49:00 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:49:00 INFO - 'tests': ['a11yr', 13:49:00 INFO - 'ts_paint', 13:49:00 INFO - 'tpaint', 13:49:00 INFO - 'sessionrestore', 13:49:00 INFO - 'sessionrestore_no_auto_restore', 13:49:00 INFO - 'tabpaint']}, 13:49:00 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:49:00 INFO - 'tests': ['a11yr', 13:49:00 INFO - 'ts_paint', 13:49:00 INFO - 'tpaint', 13:49:00 INFO - 'sessionrestore', 13:49:00 INFO - 'sessionrestore_no_auto_restore', 13:49:00 INFO - 'tabpaint']}, 13:49:00 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:49:00 INFO - 'tests': ['tsvgx', 13:49:00 INFO - 'tsvgr_opacity', 13:49:00 INFO - 'tart', 13:49:00 INFO - 'tscrollx', 13:49:00 INFO - 'cart']}, 13:49:00 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:49:00 INFO - 'tsvgr_opacity', 13:49:00 INFO - 'tart', 13:49:00 INFO - 'tscrollx', 13:49:00 INFO - 'cart']}, 13:49:00 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:49:00 INFO - 'talos_options': ['--disable-e10s'], 13:49:00 INFO - 'tests': ['tp5o']}, 13:49:00 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:49:00 INFO - 'tests': ['tp5o']}, 13:49:00 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:49:00 INFO - 'talos_options': ['--disable-e10s', 13:49:00 INFO - '--xperf_path', 13:49:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:49:00 INFO - 'tests': ['tp5n']}, 13:49:00 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:49:00 INFO - 'talos_options': ['--xperf_path', 13:49:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:49:00 INFO - 'tests': ['tp5n']}}, 13:49:00 INFO - 'talos.zip': {'path': '', 13:49:00 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:49:00 INFO - Running post-action listener: _resource_record_post_action 13:49:00 INFO - ##### 13:49:00 INFO - ##### Finished populate-webroot step (success) 13:49:00 INFO - ##### 13:49:00 INFO - ##### 13:49:00 INFO - ##### Running create-virtualenv step. 13:49:00 INFO - ##### 13:49:00 INFO - Running pre-action listener: _resource_record_pre_action 13:49:00 INFO - Running main action method: create_virtualenv 13:49:00 INFO - Creating virtualenv /builds/slave/test/build/venv 13:49:00 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 13:49:00 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:49:01 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:49:01 INFO - Using real prefix '/tools/python27' 13:49:01 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:49:01 INFO - Installing distribute.............................................................................................................................................................................................done. 13:49:04 INFO - Installing pip.................done. 13:49:04 INFO - Return code: 0 13:49:04 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:49:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:49:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:49:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:49:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:49:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:49:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:49:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10bf84a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c019618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff2d0485fd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bee8d30>, '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 0x10bc4ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bee0b20>, '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.nhXhCgx2Mr/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.CGcZYFE7uZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/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 13:49:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 13:49:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 13:49:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nhXhCgx2Mr/Render', 13:49:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:49:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:49:04 INFO - 'HOME': '/Users/cltbld', 13:49:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:49:04 INFO - 'LOGNAME': 'cltbld', 13:49:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:49:04 INFO - 'MOZ_NO_REMOTE': '1', 13:49:04 INFO - 'NO_EM_RESTART': '1', 13:49:04 INFO - 'PAGER': '/bin/cat', 13:49:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:49:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:49:04 INFO - 'PWD': '/builds/slave/test', 13:49:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:49:04 INFO - 'SHELL': '/bin/bash', 13:49:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CGcZYFE7uZ/Listeners', 13:49:04 INFO - 'TMPDIR': '/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/', 13:49:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:49:04 INFO - 'USER': 'cltbld', 13:49:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:49:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:49:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:49:04 INFO - 'XPC_FLAGS': '0x0', 13:49:04 INFO - 'XPC_SERVICE_NAME': '0', 13:49:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:49:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:49:04 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 13:49:04 INFO - Cleaning up... 13:49:04 INFO - Return code: 0 13:49:04 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 13:49:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:49:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:49:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:49:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:49:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:49:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:49:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10bf84a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c019618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff2d0485fd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bee8d30>, '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 0x10bc4ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bee0b20>, '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.nhXhCgx2Mr/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.CGcZYFE7uZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/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 13:49:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 13:49:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 13:49:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nhXhCgx2Mr/Render', 13:49:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:49:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:49:04 INFO - 'HOME': '/Users/cltbld', 13:49:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:49:04 INFO - 'LOGNAME': 'cltbld', 13:49:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:49:04 INFO - 'MOZ_NO_REMOTE': '1', 13:49:04 INFO - 'NO_EM_RESTART': '1', 13:49:04 INFO - 'PAGER': '/bin/cat', 13:49:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:49:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:49:04 INFO - 'PWD': '/builds/slave/test', 13:49:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:49:04 INFO - 'SHELL': '/bin/bash', 13:49:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CGcZYFE7uZ/Listeners', 13:49:04 INFO - 'TMPDIR': '/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/', 13:49:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:49:04 INFO - 'USER': 'cltbld', 13:49:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:49:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:49:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:49:04 INFO - 'XPC_FLAGS': '0x0', 13:49:04 INFO - 'XPC_SERVICE_NAME': '0', 13:49:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:49:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:49:05 INFO - Downloading/unpacking psutil>=3.1.1 13:49:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:49:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:49:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:49:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:49:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:49:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:49:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:49:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:49:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:49:08 INFO - Installing collected packages: psutil 13:49:08 INFO - Running setup.py install for psutil 13:49:08 INFO - building 'psutil._psutil_osx' extension 13:49:08 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 13:49:09 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 13:49:09 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 13:49:09 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 13:49:09 INFO - building 'psutil._psutil_posix' extension 13:49:09 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 13:49:09 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 13:49:09 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 13:49:09 INFO - ^ 13:49:09 INFO - 1 warning generated. 13:49:09 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 13:49:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:49:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:49:09 INFO - Successfully installed psutil 13:49:09 INFO - Cleaning up... 13:49:09 INFO - Return code: 0 13:49:09 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 13:49:09 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')]} 13:49:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:49:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:49:09 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')]} 13:49:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:49:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:49:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10bf84a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c019618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff2d0485fd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bee8d30>, '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 0x10bc4ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bee0b20>, '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.nhXhCgx2Mr/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.CGcZYFE7uZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/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 13:49:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 13:49:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 13:49:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nhXhCgx2Mr/Render', 13:49:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:49:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:49:09 INFO - 'HOME': '/Users/cltbld', 13:49:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:49:09 INFO - 'LOGNAME': 'cltbld', 13:49:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:49:09 INFO - 'MOZ_NO_REMOTE': '1', 13:49:09 INFO - 'NO_EM_RESTART': '1', 13:49:09 INFO - 'PAGER': '/bin/cat', 13:49:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:49:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:49:09 INFO - 'PWD': '/builds/slave/test', 13:49:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:49:09 INFO - 'SHELL': '/bin/bash', 13:49:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CGcZYFE7uZ/Listeners', 13:49:09 INFO - 'TMPDIR': '/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/', 13:49:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:49:09 INFO - 'USER': 'cltbld', 13:49:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:49:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:49:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:49:09 INFO - 'XPC_FLAGS': '0x0', 13:49:09 INFO - 'XPC_SERVICE_NAME': '0', 13:49:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:49:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:49:09 INFO - Downloading/unpacking mozsystemmonitor==0.3 13:49:09 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 13:49:09 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 13:49:09 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 13:49:09 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 13:49:09 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 13:49:09 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 13:49:12 INFO - Downloading mozsystemmonitor-0.3.tar.gz 13:49:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:49:12 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 13:49:12 INFO - Installing collected packages: mozsystemmonitor 13:49:12 INFO - Running setup.py install for mozsystemmonitor 13:49:12 INFO - Successfully installed mozsystemmonitor 13:49:12 INFO - Cleaning up... 13:49:12 INFO - Return code: 0 13:49:12 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 13:49:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:49:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:49:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:49:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:49:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:49:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:49:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10bf84a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c019618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff2d0485fd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bee8d30>, '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 0x10bc4ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bee0b20>, '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.nhXhCgx2Mr/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.CGcZYFE7uZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/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 13:49:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 13:49:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 13:49:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nhXhCgx2Mr/Render', 13:49:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:49:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:49:12 INFO - 'HOME': '/Users/cltbld', 13:49:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:49:12 INFO - 'LOGNAME': 'cltbld', 13:49:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:49:12 INFO - 'MOZ_NO_REMOTE': '1', 13:49:12 INFO - 'NO_EM_RESTART': '1', 13:49:12 INFO - 'PAGER': '/bin/cat', 13:49:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:49:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:49:12 INFO - 'PWD': '/builds/slave/test', 13:49:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:49:12 INFO - 'SHELL': '/bin/bash', 13:49:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CGcZYFE7uZ/Listeners', 13:49:12 INFO - 'TMPDIR': '/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/', 13:49:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:49:12 INFO - 'USER': 'cltbld', 13:49:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:49:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:49:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:49:12 INFO - 'XPC_FLAGS': '0x0', 13:49:12 INFO - 'XPC_SERVICE_NAME': '0', 13:49:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:49:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:49:12 INFO - Downloading/unpacking jsonschema==2.5.1 13:49:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:49:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:49:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:49:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:49:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:49:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:49:15 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:49:15 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 13:49:15 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 13:49:15 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 13:49:15 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 13:49:15 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 13:49:15 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 13:49:15 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 13:49:15 INFO - Downloading functools32-3.2.3-2.tar.gz 13:49:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:49:15 INFO - warning: no files found matching '*.txt' 13:49:15 INFO - no previously-included directories found matching 'build' 13:49:15 INFO - no previously-included directories found matching 'dist' 13:49:15 INFO - no previously-included directories found matching '.git*' 13:49:15 INFO - Installing collected packages: jsonschema, functools32 13:49:15 INFO - Running setup.py install for functools32 13:49:15 INFO - warning: no files found matching '*.txt' 13:49:15 INFO - no previously-included directories found matching 'build' 13:49:15 INFO - no previously-included directories found matching 'dist' 13:49:15 INFO - no previously-included directories found matching '.git*' 13:49:15 INFO - Successfully installed jsonschema functools32 13:49:15 INFO - Cleaning up... 13:49:15 INFO - Return code: 0 13:49:15 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:49: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')]} 13:49:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:49:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:49: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')]} 13:49:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:49:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:49:15 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 0x10bf84a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c019618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff2d0485fd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bee8d30>, '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 0x10bc4ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bee0b20>, '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.nhXhCgx2Mr/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.CGcZYFE7uZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/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 13:49:15 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 13:49:15 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 13:49:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nhXhCgx2Mr/Render', 13:49:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:49:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:49:15 INFO - 'HOME': '/Users/cltbld', 13:49:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:49:15 INFO - 'LOGNAME': 'cltbld', 13:49:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:49:15 INFO - 'MOZ_NO_REMOTE': '1', 13:49:15 INFO - 'NO_EM_RESTART': '1', 13:49:15 INFO - 'PAGER': '/bin/cat', 13:49:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:49:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:49:15 INFO - 'PWD': '/builds/slave/test', 13:49:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:49:15 INFO - 'SHELL': '/bin/bash', 13:49:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CGcZYFE7uZ/Listeners', 13:49:15 INFO - 'TMPDIR': '/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/', 13:49:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:49:15 INFO - 'USER': 'cltbld', 13:49:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:49:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:49:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:49:15 INFO - 'XPC_FLAGS': '0x0', 13:49:15 INFO - 'XPC_SERVICE_NAME': '0', 13:49:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:49:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:49:16 INFO - Downloading/unpacking blobuploader==1.2.4 13:49:16 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 13:49:16 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 13:49:16 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 13:49:16 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 13:49:16 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 13:49:16 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 13:49:18 INFO - Downloading blobuploader-1.2.4.tar.gz 13:49:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:49:18 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:49:18 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 13:49:18 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 13:49:18 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 13:49:18 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 13:49:18 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 13:49:18 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 13:49:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:49:19 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:49:19 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 13:49:19 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 13:49:19 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 13:49:19 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 13:49:19 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 13:49:19 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 13:49:19 INFO - Downloading docopt-0.6.1.tar.gz 13:49:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:49:20 INFO - Installing collected packages: blobuploader, requests, docopt 13:49:20 INFO - Running setup.py install for blobuploader 13:49:20 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:49:20 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:49:20 INFO - Running setup.py install for requests 13:49:20 INFO - Running setup.py install for docopt 13:49:20 INFO - Successfully installed blobuploader requests docopt 13:49:20 INFO - Cleaning up... 13:49:20 INFO - Return code: 0 13:49:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:49: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')]} 13:49:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:49:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:49: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')]} 13:49:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:49:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:49:20 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 0x10bf84a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c019618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff2d0485fd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bee8d30>, '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 0x10bc4ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bee0b20>, '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.nhXhCgx2Mr/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.CGcZYFE7uZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/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 13:49:20 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 13:49:20 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 13:49:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nhXhCgx2Mr/Render', 13:49:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:49:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:49:20 INFO - 'HOME': '/Users/cltbld', 13:49:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:49:20 INFO - 'LOGNAME': 'cltbld', 13:49:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:49:20 INFO - 'MOZ_NO_REMOTE': '1', 13:49:20 INFO - 'NO_EM_RESTART': '1', 13:49:20 INFO - 'PAGER': '/bin/cat', 13:49:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:49:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:49:20 INFO - 'PWD': '/builds/slave/test', 13:49:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:49:20 INFO - 'SHELL': '/bin/bash', 13:49:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CGcZYFE7uZ/Listeners', 13:49:20 INFO - 'TMPDIR': '/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/', 13:49:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:49:20 INFO - 'USER': 'cltbld', 13:49:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:49:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:49:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:49:20 INFO - 'XPC_FLAGS': '0x0', 13:49:20 INFO - 'XPC_SERVICE_NAME': '0', 13:49:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:49:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:49:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:49:21 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-tftpog-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:49:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:49:21 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-_JyCQy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:49:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:49:21 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-rVCmJg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:49:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:49:21 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-5FzXSj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:49:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:49:21 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-YvSTET-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:49:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:49:21 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-QS453i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:49:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:49:21 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-asvytG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:49:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:49:21 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-TmYtZm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:49:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:49:22 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-fteS0r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:49:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:49:22 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-IIEq4H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:49:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:49:22 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-rBbQAr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:49:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:49:22 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-Pw8UqK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:49:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:49:22 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-DZL0XU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:49:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:49:22 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-zqSK3t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:49:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:49:22 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-Or7YfD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:49:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:49:22 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-uznuQM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:49:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:49:22 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-Qfil2h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:49:22 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:49:22 INFO - Running setup.py install for manifestparser 13:49:23 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:49:23 INFO - Running setup.py install for mozcrash 13:49:23 INFO - Running setup.py install for mozdebug 13:49:23 INFO - Running setup.py install for mozdevice 13:49:23 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:49:23 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:49:23 INFO - Running setup.py install for mozfile 13:49:23 INFO - Running setup.py install for mozhttpd 13:49:23 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:49:23 INFO - Running setup.py install for mozinfo 13:49:23 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:49:24 INFO - Running setup.py install for mozInstall 13:49:24 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:49:24 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:49:24 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:49:24 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:49:24 INFO - Running setup.py install for mozleak 13:49:24 INFO - Running setup.py install for mozlog 13:49:24 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:49:24 INFO - Running setup.py install for moznetwork 13:49:24 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:49:24 INFO - Running setup.py install for mozprocess 13:49:24 INFO - Running setup.py install for mozprofile 13:49:24 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:49:24 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:49:24 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:49:24 INFO - Running setup.py install for mozrunner 13:49:25 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:49:25 INFO - Running setup.py install for mozscreenshot 13:49:25 INFO - Running setup.py install for moztest 13:49:25 INFO - Running setup.py install for mozversion 13:49:25 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:49:25 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:49:25 INFO - Cleaning up... 13:49:25 INFO - Return code: 0 13:49:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:49: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')]} 13:49:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:49:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:49: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')]} 13:49:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:49:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:49:25 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 0x10bf84a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c019618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff2d0485fd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bee8d30>, '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 0x10bc4ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bee0b20>, '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.nhXhCgx2Mr/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.CGcZYFE7uZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/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 13:49:25 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 13:49:25 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 13:49:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nhXhCgx2Mr/Render', 13:49:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:49:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:49:25 INFO - 'HOME': '/Users/cltbld', 13:49:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:49:25 INFO - 'LOGNAME': 'cltbld', 13:49:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:49:25 INFO - 'MOZ_NO_REMOTE': '1', 13:49:25 INFO - 'NO_EM_RESTART': '1', 13:49:25 INFO - 'PAGER': '/bin/cat', 13:49:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:49:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:49:25 INFO - 'PWD': '/builds/slave/test', 13:49:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:49:25 INFO - 'SHELL': '/bin/bash', 13:49:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CGcZYFE7uZ/Listeners', 13:49:25 INFO - 'TMPDIR': '/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/', 13:49:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:49:25 INFO - 'USER': 'cltbld', 13:49:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:49:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:49:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:49:25 INFO - 'XPC_FLAGS': '0x0', 13:49:25 INFO - 'XPC_SERVICE_NAME': '0', 13:49:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:49:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:49:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:49:25 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-llWmL9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:49:25 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)) 13:49:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:49:25 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-xPQAVs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:49:26 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)) 13:49:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:49:26 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-HQxFOU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:49:26 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)) 13:49:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:49:26 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-lBrbj4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:49:26 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)) 13:49:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:49:26 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-wzZDng-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:49:26 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)) 13:49:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:49:26 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-UMu4xd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:49:26 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)) 13:49:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:49:26 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-8n6yta-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:49:26 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)) 13:49:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:49:26 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-JFsJ9Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:49:26 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)) 13:49:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:49:26 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-NUj296-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:49:26 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)) 13:49:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:49:26 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-BCdqre-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:49:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 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)) 13:49:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:49:26 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-UWkON3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:49:26 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)) 13:49:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:49:26 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-C9KMpT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:49:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 13:49:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:49:27 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-PbBM17-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:49:27 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)) 13:49:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:49:27 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-SCesCP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:49:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 13:49:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:49:27 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-h9JG9z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:49:27 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)) 13:49:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:49:27 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-B81CAG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:49:27 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)) 13:49:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:49:27 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-lJa1QF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:49:27 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)) 13:49:27 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)) 13:49:27 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)) 13:49:27 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)) 13:49:27 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)) 13:49:27 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)) 13:49:27 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:49:27 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 13:49:27 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 13:49:27 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 13:49:27 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 13:49:27 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 13:49:27 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 13:49:30 INFO - Downloading blessings-1.6.tar.gz 13:49:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:49:30 INFO - Installing collected packages: blessings 13:49:30 INFO - Running setup.py install for blessings 13:49:30 INFO - Successfully installed blessings 13:49:30 INFO - Cleaning up... 13:49:30 INFO - Return code: 0 13:49:30 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:49:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:49:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:49:30 INFO - Reading from file tmpfile_stdout 13:49:30 INFO - Current package versions: 13:49:30 INFO - blessings == 1.6 13:49:30 INFO - blobuploader == 1.2.4 13:49:30 INFO - docopt == 0.6.1 13:49:30 INFO - functools32 == 3.2.3-2 13:49:30 INFO - jsonschema == 2.5.1 13:49:30 INFO - manifestparser == 1.1 13:49:30 INFO - mozInstall == 1.12 13:49:30 INFO - mozcrash == 0.17 13:49:30 INFO - mozdebug == 0.1 13:49:30 INFO - mozdevice == 0.48 13:49:30 INFO - mozfile == 1.2 13:49:30 INFO - mozhttpd == 0.7 13:49:30 INFO - mozinfo == 0.9 13:49:30 INFO - mozleak == 0.1 13:49:30 INFO - mozlog == 3.2 13:49:30 INFO - moznetwork == 0.27 13:49:30 INFO - mozprocess == 0.23 13:49:30 INFO - mozprofile == 0.28 13:49:30 INFO - mozrunner == 6.12 13:49:30 INFO - mozscreenshot == 0.1 13:49:30 INFO - mozsystemmonitor == 0.3 13:49:30 INFO - moztest == 0.7 13:49:30 INFO - mozversion == 1.4 13:49:30 INFO - psutil == 3.1.1 13:49:30 INFO - requests == 1.2.3 13:49:30 INFO - wsgiref == 0.1.2 13:49:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:49:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:49:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:49:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:49:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:49:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:49:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:49:30 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 0x10bf84a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c019618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff2d0485fd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bee8d30>, '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 0x10bc4ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bee0b20>, '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.nhXhCgx2Mr/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.CGcZYFE7uZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/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 13:49:30 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 13:49:30 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 13:49:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nhXhCgx2Mr/Render', 13:49:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:49:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:49:31 INFO - 'HOME': '/Users/cltbld', 13:49:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:49:31 INFO - 'LOGNAME': 'cltbld', 13:49:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:49:31 INFO - 'MOZ_NO_REMOTE': '1', 13:49:31 INFO - 'NO_EM_RESTART': '1', 13:49:31 INFO - 'PAGER': '/bin/cat', 13:49:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:49:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:49:31 INFO - 'PWD': '/builds/slave/test', 13:49:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:49:31 INFO - 'SHELL': '/bin/bash', 13:49:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CGcZYFE7uZ/Listeners', 13:49:31 INFO - 'TMPDIR': '/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/', 13:49:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:49:31 INFO - 'USER': 'cltbld', 13:49:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:49:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:49:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:49:31 INFO - 'XPC_FLAGS': '0x0', 13:49:31 INFO - 'XPC_SERVICE_NAME': '0', 13:49:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:49:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:49:31 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)) 13:49:31 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)) 13:49:31 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)) 13:49:31 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)) 13:49:31 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)) 13:49:31 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)) 13:49:31 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)) 13:49:31 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)) 13:49:31 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)) 13:49:31 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)) 13:49:31 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)) 13:49:31 INFO - Cleaning up... 13:49:31 INFO - Return code: 0 13:49:31 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:49:31 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')]} 13:49:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:49:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:49:31 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')]} 13:49:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:49:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:49:31 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 0x10bf84a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c019618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff2d0485fd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bee8d30>, '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 0x10bc4ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bee0b20>, '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.nhXhCgx2Mr/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.CGcZYFE7uZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/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 13:49:31 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 13:49:31 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 13:49:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nhXhCgx2Mr/Render', 13:49:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:49:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:49:31 INFO - 'HOME': '/Users/cltbld', 13:49:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:49:31 INFO - 'LOGNAME': 'cltbld', 13:49:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:49:31 INFO - 'MOZ_NO_REMOTE': '1', 13:49:31 INFO - 'NO_EM_RESTART': '1', 13:49:31 INFO - 'PAGER': '/bin/cat', 13:49:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:49:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:49:31 INFO - 'PWD': '/builds/slave/test', 13:49:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:49:31 INFO - 'SHELL': '/bin/bash', 13:49:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CGcZYFE7uZ/Listeners', 13:49:31 INFO - 'TMPDIR': '/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/', 13:49:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:49:31 INFO - 'USER': 'cltbld', 13:49:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:49:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:49:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:49:31 INFO - 'XPC_FLAGS': '0x0', 13:49:31 INFO - 'XPC_SERVICE_NAME': '0', 13:49:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:49:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:49:31 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 13:49:31 INFO - Cleaning up... 13:49:31 INFO - Return code: 0 13:49:31 INFO - Running post-action listener: _resource_record_post_action 13:49:31 INFO - Running post-action listener: _start_resource_monitoring 13:49:31 INFO - Starting resource monitoring. 13:49:31 INFO - ##### 13:49:31 INFO - ##### Finished create-virtualenv step (success) 13:49:31 INFO - ##### 13:49:31 INFO - ##### 13:49:31 INFO - ##### Running install step. 13:49:31 INFO - ##### 13:49:31 INFO - Running pre-action listener: _resource_record_pre_action 13:49:31 INFO - Running main action method: install 13:49:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:49:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:49:31 INFO - Reading from file tmpfile_stdout 13:49:31 INFO - Detecting whether we're running mozinstall >=1.0... 13:49:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:49:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:49:31 INFO - Reading from file tmpfile_stdout 13:49:31 INFO - Output received: 13:49:31 INFO - Usage: mozinstall [options] installer 13:49:31 INFO - Options: 13:49:31 INFO - -h, --help show this help message and exit 13:49:31 INFO - -d DEST, --destination=DEST 13:49:31 INFO - Directory to install application into. [default: 13:49:31 INFO - "/builds/slave/test"] 13:49:31 INFO - --app=APP Application being installed. [default: firefox] 13:49:31 INFO - mkdir: /builds/slave/test/build/application 13:49:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 13:49:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 13:50:06 INFO - Reading from file tmpfile_stdout 13:50:06 INFO - Output received: 13:50:06 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 13:50:06 INFO - Running post-action listener: _resource_record_post_action 13:50:06 INFO - ##### 13:50:06 INFO - ##### Finished install step (success) 13:50:06 INFO - ##### 13:50:06 INFO - ##### 13:50:06 INFO - ##### Running run-tests step. 13:50:06 INFO - ##### 13:50:06 INFO - Running pre-action listener: _resource_record_pre_action 13:50:06 INFO - Running main action method: run_tests 13:50:06 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 13:50:06 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 13:50:06 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 13:50:06 INFO - 2016-07-08 13:50:06.355 screenresolution[1670:7713] starting screenresolution argv=screenresolution get 13:50:06 INFO - 2016-07-08 13:50:06.358 screenresolution[1670:7713] Display 0: 1600x1200x32@60 13:50:06 INFO - 2016-07-08 13:50:06.364 screenresolution[1671:7715] starting screenresolution argv=screenresolution list 13:50:06 INFO - Available Modes on Display 0 13:50:06 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 13:50:06 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 13:50:06 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 13:50:06 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 13:50:06 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 13:50:06 INFO - Intel Iris: 13:50:06 INFO - Chipset Model: Intel Iris 13:50:06 INFO - Type: GPU 13:50:06 INFO - Bus: Built-In 13:50:06 INFO - VRAM (Dynamic, Max): 1536 MB 13:50:06 INFO - Vendor: Intel (0x8086) 13:50:06 INFO - Device ID: 0x0a2e 13:50:06 INFO - Revision ID: 0x0009 13:50:06 INFO - Displays: 13:50:06 INFO - Display: 13:50:06 INFO - Resolution: 1600 x 1200 @ 60 Hz 13:50:06 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 13:50:06 INFO - Display Serial Number: 1600x1200 60 13:50:06 INFO - Main Display: Yes 13:50:06 INFO - Mirror: Off 13:50:06 INFO - Online: Yes 13:50:06 INFO - Rotation: Supported 13:50:06 INFO - Return code: 0 13:50:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:50:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:50:06 INFO - Python 2.7.3 13:50:06 INFO - Return code: 0 13:50:06 INFO - grabbing minidump binary from tooltool 13:50: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')]} 13:50: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: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bee8d30>, '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 0x10bc4ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bee0b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:50: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 13:50: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 13:50:06 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 13:50:06 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:50:06 INFO - Return code: 0 13:50:06 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 13:50:06 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:50:06 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:50:06 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 13:50:06 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:50:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dePeT9xHSWCSRTVsfFMfKg/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0258', '--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 13:50:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/dePeT9xHSWCSRTVsfFMfKg/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0258 --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 13:50:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nhXhCgx2Mr/Render', 13:50:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:50:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:50:06 INFO - 'HOME': '/Users/cltbld', 13:50:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:50:06 INFO - 'LOGNAME': 'cltbld', 13:50:06 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:50:06 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 13:50:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:50:06 INFO - 'MOZ_NO_REMOTE': '1', 13:50:06 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:50:06 INFO - 'NO_EM_RESTART': '1', 13:50:06 INFO - 'PAGER': '/bin/cat', 13:50:06 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:50:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:50:06 INFO - 'PWD': '/builds/slave/test', 13:50:06 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:50:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:50:06 INFO - 'SHELL': '/bin/bash', 13:50:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CGcZYFE7uZ/Listeners', 13:50:06 INFO - 'TMPDIR': '/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/', 13:50:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:50:06 INFO - 'USER': 'cltbld', 13:50:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:50:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:50:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:50:06 INFO - 'XPC_FLAGS': '0x0', 13:50:06 INFO - 'XPC_SERVICE_NAME': '0', 13:50:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:50:06 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dePeT9xHSWCSRTVsfFMfKg/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0258', '--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 13:50:06 INFO - mozversion application_buildid: 20160708120026 13:50:06 INFO - mozversion application_changeset: a5bbe665a0d9677fadcd2a11b14818fd81209968 13:50:06 INFO - mozversion application_display_name: Nightly 13:50:06 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:50:06 INFO - mozversion application_name: Firefox 13:50:06 INFO - mozversion application_remotingname: firefox 13:50:06 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 13:50:06 INFO - mozversion application_vendor: Mozilla 13:50:06 INFO - mozversion application_version: 50.0a1 13:50:06 INFO - mozversion platform_buildid: 20160708120026 13:50:06 INFO - mozversion platform_changeset: a5bbe665a0d9677fadcd2a11b14818fd81209968 13:50:06 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 13:50:06 INFO - mozversion platform_version: 50.0a1 13:50:06 INFO - using testdate: 1468011006 13:50:06 INFO - actual date: 1468011006 13:50:06 INFO - starting webserver on 'localhost:49268' 13:50:06 INFO - SUITE-START | Running 2 tests 13:50:06 INFO - TEST-START | dromaeo_css 13:50:06 INFO - operating with platform_type : mac_ 13:50:06 INFO - Initialising browser for dromaeo_css test... 13:50:06 INFO - TEST-INFO | started process 1681 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/tmpxyYRIX/profile http://localhost:49268/getInfo.html) 13:50:09 INFO - PROCESS | 1681 | __metrics Screen width/height:1600/1200 13:50:09 INFO - PROCESS | 1681 | colorDepth:24 13:50:09 INFO - PROCESS | 1681 | Browser inner width/height: 1024/689 13:50:09 INFO - PROCESS | 1681 | __metrics 13:50:10 ERROR - PROCESS | 1681 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2957: TypeError: this.tabs is undefined 13:50:10 INFO - TEST-INFO | 1681: exit 0 13:50:10 INFO - Browser initialized. 13:50:10 INFO - Running cycle 1/1 for dromaeo_css test... 13:50:10 INFO - TEST-INFO | started process 1686 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/tmpxyYRIX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:50:22 INFO - PROCESS | 1686 | RSS: Main: 254341120 13:50:22 INFO - PROCESS | 1686 | 13:51:12 INFO - PROCESS | 1686 | 1468011072418 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] 13:53:23 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49268/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49268/tests/dromaeo/cssquery-ext.html) 13:53:24 INFO - PROCESS | 1686 | RSS: Main: 268750848 13:53:24 INFO - PROCESS | 1686 | 13:56:26 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49268/tests/dromaeo/cssquery-ext.html (next: http://localhost:49268/tests/dromaeo/cssquery-jquery.html) 13:56:27 INFO - PROCESS | 1686 | RSS: Main: 277438464 13:56:27 INFO - PROCESS | 1686 | 13:59:29 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49268/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49268/tests/dromaeo/cssquery-mootools.html) 13:59:29 INFO - PROCESS | 1686 | RSS: Main: 281878528 13:59:29 INFO - PROCESS | 1686 | 14:02:31 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49268/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49268/tests/dromaeo/cssquery-prototype.html) 14:02:32 INFO - PROCESS | 1686 | RSS: Main: 280977408 14:02:32 INFO - PROCESS | 1686 | 14:05:35 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49268/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49268/tests/dromaeo/cssquery-yui.html) 14:05:35 INFO - PROCESS | 1686 | RSS: Main: 284643328 14:05:35 INFO - PROCESS | 1686 | 14:08:38 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49268/tests/dromaeo/cssquery-yui.html (next: http://localhost:49268/tests/dromaeo/cssquery-dojo.html) 14:08:38 INFO - PROCESS | 1686 | RSS: Main: 284598272 14:08:38 INFO - PROCESS | 1686 | 14:08:38 INFO - PROCESS | 1686 | __start_tp_report 14:08:38 INFO - PROCESS | 1686 | _x_x_mozilla_page_load 14:08:38 INFO - PROCESS | 1686 | _x_x_mozilla_page_load_details 14:08:38 INFO - PROCESS | 1686 | |i|pagename|runs| 14:08:38 INFO - PROCESS | 1686 | |0;dojo.html;3373.881914133006;3375.206826395798;3379.1045372976164;3384.966150338496;3416.5558477397935;5693.943060569393;5708.600397972149;5747.511461525765;5753.662875532192;5904.586678932476;4891.315215869772;5576.9163462548095;5732.254806875111;5796.333421656522;5811.767529298823;5151.845444636667;5202.167653175493;5305.840824775263;5322.76047577858;5354.5716342692685;848.5173454872121;5216.24364467152;5274.736263186845;5290.947090529103;5363.061464243761;5176.352955880515;5222.138347172712;5243.501867322599;5258.789648414059;5272.736363181825;5176.689398636094;5254.3169387979315;5288.603354748371;5295.867603309948;5314.840554783363;5158.045761534128;5181.4559471255725;5188.610854185951;5224.791008359661;5229.816956406507;4691.29630555416;4844.4186697596515;5746.2529871116485;5809;5842.444967728059;6089;6162.84592885177;6200.844978875519;6275.341089185616;6284.937150628481;6178.567500274982;6182.814515564541;6229.09678096678;6253.1558239637525;6257.342978987186;5929.169916211734;5950.256217972754;5955.672438015908;5961.642301461883;5997.370276120988;5215.269862219292;6153.384661533811;6157.9384206158265;6273.811785646347;6295.96852015737;6201.007838745779;6207.224096987877;6212.565120441616;6216.813495595139;6234.3453937336835;6245.906311405332;6272.3100458949475;6280.8694435001225;6283.937160628427;6293.905591416133;5832.825015249549;6051.57638965277;6175.3824617538785;6219.315875253718;6239.937600623935;6106.603070800384;6186.752529898844;6236.906446403307;6237.812865614039;6251.499880009588;4982.953579748221;5013.24801279811;5038.874028149326;5044.747762611854;5056.696598204119;4385.386045953569;4402.163588918095;4449.510553839075;4479.440069991251;4542.477615074243;5789.768409263583;5820.097884827858;5832.708364581754;5884.264466941632;5887.970560147171;6313.2424109107205;6323.715432805535;6325.810225693144;6340.953742632414;6350.428461438492;5690.829275121753;5782.10377391505;5792.362840087587;5804.9419505805245;5909.556783241274;4992.851644121873;5490.368607610176;5491.560675145979;5501.119820828648;5510.393856675762;6179.412955769195;6198.008318668992;6349.428551430394;6354.618722876549;6355.110284560165;6215.12988181664;6243.282022567463;6275.623462592259;6308.747650093945;6321.683915804099;6327.019312006646;6330.39861213184;6339.334369891095;6360.141380913703;6365.172527571386;6056.182415373868;6187.226596675416;6277.058441233851;6290.465310448663;6291.591046581958;6197.752089916353;6273.059041143865;6279.434850863444;6318.178636777189;6324;5831.212786273968;6017.2779266488305;6204.286507051746;6206.441420272197;6234.438900498977;5914.467697907209;6109.69451527413;6140.1710769047395;6212.254529456494;6214.875702485834;4746.525347465225;4814.398200224972;5802.912956305574;5944.167816505779;6057.757689692363;6160;6173.104899789595;6190.380961903774;6197.194364732556;6206.472449841814;5912.408759124053;5965.313988891333;6034.39656034393;6037.909431358621;6058 14:08:38 INFO - PROCESS | 1686 | |1;ext.html;449.65601314994035;499.291006770386;514.3262326352478;545.9535939445148;561.7724821447315;35198.47202291965;40360.59639403605;42693.573064269345;42928.35607465891;42984.35523467151;43757.56242437575;44097.338539921846;44150;44208.778956105176;44257.557424425744;9744.65893693719;9793.804123917518;9820.90179098207;9828.361156524803;9994.350367226107;9764.853527197098;9767.267454940873;9780.55987480565;9798.216142708601;9854.605815767361;9723.659671911484;9730.270229732763;9764.804703905918;9861.852072218922;9890.456024918627;9797.755056123618;9823.066808653166;9844;9859.161971232454;9905.801883962353;8183.181681831828;9749.561269742879;9834.557444914924;9845;9878.604855805832;41146.58853411458;41491;41639.375409368884;41678.95802604929;41687.7915610423;3168.5722427472456;3391.406503861814;3437.862485500577;3465.28961562879;3536.1513236823234;29330.560041599394;31316.37367252665;31991.680083199102;32456;33138;3190.8245046522434;3205.2788122672214;3207.695268949446;3314;3349.949750753741;411769;475187;475962;480651;483881;34524.30951380958;35787.64212357895;35951;36004.27991440209;36030.279394412486;34923.825380873444;35764;35814.104647384025;36178.457323140174;36352.81823590918;15270.31283592241;15270.31283592241;15438.842086843531;15480.690386192213;15483.380664773507;13045.804312935314;13099.279539625222;13127.409266583027;13145.21128732279;13161.407736651874;7342.889856652155;7823.061232652004;7880.802979925433;7894.921050789419;7919.089304729914;2706.9458610827674;3094.6905309469325;3175.4601717708047;3218.066760639435;3224.2261857154585;797.8125140591957;966.8839739231337;1010.2220092636865;1097.5390336058874;1122.528538014036;23608.409789755395;26989.595156072675;31307;31746.841265793522;32572.348553028805;948.9051094890456;1095.7644106517137;1176.8823117688335;1217.5738491527895;1222.6943264183953;13626.182429054288;16085.678286434206;16455.588610284838;16541.007539547667;16714.997100174027;699535;705028;707359;711892;715219;62676;63202;63315.36684633187;63319.36680633227;63337.68331158407;1395.3651088754593;1422.566117334223;1432.9068610540282;1444.59551325629;1445.580781573332;31268.843655781577;31290;31296.21759456032;31589.52615710812;31709.20726981844;55275.44724552703;55372.44627553673;55870.720646396505;55966.440335596126;56104.71947640236;609559;629097;633596;634727;638064;28187.57718634263;28519.572206416506;28566.42867142687;28595.857020714764;28739.712602873704;50933.74533127311;51583.48416515787;51817.7409112952;52463.73768131135;52609.47390526199;41838.37242441305;41972.79013604912;42421.575784242996;42497;43407.91480212894;38245;40796.388054179806;42170.1565968685;42568.36147457729;43304.350434742875;33791.49312760261;40030.99922501961;41046;41169.1766164681;42435.787821060694;35008.649913501555;36103.27793444064;37079.62920370762;37096.44355334618;37693.246135077694;26417.471650567266;26689.199324020312;27021.86489067542;27349.495777732416;27522.587161192998 14:08:38 INFO - PROCESS | 1686 | |2;jquery.html;352.13023831137093;383.66046049246427;384.2123646524625;395.8218801539308;404.24204616344355;20215.49461263469;21910.671339929915;22110.894455277252;22175.223867164652;22358.8820558972;20880.582388352224;21232.4691882703;21470.248541301058;21783;21928.671069933964;5245.924585459981;6027.487663548582;6051.636901785907;6055.212822333113;6063.514918806507;5887.381824908387;5919.230500035011;5936.7328470218945;5944.078667806475;5944.138099975501;5803.564732645069;5850.707464626773;5852.092925596539;5869.794557190499;5895.646261224319;5733.655980641175;5791.27609048871;5891.381404952483;5932.822015339503;5936.584439089265;5086.237064440326;5118.078745825787;5154.12379895415;5157.277981082651;5167.48325167484;20951.8952405237;22135.667964980537;23405.89346958782;25523.617145742828;26336;1714.4170981866225;2107.483666501717;2190.518086021073;2396.1852969990287;2539.2382285314516;10054.648087316982;10215.795684086352;10229.437380944046;10271.897281027168;10388.688339349832;1822.735703323024;1913.6268427656612;1962.8331591814713;1975.4370004548634;2004.6091012252616;103694;124114.37942810319;124203;127096.72903270941;129033;9406.48264345454;9448.433094014381;11630.476628551736;11664.475098620582;11667.533298667959;12642.367881606067;13875.236861972486;14353.354099065567;14371.568852934428;14512.637184070272;8610.741677749678;8759.255463285564;8777.29781617469;8870.645174193089;8871.112888711206;8155.388345874083;8487.957560212159;8551.401401901807;8808.735737927873;8928.285737141143;4112.280350938574;4440.68915175941;4512.661550383668;4532.841350552715;4570.702904311209;1910.8566857485744;1946.9610607787765;1961.6469035573448;1969.3796454117194;1975.1605567633699;851.3019324154134;917.2386918857333;918.4443411735804;992.2905122837207;1002.2933831648816;21056.052477638543;21409.67885481719;21919;21972.450688732908;22111.668324975137;877.7586163804878;949.6106596295485;954.4941181173989;958.3052287091803;975.3708857786688;9629.422234665803;9746.415215087118;11545.769084618261;11558.942205289088;11634.76730465386;581900;605191;617891;641350.725710081;642466;90831;96388.59028524203;98530.52204216942;111579;132280;844.6832437835811;913.3287034029983;947.772534591693;961.6105477281712;992.9751756206008;18698.719519206952;18881.961492118066;19333.419997400102;19370.2251909922;19403.12685929165;46758;49237.753811230716;50635;51585;51804.740976294874;63943.680281598296;69839.65080174567;74103;74815;75143;6881.277465866212;7206.56760594366;7941.960290198512;7963.721269755531;8121.918780812116;10157.085862272432;12015.519379224734;12402.75194496123;12611.810822837848;12826;10866.728331791452;10886.727831804268;10900.618478353219;10906.781864362827;10932;10963.725906852393;11002.449877506253;11004;11042.834357484804;11156.49795759209;10239.641612543524;10644.988726071011;11275.492602832728;11297.548098075986;11392.08863290918;5949.583529152917;7863.135055143815;7895.64469598858;7907.525548467111;8105.797355066171;9982;10891.529643498343;10925.726856828325;10926;11047.337159770439 14:08:38 INFO - PROCESS | 1686 | |3;mootools.html;1578.7395079811831;1626.6177448299647;1864.515226041229;1936.8644194906353;1956.9412917612476;7774.961125194366;8084.393670474723;8703.65185392585;8778.956105219473;9261.351705380626;8765.86851197231;8797.692080777175;8978;8986.37095403322;8992.100789921005;2363.078399424226;2391.796697280733;2392.102961389479;2402.255300856731;2403.7380375302932;2349.0603758496654;2360.315508502541;2370.490344575916;2376.2633583589054;2398.6641870138196;2005.1979208316643;2059.7116403703494;2105.9262925797602;2206.6098358034496;2348.4598542335275;2330.8368414211013;2344.5076533927895;2345;2345.57779599672;2353.5645905507363;2333.708286464192;2336.380859072347;2339.017612602694;2343.906243750248;2355.5406695694346;9006.86489702655;9118.270538356915;9194.908050919472;9199.402038867453;9226.53867306632;4550.83953591832;5155.200943853709;5382.381026182;5475.06923822951;5485.314335708036;3480.1473638958364;3514.4552594347915;3595.8022308773006;3608.6932610728118;3647.1246900743895;1061.1086687182803;1072.9731756706067;1088.4938503595786;1097.358045543358;1097.6761855252719;11669.591564295293;11827.704307392298;11864.88135118655;11888.643340699793;11905.821412678817;4060.9847538115473;4634.37435946143;4636.582707556337;4837.129316723023;4845.466998630219;10112.544935477921;10124;10129.189664826796;10157.9492102539;10174.796504070026;5312.946870531323;5426.158945363475;5427.43011983744;5440.238366628675;5459.972700136554;4192.4759405074365;4474.574915383034;4783.928241076386;4930.556249937523;4967.801287948514;3954.5649978502342;4022.0749227677798;4078.163976384834;4095.672346212296;4146.460960075231;1300.876416740408;1308.6597484654058;1312.7768279392335;1317.1701827848394;1321.9339033048502;801.485486143266;841.4278290762218;856.6958729651009;895.4269267668698;969.5103972493846;6017.157597936292;6111.022236442148;6137;6155.261368635703;6250.531210159165;991.7619771254991;995.4226548601794;1012.336919317848;1028.681108856257;1037.7509397744639;4062.979685101615;4069.552349241581;4160.979195104005;4173.31140361843;4187.309093999456;10639.680809575726;10908.454577271104;10985.780284394268;10991.835122473169;11022;10819.242653014371;10987.285826421257;11009.669709908716;11137;11138.443077846237;8224.547649879314;8444.746657600283;8475.618597163142;8518.275946544489;8532.146785321418;5976.581639285208;5981.641101533922;6025.3070896845675;6026.186464827192;6035.486983606443;10016.64941727036;10143.7464063399;10222.233332499944;10290.485475726035;10323.380597164194;10000.449975251431;10283.228757843042;10575.153987680813;10605.575776968835;10605.575776969143;6703.765368212089;7040.471964602573;7081.539699919489;7261.910713392822;7391.889121663287;8681.696140635047;8683.348748843735;8748.168923952215;8755.562221888753;8760.780980475283;7595.3164215218685;7762.3790096793255;7806.1803510632835;7884.4086693497065;7884.605769711607;7479.551226926184;7573.2805383488485;7591.164971852982;7693.769186924401;7752.341051010501;7110.395616372666;7216.494845360774;7225.963870180615;7239.131304243314;7253.782386528413;4626.236670949255;5043.4956504349275;5094.439611642642;5095.363079615048;5200.349956255468;5107.591392688501;5154.948450515597;5280.683159010472;5335.813246536352;5360.517553420055 14:08:38 INFO - PROCESS | 1686 | |4;prototype.html;310.6598274888997;315.1286692295801;316.92562214094227;318.3299155278141;320.8572185377505;5666.433356664332;5689.658620482769;5714.428557144294;5731.541476681866;5772.719775688601;4263.5310115887305;4749.240121580548;5625.465580769831;5641.802536911209;5653.886922261562;3720.7209459290525;4106.342985122381;4224.809883555247;4232.02663387421;4250.872473825791;3841.558220804601;4201.978990105045;4251.744895306291;4262.360645903108;4264.420025884342;4123.278426275405;4232.068944832132;4244.236037513247;4260.339647354649;4261.21167583998;3381.425157723193;3652.7443078984484;3703.4815125882396;4028.8719158635336;4230.915381692349;3258.885938992124;3359.0090923177722;3712.3688972874675;3713.350163721338;3748.3815170496837;4358.3244597087505;4566.49768525462;5206.76569554371;5437.891242175135;5485.177223416479;4601.378813860153;4631.884202894921;4671.5094915034115;4847.369841920563;4960.503949605047;5759.819237056394;5774.884502309972;5789.16057171712;5816.505597024258;5845.473907348359;3103.7584966013774;3574.195805943668;4029.9447281886155;4035.737677051012;4048.6963477739287;4791.31686255698;6176.783812566584;6191.721372538246;6195.44241018306;6324.715387807513;3403.217260030207;3562.091666625046;4049.7445791804635;4060.7360521566;4084.6105028558627;3760.6530188132583;3863.903402414906;4144.378343248537;4149.419081328617;4155.729877558009;4281.379200016043;4712.887878153114;4874.390701162355;4875.829345972874;4885.658003939761;5328.8401347959625;5383.892322153535;5831.212786273799;5956.225690660273;6071.085878778123;1369.6849724563406;1412.9929350353389;1414.4412956881974;1416.6033510617044;1424.7720364741592;741.8108382362464;840.2899549880341;857.0743596915316;873.275181599271;918.5636822509255;5426.647267927572;5495.890082198413;5506.081776658378;5506.339239291311;5556.749946252428;4708.293755936637;4926.975365123151;5989.940100599026;6057.757689692363;6109.7861574844665;4824.8793780155775;5118.131881863093;5399.487048730443;5481.588880833953;5520.806771763049;2831.6743574488787;2959.3045634275927;2979.851007449619;3086.8424340872175;3212.726918211931;5437.32033495813;6039.516838652898;6170.784022559279;6270.247570291503;6335.619862808154;6261.405166509266;6319.052142178618;6333.113364129025;6338.397852204033;6366.790309841115;5099.56653684441;6324.841878953063;6331.905021424683;6345.460635845912;6389.840253993687;5150.707934968903;5821.118546319599;6055.909936211348;6154.169187159855;6182;6008.326294798772;6021.277446706424;6024.759009639741;6052.394760523913;6091.416231779681;5334.493223143795;5942.494887934401;6238.095476155841;6289.528285378524;6341.034279373409;3818.8734323375224;4034.6772258218684;4050.939235911405;4078.9388159177042;4080.551139374607;4948.264060634198;5563.527100196528;5987.832372687459;6102.511799056154;6171.506279497539;4505.549445055468;5151.6393852431465;5568.8305455854725;5830;5965.045592705146;4869.95130048695;5427.972860135674;5474.576610081328;5864.266966629171;5939.4951429129005;4874.098291816025;4930.704157750546;5217.973910130425;5575.275214222125;5734.942650573607;5120.974395128001;5597.580181486486;5967.552433567586;6015.879682406415;6078.6048906820915;5891.646501209942;5905.202797622438;5910.46805787464;5915.556333274935;5937.910931335947 14:08:38 INFO - PROCESS | 1686 | |5;yui.html;726.150404027288;751.6504825256256;759.2407592407592;790.8141586727122;866.0559989611324;13021.414036368362;15320.157391343471;15786.605334866634;15884.76172857408;15966.441174558864;13619.319034048283;14170.433182672707;14689.192094434802;14770.556883293519;14802.629934251649;728.137157468399;759.6771372166835;904.2223687628634;922.3681777982071;923.0400383601046;898.178166977215;902.2150728865896;923.9076092390775;934.7943452440486;935.6210734652477;935.6678379175397;974.9902500975006;987.7678745494838;989.7476143583376;991.167419367731;926.7636752628105;978.2516374973151;981.8527220916884;983.626222035629;985.522021819417;727.8398752274544;729.7664747280872;731.846312274423;733.9302766237253;736.8526294741073;15456.381744730197;15484.30320635574;15517.767233491506;15546.300416481285;15618;15115.697686046327;15138.032055832782;15145.242737863173;15206.847931520764;15228.086314821147;10179.440130792804;12047.518099276018;12119.272843629411;12207;12324.630261092181;3885.825137868803;3931.744436611611;3956.7032472564674;3964.345882929313;4084.7957602119777;106053.46973265085;115141.42429287884;121797;121831;125046;11630.6510804676;11662.050686440816;11815.88184118165;11898.583549575724;11947.402629868471;23916.760832391803;24715;24813.751862481506;24867.751322486907;24989.875050624993;8411.948506436695;8436.578171091422;8446.408751387344;8478.576071196416;8649.264812490883;4379.343098535245;4398.406215160912;4467.92677481772;4550.840720574764;4572.474165471013;3630.7458477906293;3680.6687398134295;3767.3972164454103;3782.583915769263;3785.242951409729;538.6694863686688;569.5671289819767;579.7622974580402;603.9214902062791;615.7383112177307;495.9504049595084;557.8912112138175;584.5498965796313;590.1796502861026;592.2508027345411;8932.19610235082;9923.950380248052;9958.103770660531;9974.950125249326;10125.898741012643;658.9571677840925;660.7555204574243;681.8056853796644;689.486332682145;692.8545005548891;4624.352590637313;4798.304245884327;4822.373091498082;4840.636952228597;4893.168161412568;122109;133844.33077834744;134152;150136.9972600542;150708.49291506945;113554.43222783833;114765.4261728686;119182;119292;121474;104665;106087.16520591287;106444.46777766217;109807;111376;9889.345117962406;9981.351212171186;10117.89882101199;10201.74495637615;10222.080012798586;42793;61162.38837611567;62080.689596551725;62460.687696561225;63090.68454657697;71585.64207179139;82337.58831205805;84249;90153;91831.08168918492;11047.392393418439;13392.196468211938;13453.529126480526;13494.32528373597;13684.794728079285;12635.810462843248;13192.406341714453;13303.201807891557;13623.86376136226;15634.765478518058;12120.878791212328;12175.634730958085;13362.265075420944;14133.717325653635;14450;11580.942095289469;13965.650858728206;14152.716945660823;14219.573412797632;14609.415623374945;13744.86255137436;14021.3690383935;14027.158370497802;14163.575092747235;14225.502107426191;11195;11312.321260724382;11371.43142842871;11441.48513316886;11513.88486115128;10823.404712740874;11281.605143819927;11479.942600286946;11540.192186546861;11812.881871181522 14:08:38 INFO - PROCESS | 1686 | __end_tp_report 14:08:38 INFO - PROCESS | 1686 | __start_cc_report 14:08:38 INFO - PROCESS | 1686 | _x_x_mozilla_cycle_collect,436 14:08:38 INFO - PROCESS | 1686 | __end_cc_report 14:08:38 INFO - PROCESS | 1686 | __startTimestamp1468012118532__endTimestamp 14:08:38 INFO - PROCESS | 1686 | 14:08:38 INFO - PROCESS | 1686 | ------- Summary: start ------- 14:08:38 INFO - PROCESS | 1686 | Number of tests: 6 14:08:38 INFO - PROCESS | 1686 | 14:08:38 INFO - PROCESS | 1686 | [#0] dojo.html Cycles:165 Average:5720.75 Median:5965.31 stddev:757.52 (12.7%) stddev-sans-first:737.13 14:08:38 INFO - PROCESS | 1686 | Values: 3373.9 3375.2 3379.1 3385.0 3416.6 5693.9 5708.6 5747.5 5753.7 5904.6 4891.3 5576.9 5732.3 5796.3 5811.8 5151.8 5202.2 5305.8 5322.8 5354.6 848.5 5216.2 5274.7 5290.9 5363.1 5176.4 5222.1 5243.5 5258.8 5272.7 5176.7 5254.3 5288.6 5295.9 5314.8 5158.0 5181.5 5188.6 5224.8 5229.8 4691.3 4844.4 5746.3 5809.0 5842.4 6089.0 6162.8 6200.8 6275.3 6284.9 6178.6 6182.8 6229.1 6253.2 6257.3 5929.2 5950.3 5955.7 5961.6 5997.4 5215.3 6153.4 6157.9 6273.8 6296.0 6201.0 6207.2 6212.6 6216.8 6234.3 6245.9 6272.3 6280.9 6283.9 6293.9 5832.8 6051.6 6175.4 6219.3 6239.9 6106.6 6186.8 6236.9 6237.8 6251.5 4983.0 5013.2 5038.9 5044.7 5056.7 4385.4 4402.2 4449.5 4479.4 4542.5 5789.8 5820.1 5832.7 5884.3 5888.0 6313.2 6323.7 6325.8 6341.0 6350.4 5690.8 5782.1 5792.4 5804.9 5909.6 4992.9 5490.4 5491.6 5501.1 5510.4 6179.4 6198.0 6349.4 6354.6 6355.1 6215.1 6243.3 6275.6 6308.7 6321.7 6327.0 6330.4 6339.3 6360.1 6365.2 6056.2 6187.2 6277.1 6290.5 6291.6 6197.8 6273.1 6279.4 6318.2 6324.0 5831.2 6017.3 6204.3 6206.4 6234.4 5914.5 6109.7 6140.2 6212.3 6214.9 4746.5 4814.4 5802.9 5944.2 6057.8 6160.0 6173.1 6190.4 6197.2 6206.5 5912.4 5965.3 6034.4 6037.9 6058.0 14:08:38 INFO - PROCESS | 1686 | 14:08:38 INFO - PROCESS | 1686 | [#1] ext.html Cycles:180 Average:72047.69 Median:226469.09 stddev:163505.82 (72.2%) stddev-sans-first:163876.12 14:08:38 INFO - PROCESS | 1686 | Values: 449.7 499.3 514.3 546.0 561.8 35198.5 40360.6 42693.6 42928.4 42984.4 43757.6 44097.3 44150.0 44208.8 44257.6 9744.7 9793.8 9820.9 9828.4 9994.4 9764.9 9767.3 9780.6 9798.2 9854.6 9723.7 9730.3 9764.8 9861.9 9890.5 9797.8 9823.1 9844.0 9859.2 9905.8 8183.2 9749.6 9834.6 9845.0 9878.6 41146.6 41491.0 41639.4 41679.0 41687.8 3168.6 3391.4 3437.9 3465.3 3536.2 29330.6 31316.4 31991.7 32456.0 33138.0 3190.8 3205.3 3207.7 3314.0 3349.9 411769.0 475187.0 475962.0 480651.0 483881.0 34524.3 35787.6 35951.0 36004.3 36030.3 34923.8 35764.0 35814.1 36178.5 36352.8 15270.3 15270.3 15438.8 15480.7 15483.4 13045.8 13099.3 13127.4 13145.2 13161.4 7342.9 7823.1 7880.8 7894.9 7919.1 2706.9 3094.7 3175.5 3218.1 3224.2 797.8 966.9 1010.2 1097.5 1122.5 23608.4 26989.6 31307.0 31746.8 32572.3 948.9 1095.8 1176.9 1217.6 1222.7 13626.2 16085.7 16455.6 16541.0 16715.0 699535.0 705028.0 707359.0 711892.0 715219.0 62676.0 63202.0 63315.4 63319.4 63337.7 1395.4 1422.6 1432.9 1444.6 1445.6 31268.8 31290.0 31296.2 31589.5 31709.2 55275.4 55372.4 55870.7 55966.4 56104.7 609559.0 629097.0 633596.0 634727.0 638064.0 28187.6 28519.6 28566.4 28595.9 28739.7 50933.7 51583.5 51817.7 52463.7 52609.5 41838.4 41972.8 42421.6 42497.0 43407.9 38245.0 40796.4 42170.2 42568.4 43304.4 33791.5 40031.0 41046.0 41169.2 42435.8 35008.6 36103.3 37079.6 37096.4 37693.2 26417.5 26689.2 27021.9 27349.5 27522.6 14:08:38 INFO - PROCESS | 1686 | 14:08:38 INFO - PROCESS | 1686 | [#2] jquery.html Cycles:180 Average:34748.04 Median:390.02 stddev:102565.15 (26297.6%) stddev-sans-first:102820.35 14:08:38 INFO - PROCESS | 1686 | Values: 352.1 383.7 384.2 395.8 404.2 20215.5 21910.7 22110.9 22175.2 22358.9 20880.6 21232.5 21470.2 21783.0 21928.7 5245.9 6027.5 6051.6 6055.2 6063.5 5887.4 5919.2 5936.7 5944.1 5944.1 5803.6 5850.7 5852.1 5869.8 5895.6 5733.7 5791.3 5891.4 5932.8 5936.6 5086.2 5118.1 5154.1 5157.3 5167.5 20951.9 22135.7 23405.9 25523.6 26336.0 1714.4 2107.5 2190.5 2396.2 2539.2 10054.6 10215.8 10229.4 10271.9 10388.7 1822.7 1913.6 1962.8 1975.4 2004.6 103694.0 124114.4 124203.0 127096.7 129033.0 9406.5 9448.4 11630.5 11664.5 11667.5 12642.4 13875.2 14353.4 14371.6 14512.6 8610.7 8759.3 8777.3 8870.6 8871.1 8155.4 8488.0 8551.4 8808.7 8928.3 4112.3 4440.7 4512.7 4532.8 4570.7 1910.9 1947.0 1961.6 1969.4 1975.2 851.3 917.2 918.4 992.3 1002.3 21056.1 21409.7 21919.0 21972.5 22111.7 877.8 949.6 954.5 958.3 975.4 9629.4 9746.4 11545.8 11558.9 11634.8 581900.0 605191.0 617891.0 641350.7 642466.0 90831.0 96388.6 98530.5 111579.0 132280.0 844.7 913.3 947.8 961.6 993.0 18698.7 18882.0 19333.4 19370.2 19403.1 46758.0 49237.8 50635.0 51585.0 51804.7 63943.7 69839.7 74103.0 74815.0 75143.0 6881.3 7206.6 7942.0 7963.7 8121.9 10157.1 12015.5 12402.8 12611.8 12826.0 10866.7 10886.7 10900.6 10906.8 10932.0 10963.7 11002.4 11004.0 11042.8 11156.5 10239.6 10645.0 11275.5 11297.5 11392.1 5949.6 7863.1 7895.6 7907.5 8105.8 9982.0 10891.5 10925.7 10926.0 11047.3 14:08:38 INFO - PROCESS | 1686 | 14:08:38 INFO - PROCESS | 1686 | [#3] mootools.html Cycles:180 Average:5824.62 Median:4512.71 stddev:3284.16 (72.8%) stddev-sans-first:3277.87 14:08:38 INFO - PROCESS | 1686 | Values: 1578.7 1626.6 1864.5 1936.9 1956.9 7775.0 8084.4 8703.7 8779.0 9261.4 8765.9 8797.7 8978.0 8986.4 8992.1 2363.1 2391.8 2392.1 2402.3 2403.7 2349.1 2360.3 2370.5 2376.3 2398.7 2005.2 2059.7 2105.9 2206.6 2348.5 2330.8 2344.5 2345.0 2345.6 2353.6 2333.7 2336.4 2339.0 2343.9 2355.5 9006.9 9118.3 9194.9 9199.4 9226.5 4550.8 5155.2 5382.4 5475.1 5485.3 3480.1 3514.5 3595.8 3608.7 3647.1 1061.1 1073.0 1088.5 1097.4 1097.7 11669.6 11827.7 11864.9 11888.6 11905.8 4061.0 4634.4 4636.6 4837.1 4845.5 10112.5 10124.0 10129.2 10157.9 10174.8 5312.9 5426.2 5427.4 5440.2 5460.0 4192.5 4474.6 4783.9 4930.6 4967.8 3954.6 4022.1 4078.2 4095.7 4146.5 1300.9 1308.7 1312.8 1317.2 1321.9 801.5 841.4 856.7 895.4 969.5 6017.2 6111.0 6137.0 6155.3 6250.5 991.8 995.4 1012.3 1028.7 1037.8 4063.0 4069.6 4161.0 4173.3 4187.3 10639.7 10908.5 10985.8 10991.8 11022.0 10819.2 10987.3 11009.7 11137.0 11138.4 8224.5 8444.7 8475.6 8518.3 8532.1 5976.6 5981.6 6025.3 6026.2 6035.5 10016.6 10143.7 10222.2 10290.5 10323.4 10000.4 10283.2 10575.2 10605.6 10605.6 6703.8 7040.5 7081.5 7261.9 7391.9 8681.7 8683.3 8748.2 8755.6 8760.8 7595.3 7762.4 7806.2 7884.4 7884.6 7479.6 7573.3 7591.2 7693.8 7752.3 7110.4 7216.5 7226.0 7239.1 7253.8 4626.2 5043.5 5094.4 5095.4 5200.3 5107.6 5154.9 5280.7 5335.8 5360.5 14:08:38 INFO - PROCESS | 1686 | 14:08:38 INFO - PROCESS | 1686 | [#4] prototype.html Cycles:180 Average:4728.72 Median:5331.67 stddev:1496.04 (28.1%) stddev-sans-first:1463.02 14:08:38 INFO - PROCESS | 1686 | Values: 310.7 315.1 316.9 318.3 320.9 5666.4 5689.7 5714.4 5731.5 5772.7 4263.5 4749.2 5625.5 5641.8 5653.9 3720.7 4106.3 4224.8 4232.0 4250.9 3841.6 4202.0 4251.7 4262.4 4264.4 4123.3 4232.1 4244.2 4260.3 4261.2 3381.4 3652.7 3703.5 4028.9 4230.9 3258.9 3359.0 3712.4 3713.4 3748.4 4358.3 4566.5 5206.8 5437.9 5485.2 4601.4 4631.9 4671.5 4847.4 4960.5 5759.8 5774.9 5789.2 5816.5 5845.5 3103.8 3574.2 4029.9 4035.7 4048.7 4791.3 6176.8 6191.7 6195.4 6324.7 3403.2 3562.1 4049.7 4060.7 4084.6 3760.7 3863.9 4144.4 4149.4 4155.7 4281.4 4712.9 4874.4 4875.8 4885.7 5328.8 5383.9 5831.2 5956.2 6071.1 1369.7 1413.0 1414.4 1416.6 1424.8 741.8 840.3 857.1 873.3 918.6 5426.6 5495.9 5506.1 5506.3 5556.7 4708.3 4927.0 5989.9 6057.8 6109.8 4824.9 5118.1 5399.5 5481.6 5520.8 2831.7 2959.3 2979.9 3086.8 3212.7 5437.3 6039.5 6170.8 6270.2 6335.6 6261.4 6319.1 6333.1 6338.4 6366.8 5099.6 6324.8 6331.9 6345.5 6389.8 5150.7 5821.1 6055.9 6154.2 6182.0 6008.3 6021.3 6024.8 6052.4 6091.4 5334.5 5942.5 6238.1 6289.5 6341.0 3818.9 4034.7 4050.9 4078.9 4080.6 4948.3 5563.5 5987.8 6102.5 6171.5 4505.5 5151.6 5568.8 5830.0 5965.0 4870.0 5428.0 5474.6 5864.3 5939.5 4874.1 4930.7 5218.0 5575.3 5734.9 5121.0 5597.6 5967.6 6015.9 6078.6 5891.6 5905.2 5910.5 5915.6 5937.9 14:08:38 INFO - PROCESS | 1686 | 14:08:38 INFO - PROCESS | 1686 | [#5] yui.html Cycles:180 Average:24310.14 Median:24764.38 stddev:37837.85 (152.8%) stddev-sans-first:37902.55 14:08:38 INFO - PROCESS | 1686 | Values: 726.2 751.7 759.2 790.8 866.1 13021.4 15320.2 15786.6 15884.8 15966.4 13619.3 14170.4 14689.2 14770.6 14802.6 728.1 759.7 904.2 922.4 923.0 898.2 902.2 923.9 934.8 935.6 935.7 975.0 987.8 989.7 991.2 926.8 978.3 981.9 983.6 985.5 727.8 729.8 731.8 733.9 736.9 15456.4 15484.3 15517.8 15546.3 15618.0 15115.7 15138.0 15145.2 15206.8 15228.1 10179.4 12047.5 12119.3 12207.0 12324.6 3885.8 3931.7 3956.7 3964.3 4084.8 106053.5 115141.4 121797.0 121831.0 125046.0 11630.7 11662.1 11815.9 11898.6 11947.4 23916.8 24715.0 24813.8 24867.8 24989.9 8411.9 8436.6 8446.4 8478.6 8649.3 4379.3 4398.4 4467.9 4550.8 4572.5 3630.7 3680.7 3767.4 3782.6 3785.2 538.7 569.6 579.8 603.9 615.7 496.0 557.9 584.5 590.2 592.3 8932.2 9924.0 9958.1 9975.0 10125.9 659.0 660.8 681.8 689.5 692.9 4624.4 4798.3 4822.4 4840.6 4893.2 122109.0 133844.3 134152.0 150137.0 150708.5 113554.4 114765.4 119182.0 119292.0 121474.0 104665.0 106087.2 106444.5 109807.0 111376.0 9889.3 9981.4 10117.9 10201.7 10222.1 42793.0 61162.4 62080.7 62460.7 63090.7 71585.6 82337.6 84249.0 90153.0 91831.1 11047.4 13392.2 13453.5 13494.3 13684.8 12635.8 13192.4 13303.2 13623.9 15634.8 12120.9 12175.6 13362.3 14133.7 14450.0 11580.9 13965.7 14152.7 14219.6 14609.4 13744.9 14021.4 14027.2 14163.6 14225.5 11195.0 11312.3 11371.4 11441.5 11513.9 10823.4 11281.6 11479.9 11540.2 11812.9 14:08:38 INFO - PROCESS | 1686 | -------- Summary: end -------- 14:08:38 INFO - PROCESS | 1686 | 14:08:39 INFO - TEST-INFO | 1686: exit 0 14:08:39 INFO - TEST-OK | dromaeo_css | took 1112297ms 14:08:39 INFO - TEST-START | kraken 14:08:39 INFO - operating with platform_type : mac_ 14:08:39 INFO - Initialising browser for kraken test... 14:08:39 INFO - TEST-INFO | started process 1803 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/tmpdTGoes/profile http://localhost:49268/getInfo.html) 14:08:42 INFO - PROCESS | 1803 | __metrics Screen width/height:1600/1200 14:08:42 INFO - PROCESS | 1803 | colorDepth:24 14:08:42 INFO - PROCESS | 1803 | Browser inner width/height: 1024/689 14:08:42 INFO - PROCESS | 1803 | __metrics 14:08:42 ERROR - PROCESS | 1803 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2957: TypeError: this.tabs is undefined 14:08:42 INFO - TEST-INFO | 1803: exit 0 14:08:42 INFO - Browser initialized. 14:08:42 INFO - Running cycle 1/1 for kraken test... 14:08:42 INFO - TEST-INFO | started process 1806 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/tmpdTGoes/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:08:54 INFO - PROCESS | 1806 | RSS: Main: 254464000 14:08:54 INFO - PROCESS | 1806 | 14:08:57 INFO - PROCESS | 1806 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49268/tests/kraken/driver.html?testName=audio-beat-detection) 14:08:58 INFO - PROCESS | 1806 | RSS: Main: 267243520 14:08:58 INFO - PROCESS | 1806 | 14:09:01 INFO - PROCESS | 1806 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49268/tests/kraken/driver.html?testName=audio-dft) 14:09:01 INFO - PROCESS | 1806 | RSS: Main: 271859712 14:09:01 INFO - PROCESS | 1806 | 14:09:05 INFO - PROCESS | 1806 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49268/tests/kraken/driver.html?testName=audio-fft) 14:09:06 INFO - PROCESS | 1806 | RSS: Main: 271900672 14:09:06 INFO - PROCESS | 1806 | 14:09:08 INFO - PROCESS | 1806 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49268/tests/kraken/driver.html?testName=audio-oscillator) 14:09:08 INFO - PROCESS | 1806 | RSS: Main: 272805888 14:09:08 INFO - PROCESS | 1806 | 14:09:10 INFO - PROCESS | 1806 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49268/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:09:11 INFO - PROCESS | 1806 | RSS: Main: 273498112 14:09:11 INFO - PROCESS | 1806 | 14:09:14 INFO - PROCESS | 1806 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49268/tests/kraken/driver.html?testName=imaging-darkroom) 14:09:14 INFO - PROCESS | 1806 | RSS: Main: 274042880 14:09:14 INFO - PROCESS | 1806 | 14:09:17 INFO - PROCESS | 1806 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49268/tests/kraken/driver.html?testName=imaging-desaturate) 14:09:18 INFO - PROCESS | 1806 | RSS: Main: 274239488 14:09:18 INFO - PROCESS | 1806 | 14:09:21 INFO - PROCESS | 1806 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49268/tests/kraken/driver.html?testName=json-parse-financial) 14:09:21 INFO - PROCESS | 1806 | RSS: Main: 274358272 14:09:21 INFO - PROCESS | 1806 | 14:09:23 INFO - PROCESS | 1806 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49268/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:09:24 INFO - PROCESS | 1806 | RSS: Main: 274145280 14:09:24 INFO - PROCESS | 1806 | 14:09:26 INFO - PROCESS | 1806 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49268/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:09:26 INFO - PROCESS | 1806 | RSS: Main: 274452480 14:09:26 INFO - PROCESS | 1806 | 14:09:29 INFO - PROCESS | 1806 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49268/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:09:29 INFO - PROCESS | 1806 | RSS: Main: 274501632 14:09:29 INFO - PROCESS | 1806 | 14:09:32 INFO - PROCESS | 1806 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49268/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:09:33 INFO - PROCESS | 1806 | RSS: Main: 274976768 14:09:33 INFO - PROCESS | 1806 | 14:09:36 INFO - PROCESS | 1806 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49268/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:09:37 INFO - PROCESS | 1806 | RSS: Main: 274661376 14:09:37 INFO - PROCESS | 1806 | 14:09:39 INFO - PROCESS | 1806 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49268/tests/kraken/driver.html?testName=ai-astar) 14:09:39 INFO - PROCESS | 1806 | RSS: Main: 275644416 14:09:39 INFO - PROCESS | 1806 | 14:09:39 INFO - PROCESS | 1806 | __start_tp_report 14:09:39 INFO - PROCESS | 1806 | _x_x_mozilla_page_load 14:09:39 INFO - PROCESS | 1806 | _x_x_mozilla_page_load_details 14:09:39 INFO - PROCESS | 1806 | |i|pagename|runs| 14:09:39 INFO - PROCESS | 1806 | |0;ai-astar;105;120;155;156;119;116;114;117;116;118 14:09:39 INFO - PROCESS | 1806 | |1;audio-beat-detection;147;109;135;157;110;130;127;116;198;97 14:09:39 INFO - PROCESS | 1806 | |2;audio-dft;199;196;206;233;196;202;229;275;200;197 14:09:39 INFO - PROCESS | 1806 | |3;audio-fft;68;83;76;136;59;79;52;82;162;80 14:09:39 INFO - PROCESS | 1806 | |4;audio-oscillator;70;74;130;71;72;71;115;71;74;115 14:09:39 INFO - PROCESS | 1806 | |5;imaging-gaussian-blur;89;88;114;131;89;86;90;88;89;87 14:09:39 INFO - PROCESS | 1806 | |6;imaging-darkroom;96;96;95;132;149;98;98;98;97;153 14:09:39 INFO - PROCESS | 1806 | |7;imaging-desaturate;91;97;91;93;93;89;91;94;91;92 14:09:39 INFO - PROCESS | 1806 | |8;json-parse-financial;56;60;55;58;55;61;77;84;86;59 14:09:39 INFO - PROCESS | 1806 | |9;json-stringify-tinderbox;69;70;70;69;77;78;72;71;68;70 14:09:39 INFO - PROCESS | 1806 | |10;stanford-crypto-aes;90;88;87;89;87;105;100;107;108;75 14:09:39 INFO - PROCESS | 1806 | |11;stanford-crypto-ccm;171;166;158;162;156;154;168;149;195;165 14:09:39 INFO - PROCESS | 1806 | |12;stanford-crypto-pbkdf2;220;184;188;185;194;260;258;186;188;188 14:09:39 INFO - PROCESS | 1806 | |13;stanford-crypto-sha256-iterative;70;89;91;90;92;71;69;69;70;72 14:09:39 INFO - PROCESS | 1806 | __end_tp_report 14:09:39 INFO - PROCESS | 1806 | __start_cc_report 14:09:39 INFO - PROCESS | 1806 | _x_x_mozilla_cycle_collect,1127 14:09:39 INFO - PROCESS | 1806 | __end_cc_report 14:09:39 INFO - PROCESS | 1806 | __startTimestamp1468012179441__endTimestamp 14:09:39 INFO - PROCESS | 1806 | 14:09:39 INFO - PROCESS | 1806 | ------- Summary: start ------- 14:09:39 INFO - PROCESS | 1806 | Number of tests: 14 14:09:39 INFO - PROCESS | 1806 | 14:09:39 INFO - PROCESS | 1806 | [#0] ai-astar Cycles:10 Average:123.60 Median:118.50 stddev:17.32 (14.6%) stddev-sans-first:17.01 14:09:39 INFO - PROCESS | 1806 | Values: 105.0 120.0 155.0 156.0 119.0 116.0 114.0 117.0 116.0 118.0 14:09:39 INFO - PROCESS | 1806 | 14:09:39 INFO - PROCESS | 1806 | [#1] audio-beat-detection Cycles:10 Average:132.60 Median:141.00 stddev:29.32 (20.8%) stddev-sans-first:30.63 14:09:39 INFO - PROCESS | 1806 | Values: 147.0 109.0 135.0 157.0 110.0 130.0 127.0 116.0 198.0 97.0 14:09:39 INFO - PROCESS | 1806 | 14:09:39 INFO - PROCESS | 1806 | [#2] audio-dft Cycles:10 Average:213.30 Median:204.00 stddev:25.53 (12.5%) stddev-sans-first:26.55 14:09:39 INFO - PROCESS | 1806 | Values: 199.0 196.0 206.0 233.0 196.0 202.0 229.0 275.0 200.0 197.0 14:09:39 INFO - PROCESS | 1806 | 14:09:39 INFO - PROCESS | 1806 | [#3] audio-fft Cycles:10 Average:87.70 Median:77.50 stddev:34.43 (44.4%) stddev-sans-first:35.77 14:09:39 INFO - PROCESS | 1806 | Values: 68.0 83.0 76.0 136.0 59.0 79.0 52.0 82.0 162.0 80.0 14:09:39 INFO - PROCESS | 1806 | 14:09:39 INFO - PROCESS | 1806 | [#4] audio-oscillator Cycles:10 Average:86.30 Median:71.00 stddev:23.65 (33.3%) stddev-sans-first:24.33 14:09:39 INFO - PROCESS | 1806 | Values: 70.0 74.0 130.0 71.0 72.0 71.0 115.0 71.0 74.0 115.0 14:09:39 INFO - PROCESS | 1806 | 14:09:39 INFO - PROCESS | 1806 | [#5] imaging-gaussian-blur Cycles:10 Average:95.10 Median:88.50 stddev:15.03 (17.0%) stddev-sans-first:15.78 14:09:39 INFO - PROCESS | 1806 | Values: 89.0 88.0 114.0 131.0 89.0 86.0 90.0 88.0 89.0 87.0 14:09:39 INFO - PROCESS | 1806 | 14:09:39 INFO - PROCESS | 1806 | [#6] imaging-darkroom Cycles:10 Average:111.20 Median:96.50 stddev:23.71 (24.6%) stddev-sans-first:24.50 14:09:39 INFO - PROCESS | 1806 | Values: 96.0 96.0 95.0 132.0 149.0 98.0 98.0 98.0 97.0 153.0 14:09:39 INFO - PROCESS | 1806 | 14:09:39 INFO - PROCESS | 1806 | [#7] imaging-desaturate Cycles:10 Average:92.20 Median:92.50 stddev:2.20 (2.4%) stddev-sans-first:2.29 14:09:39 INFO - PROCESS | 1806 | Values: 91.0 97.0 91.0 93.0 93.0 89.0 91.0 94.0 91.0 92.0 14:09:39 INFO - PROCESS | 1806 | 14:09:39 INFO - PROCESS | 1806 | [#8] json-parse-financial Cycles:10 Average:65.10 Median:60.50 stddev:12.26 (20.3%) stddev-sans-first:12.55 14:09:39 INFO - PROCESS | 1806 | Values: 56.0 60.0 55.0 58.0 55.0 61.0 77.0 84.0 86.0 59.0 14:09:39 INFO - PROCESS | 1806 | 14:09:39 INFO - PROCESS | 1806 | [#9] json-stringify-tinderbox Cycles:10 Average:71.40 Median:70.50 stddev:3.41 (4.8%) stddev-sans-first:3.50 14:09:39 INFO - PROCESS | 1806 | Values: 69.0 70.0 70.0 69.0 77.0 78.0 72.0 71.0 68.0 70.0 14:09:39 INFO - PROCESS | 1806 | 14:09:39 INFO - PROCESS | 1806 | [#10] stanford-crypto-aes Cycles:10 Average:93.60 Median:87.00 stddev:10.83 (12.5%) stddev-sans-first:11.41 14:09:39 INFO - PROCESS | 1806 | Values: 90.0 88.0 87.0 89.0 87.0 105.0 100.0 107.0 108.0 75.0 14:09:39 INFO - PROCESS | 1806 | 14:09:39 INFO - PROCESS | 1806 | [#11] stanford-crypto-ccm Cycles:10 Average:164.40 Median:165.50 stddev:12.73 (7.7%) stddev-sans-first:13.28 14:09:39 INFO - PROCESS | 1806 | Values: 171.0 166.0 158.0 162.0 156.0 154.0 168.0 149.0 195.0 165.0 14:09:39 INFO - PROCESS | 1806 | 14:09:39 INFO - PROCESS | 1806 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:205.10 Median:191.00 stddev:30.27 (15.9%) stddev-sans-first:31.63 14:09:39 INFO - PROCESS | 1806 | Values: 220.0 184.0 188.0 185.0 194.0 260.0 258.0 186.0 188.0 188.0 14:09:39 INFO - PROCESS | 1806 | 14:09:39 INFO - PROCESS | 1806 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:78.30 Median:80.50 stddev:10.56 (13.1%) stddev-sans-first:10.77 14:09:39 INFO - PROCESS | 1806 | Values: 70.0 89.0 91.0 90.0 92.0 71.0 69.0 69.0 70.0 72.0 14:09:39 INFO - PROCESS | 1806 | -------- Summary: end -------- 14:09:39 INFO - PROCESS | 1806 | 14:09:40 INFO - TEST-INFO | 1806: exit 0 14:09:40 INFO - TEST-OK | kraken | took 60996ms 14:09:40 INFO - SUITE-END | took 1173s 14:09:40 INFO - Completed test suite (00:19:33) 14:09:40 INFO - javascript benchmark 14:09:40 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7376.73139275502, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3373.881914133006, 3375.206826395798, 3379.1045372976164, 3384.966150338496, 3416.5558477397935, 5693.943060569393, 5708.600397972149, 5747.511461525765, 5753.662875532192, 5904.586678932476, 4891.315215869772, 5576.9163462548095, 5732.254806875111, 5796.333421656522, 5811.767529298823, 5151.845444636667, 5202.167653175493, 5305.840824775263, 5322.76047577858, 5354.5716342692685, 848.5173454872121, 5216.24364467152, 5274.736263186845, 5290.947090529103, 5363.061464243761, 5176.352955880515, 5222.138347172712, 5243.501867322599, 5258.789648414059, 5272.736363181825, 5176.689398636094, 5254.3169387979315, 5288.603354748371, 5295.867603309948, 5314.840554783363, 5158.045761534128, 5181.4559471255725, 5188.610854185951, 5224.791008359661, 5229.816956406507, 4691.29630555416, 4844.4186697596515, 5746.2529871116485, 5809.0, 5842.444967728059, 6089.0, 6162.84592885177, 6200.844978875519, 6275.341089185616, 6284.937150628481, 6178.567500274982, 6182.814515564541, 6229.09678096678, 6253.1558239637525, 6257.342978987186, 5929.169916211734, 5950.256217972754, 5955.672438015908, 5961.642301461883, 5997.370276120988, 5215.269862219292, 6153.384661533811, 6157.9384206158265, 6273.811785646347, 6295.96852015737, 6201.007838745779, 6207.224096987877, 6212.565120441616, 6216.813495595139, 6234.3453937336835, 6245.906311405332, 6272.3100458949475, 6280.8694435001225, 6283.937160628427, 6293.905591416133, 5832.825015249549, 6051.57638965277, 6175.3824617538785, 6219.315875253718, 6239.937600623935, 6106.603070800384, 6186.752529898844, 6236.906446403307, 6237.812865614039, 6251.499880009588, 4982.953579748221, 5013.24801279811, 5038.874028149326, 5044.747762611854, 5056.696598204119, 4385.386045953569, 4402.163588918095, 4449.510553839075, 4479.440069991251, 4542.477615074243, 5789.768409263583, 5820.097884827858, 5832.708364581754, 5884.264466941632, 5887.970560147171, 6313.2424109107205, 6323.715432805535, 6325.810225693144, 6340.953742632414, 6350.428461438492, 5690.829275121753, 5782.10377391505, 5792.362840087587, 5804.9419505805245, 5909.556783241274, 4992.851644121873, 5490.368607610176, 5491.560675145979, 5501.119820828648, 5510.393856675762, 6179.412955769195, 6198.008318668992, 6349.428551430394, 6354.618722876549, 6355.110284560165, 6215.12988181664, 6243.282022567463, 6275.623462592259, 6308.747650093945, 6321.683915804099, 6327.019312006646, 6330.39861213184, 6339.334369891095, 6360.141380913703, 6365.172527571386, 6056.182415373868, 6187.226596675416, 6277.058441233851, 6290.465310448663, 6291.591046581958, 6197.752089916353, 6273.059041143865, 6279.434850863444, 6318.178636777189, 6324.0, 5831.212786273968, 6017.2779266488305, 6204.286507051746, 6206.441420272197, 6234.438900498977, 5914.467697907209, 6109.69451527413, 6140.1710769047395, 6212.254529456494, 6214.875702485834, 4746.525347465225, 4814.398200224972, 5802.912956305574, 5944.167816505779, 6057.757689692363, 6160.0, 6173.104899789595, 6190.380961903774, 6197.194364732556, 6206.472449841814, 5912.408759124053, 5965.313988891333, 6034.39656034393, 6037.909431358621, 6058.0], "value": 5675.128795171366, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [449.65601314994035, 499.291006770386, 514.3262326352478, 545.9535939445148, 561.7724821447315, 35198.47202291965, 40360.59639403605, 42693.573064269345, 42928.35607465891, 42984.35523467151, 43757.56242437575, 44097.338539921846, 44150.0, 44208.778956105176, 44257.557424425744, 9744.65893693719, 9793.804123917518, 9820.90179098207, 9828.361156524803, 9994.350367226107, 9764.853527197098, 9767.267454940873, 9780.55987480565, 9798.216142708601, 9854.605815767361, 9723.659671911484, 9730.270229732763, 9764.804703905918, 9861.852072218922, 9890.456024918627, 9797.755056123618, 9823.066808653166, 9844.0, 9859.161971232454, 9905.801883962353, 8183.181681831828, 9749.561269742879, 9834.557444914924, 9845.0, 9878.604855805832, 41146.58853411458, 41491.0, 41639.375409368884, 41678.95802604929, 41687.7915610423, 3168.5722427472456, 3391.406503861814, 3437.862485500577, 3465.28961562879, 3536.1513236823234, 29330.560041599394, 31316.37367252665, 31991.680083199102, 32456.0, 33138.0, 3190.8245046522434, 3205.2788122672214, 3207.695268949446, 3314.0, 3349.949750753741, 411769.0, 475187.0, 475962.0, 480651.0, 483881.0, 34524.30951380958, 35787.64212357895, 35951.0, 36004.27991440209, 36030.279394412486, 34923.825380873444, 35764.0, 35814.104647384025, 36178.457323140174, 36352.81823590918, 15270.31283592241, 15270.31283592241, 15438.842086843531, 15480.690386192213, 15483.380664773507, 13045.804312935314, 13099.279539625222, 13127.409266583027, 13145.21128732279, 13161.407736651874, 7342.889856652155, 7823.061232652004, 7880.802979925433, 7894.921050789419, 7919.089304729914, 2706.9458610827674, 3094.6905309469325, 3175.4601717708047, 3218.066760639435, 3224.2261857154585, 797.8125140591957, 966.8839739231337, 1010.2220092636865, 1097.5390336058874, 1122.528538014036, 23608.409789755395, 26989.595156072675, 31307.0, 31746.841265793522, 32572.348553028805, 948.9051094890456, 1095.7644106517137, 1176.8823117688335, 1217.5738491527895, 1222.6943264183953, 13626.182429054288, 16085.678286434206, 16455.588610284838, 16541.007539547667, 16714.997100174027, 699535.0, 705028.0, 707359.0, 711892.0, 715219.0, 62676.0, 63202.0, 63315.36684633187, 63319.36680633227, 63337.68331158407, 1395.3651088754593, 1422.566117334223, 1432.9068610540282, 1444.59551325629, 1445.580781573332, 31268.843655781577, 31290.0, 31296.21759456032, 31589.52615710812, 31709.20726981844, 55275.44724552703, 55372.44627553673, 55870.720646396505, 55966.440335596126, 56104.71947640236, 609559.0, 629097.0, 633596.0, 634727.0, 638064.0, 28187.57718634263, 28519.572206416506, 28566.42867142687, 28595.857020714764, 28739.712602873704, 50933.74533127311, 51583.48416515787, 51817.7409112952, 52463.73768131135, 52609.47390526199, 41838.37242441305, 41972.79013604912, 42421.575784242996, 42497.0, 43407.91480212894, 38245.0, 40796.388054179806, 42170.1565968685, 42568.36147457729, 43304.350434742875, 33791.49312760261, 40030.99922501961, 41046.0, 41169.1766164681, 42435.787821060694, 35008.649913501555, 36103.27793444064, 37079.62920370762, 37096.44355334618, 37693.246135077694, 26417.471650567266, 26689.199324020312, 27021.86489067542, 27349.495777732416, 27522.587161192998], "value": 19093.39572318655, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [352.13023831137093, 383.66046049246427, 384.2123646524625, 395.8218801539308, 404.24204616344355, 20215.49461263469, 21910.671339929915, 22110.894455277252, 22175.223867164652, 22358.8820558972, 20880.582388352224, 21232.4691882703, 21470.248541301058, 21783.0, 21928.671069933964, 5245.924585459981, 6027.487663548582, 6051.636901785907, 6055.212822333113, 6063.514918806507, 5887.381824908387, 5919.230500035011, 5936.7328470218945, 5944.078667806475, 5944.138099975501, 5803.564732645069, 5850.707464626773, 5852.092925596539, 5869.794557190499, 5895.646261224319, 5733.655980641175, 5791.27609048871, 5891.381404952483, 5932.822015339503, 5936.584439089265, 5086.237064440326, 5118.078745825787, 5154.12379895415, 5157.277981082651, 5167.48325167484, 20951.8952405237, 22135.667964980537, 23405.89346958782, 25523.617145742828, 26336.0, 1714.4170981866225, 2107.483666501717, 2190.518086021073, 2396.1852969990287, 2539.2382285314516, 10054.648087316982, 10215.795684086352, 10229.437380944046, 10271.897281027168, 10388.688339349832, 1822.735703323024, 1913.6268427656612, 1962.8331591814713, 1975.4370004548634, 2004.6091012252616, 103694.0, 124114.37942810319, 124203.0, 127096.72903270941, 129033.0, 9406.48264345454, 9448.433094014381, 11630.476628551736, 11664.475098620582, 11667.533298667959, 12642.367881606067, 13875.236861972486, 14353.354099065567, 14371.568852934428, 14512.637184070272, 8610.741677749678, 8759.255463285564, 8777.29781617469, 8870.645174193089, 8871.112888711206, 8155.388345874083, 8487.957560212159, 8551.401401901807, 8808.735737927873, 8928.285737141143, 4112.280350938574, 4440.68915175941, 4512.661550383668, 4532.841350552715, 4570.702904311209, 1910.8566857485744, 1946.9610607787765, 1961.6469035573448, 1969.3796454117194, 1975.1605567633699, 851.3019324154134, 917.2386918857333, 918.4443411735804, 992.2905122837207, 1002.2933831648816, 21056.052477638543, 21409.67885481719, 21919.0, 21972.450688732908, 22111.668324975137, 877.7586163804878, 949.6106596295485, 954.4941181173989, 958.3052287091803, 975.3708857786688, 9629.422234665803, 9746.415215087118, 11545.769084618261, 11558.942205289088, 11634.76730465386, 581900.0, 605191.0, 617891.0, 641350.725710081, 642466.0, 90831.0, 96388.59028524203, 98530.52204216942, 111579.0, 132280.0, 844.6832437835811, 913.3287034029983, 947.772534591693, 961.6105477281712, 992.9751756206008, 18698.719519206952, 18881.961492118066, 19333.419997400102, 19370.2251909922, 19403.12685929165, 46758.0, 49237.753811230716, 50635.0, 51585.0, 51804.740976294874, 63943.680281598296, 69839.65080174567, 74103.0, 74815.0, 75143.0, 6881.277465866212, 7206.56760594366, 7941.960290198512, 7963.721269755531, 8121.918780812116, 10157.085862272432, 12015.519379224734, 12402.75194496123, 12611.810822837848, 12826.0, 10866.728331791452, 10886.727831804268, 10900.618478353219, 10906.781864362827, 10932.0, 10963.725906852393, 11002.449877506253, 11004.0, 11042.834357484804, 11156.49795759209, 10239.641612543524, 10644.988726071011, 11275.492602832728, 11297.548098075986, 11392.08863290918, 5949.583529152917, 7863.135055143815, 7895.64469598858, 7907.525548467111, 8105.797355066171, 9982.0, 10891.529643498343, 10925.726856828325, 10926.0, 11047.337159770439], "value": 9417.036508931464, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1578.7395079811831, 1626.6177448299647, 1864.515226041229, 1936.8644194906353, 1956.9412917612476, 7774.961125194366, 8084.393670474723, 8703.65185392585, 8778.956105219473, 9261.351705380626, 8765.86851197231, 8797.692080777175, 8978.0, 8986.37095403322, 8992.100789921005, 2363.078399424226, 2391.796697280733, 2392.102961389479, 2402.255300856731, 2403.7380375302932, 2349.0603758496654, 2360.315508502541, 2370.490344575916, 2376.2633583589054, 2398.6641870138196, 2005.1979208316643, 2059.7116403703494, 2105.9262925797602, 2206.6098358034496, 2348.4598542335275, 2330.8368414211013, 2344.5076533927895, 2345.0, 2345.57779599672, 2353.5645905507363, 2333.708286464192, 2336.380859072347, 2339.017612602694, 2343.906243750248, 2355.5406695694346, 9006.86489702655, 9118.270538356915, 9194.908050919472, 9199.402038867453, 9226.53867306632, 4550.83953591832, 5155.200943853709, 5382.381026182, 5475.06923822951, 5485.314335708036, 3480.1473638958364, 3514.4552594347915, 3595.8022308773006, 3608.6932610728118, 3647.1246900743895, 1061.1086687182803, 1072.9731756706067, 1088.4938503595786, 1097.358045543358, 1097.6761855252719, 11669.591564295293, 11827.704307392298, 11864.88135118655, 11888.643340699793, 11905.821412678817, 4060.9847538115473, 4634.37435946143, 4636.582707556337, 4837.129316723023, 4845.466998630219, 10112.544935477921, 10124.0, 10129.189664826796, 10157.9492102539, 10174.796504070026, 5312.946870531323, 5426.158945363475, 5427.43011983744, 5440.238366628675, 5459.972700136554, 4192.4759405074365, 4474.574915383034, 4783.928241076386, 4930.556249937523, 4967.801287948514, 3954.5649978502342, 4022.0749227677798, 4078.163976384834, 4095.672346212296, 4146.460960075231, 1300.876416740408, 1308.6597484654058, 1312.7768279392335, 1317.1701827848394, 1321.9339033048502, 801.485486143266, 841.4278290762218, 856.6958729651009, 895.4269267668698, 969.5103972493846, 6017.157597936292, 6111.022236442148, 6137.0, 6155.261368635703, 6250.531210159165, 991.7619771254991, 995.4226548601794, 1012.336919317848, 1028.681108856257, 1037.7509397744639, 4062.979685101615, 4069.552349241581, 4160.979195104005, 4173.31140361843, 4187.309093999456, 10639.680809575726, 10908.454577271104, 10985.780284394268, 10991.835122473169, 11022.0, 10819.242653014371, 10987.285826421257, 11009.669709908716, 11137.0, 11138.443077846237, 8224.547649879314, 8444.746657600283, 8475.618597163142, 8518.275946544489, 8532.146785321418, 5976.581639285208, 5981.641101533922, 6025.3070896845675, 6026.186464827192, 6035.486983606443, 10016.64941727036, 10143.7464063399, 10222.233332499944, 10290.485475726035, 10323.380597164194, 10000.449975251431, 10283.228757843042, 10575.153987680813, 10605.575776968835, 10605.575776969143, 6703.765368212089, 7040.471964602573, 7081.539699919489, 7261.910713392822, 7391.889121663287, 8681.696140635047, 8683.348748843735, 8748.168923952215, 8755.562221888753, 8760.780980475283, 7595.3164215218685, 7762.3790096793255, 7806.1803510632835, 7884.4086693497065, 7884.605769711607, 7479.551226926184, 7573.2805383488485, 7591.164971852982, 7693.769186924401, 7752.341051010501, 7110.395616372666, 7216.494845360774, 7225.963870180615, 7239.131304243314, 7253.782386528413, 4626.236670949255, 5043.4956504349275, 5094.439611642642, 5095.363079615048, 5200.349956255468, 5107.591392688501, 5154.948450515597, 5280.683159010472, 5335.813246536352, 5360.517553420055], "value": 4671.572431368886, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [310.6598274888997, 315.1286692295801, 316.92562214094227, 318.3299155278141, 320.8572185377505, 5666.433356664332, 5689.658620482769, 5714.428557144294, 5731.541476681866, 5772.719775688601, 4263.5310115887305, 4749.240121580548, 5625.465580769831, 5641.802536911209, 5653.886922261562, 3720.7209459290525, 4106.342985122381, 4224.809883555247, 4232.02663387421, 4250.872473825791, 3841.558220804601, 4201.978990105045, 4251.744895306291, 4262.360645903108, 4264.420025884342, 4123.278426275405, 4232.068944832132, 4244.236037513247, 4260.339647354649, 4261.21167583998, 3381.425157723193, 3652.7443078984484, 3703.4815125882396, 4028.8719158635336, 4230.915381692349, 3258.885938992124, 3359.0090923177722, 3712.3688972874675, 3713.350163721338, 3748.3815170496837, 4358.3244597087505, 4566.49768525462, 5206.76569554371, 5437.891242175135, 5485.177223416479, 4601.378813860153, 4631.884202894921, 4671.5094915034115, 4847.369841920563, 4960.503949605047, 5759.819237056394, 5774.884502309972, 5789.16057171712, 5816.505597024258, 5845.473907348359, 3103.7584966013774, 3574.195805943668, 4029.9447281886155, 4035.737677051012, 4048.6963477739287, 4791.31686255698, 6176.783812566584, 6191.721372538246, 6195.44241018306, 6324.715387807513, 3403.217260030207, 3562.091666625046, 4049.7445791804635, 4060.7360521566, 4084.6105028558627, 3760.6530188132583, 3863.903402414906, 4144.378343248537, 4149.419081328617, 4155.729877558009, 4281.379200016043, 4712.887878153114, 4874.390701162355, 4875.829345972874, 4885.658003939761, 5328.8401347959625, 5383.892322153535, 5831.212786273799, 5956.225690660273, 6071.085878778123, 1369.6849724563406, 1412.9929350353389, 1414.4412956881974, 1416.6033510617044, 1424.7720364741592, 741.8108382362464, 840.2899549880341, 857.0743596915316, 873.275181599271, 918.5636822509255, 5426.647267927572, 5495.890082198413, 5506.081776658378, 5506.339239291311, 5556.749946252428, 4708.293755936637, 4926.975365123151, 5989.940100599026, 6057.757689692363, 6109.7861574844665, 4824.8793780155775, 5118.131881863093, 5399.487048730443, 5481.588880833953, 5520.806771763049, 2831.6743574488787, 2959.3045634275927, 2979.851007449619, 3086.8424340872175, 3212.726918211931, 5437.32033495813, 6039.516838652898, 6170.784022559279, 6270.247570291503, 6335.619862808154, 6261.405166509266, 6319.052142178618, 6333.113364129025, 6338.397852204033, 6366.790309841115, 5099.56653684441, 6324.841878953063, 6331.905021424683, 6345.460635845912, 6389.840253993687, 5150.707934968903, 5821.118546319599, 6055.909936211348, 6154.169187159855, 6182.0, 6008.326294798772, 6021.277446706424, 6024.759009639741, 6052.394760523913, 6091.416231779681, 5334.493223143795, 5942.494887934401, 6238.095476155841, 6289.528285378524, 6341.034279373409, 3818.8734323375224, 4034.6772258218684, 4050.939235911405, 4078.9388159177042, 4080.551139374607, 4948.264060634198, 5563.527100196528, 5987.832372687459, 6102.511799056154, 6171.506279497539, 4505.549445055468, 5151.6393852431465, 5568.8305455854725, 5830.0, 5965.045592705146, 4869.95130048695, 5427.972860135674, 5474.576610081328, 5864.266966629171, 5939.4951429129005, 4874.098291816025, 4930.704157750546, 5217.973910130425, 5575.275214222125, 5734.942650573607, 5120.974395128001, 5597.580181486486, 5967.552433567586, 6015.879682406415, 6078.6048906820915, 5891.646501209942, 5905.202797622438, 5910.46805787464, 5915.556333274935, 5937.910931335947], "value": 4249.700746956011, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [726.150404027288, 751.6504825256256, 759.2407592407592, 790.8141586727122, 866.0559989611324, 13021.414036368362, 15320.157391343471, 15786.605334866634, 15884.76172857408, 15966.441174558864, 13619.319034048283, 14170.433182672707, 14689.192094434802, 14770.556883293519, 14802.629934251649, 728.137157468399, 759.6771372166835, 904.2223687628634, 922.3681777982071, 923.0400383601046, 898.178166977215, 902.2150728865896, 923.9076092390775, 934.7943452440486, 935.6210734652477, 935.6678379175397, 974.9902500975006, 987.7678745494838, 989.7476143583376, 991.167419367731, 926.7636752628105, 978.2516374973151, 981.8527220916884, 983.626222035629, 985.522021819417, 727.8398752274544, 729.7664747280872, 731.846312274423, 733.9302766237253, 736.8526294741073, 15456.381744730197, 15484.30320635574, 15517.767233491506, 15546.300416481285, 15618.0, 15115.697686046327, 15138.032055832782, 15145.242737863173, 15206.847931520764, 15228.086314821147, 10179.440130792804, 12047.518099276018, 12119.272843629411, 12207.0, 12324.630261092181, 3885.825137868803, 3931.744436611611, 3956.7032472564674, 3964.345882929313, 4084.7957602119777, 106053.46973265085, 115141.42429287884, 121797.0, 121831.0, 125046.0, 11630.6510804676, 11662.050686440816, 11815.88184118165, 11898.583549575724, 11947.402629868471, 23916.760832391803, 24715.0, 24813.751862481506, 24867.751322486907, 24989.875050624993, 8411.948506436695, 8436.578171091422, 8446.408751387344, 8478.576071196416, 8649.264812490883, 4379.343098535245, 4398.406215160912, 4467.92677481772, 4550.840720574764, 4572.474165471013, 3630.7458477906293, 3680.6687398134295, 3767.3972164454103, 3782.583915769263, 3785.242951409729, 538.6694863686688, 569.5671289819767, 579.7622974580402, 603.9214902062791, 615.7383112177307, 495.9504049595084, 557.8912112138175, 584.5498965796313, 590.1796502861026, 592.2508027345411, 8932.19610235082, 9923.950380248052, 9958.103770660531, 9974.950125249326, 10125.898741012643, 658.9571677840925, 660.7555204574243, 681.8056853796644, 689.486332682145, 692.8545005548891, 4624.352590637313, 4798.304245884327, 4822.373091498082, 4840.636952228597, 4893.168161412568, 122109.0, 133844.33077834744, 134152.0, 150136.9972600542, 150708.49291506945, 113554.43222783833, 114765.4261728686, 119182.0, 119292.0, 121474.0, 104665.0, 106087.16520591287, 106444.46777766217, 109807.0, 111376.0, 9889.345117962406, 9981.351212171186, 10117.89882101199, 10201.74495637615, 10222.080012798586, 42793.0, 61162.38837611567, 62080.689596551725, 62460.687696561225, 63090.68454657697, 71585.64207179139, 82337.58831205805, 84249.0, 90153.0, 91831.08168918492, 11047.392393418439, 13392.196468211938, 13453.529126480526, 13494.32528373597, 13684.794728079285, 12635.810462843248, 13192.406341714453, 13303.201807891557, 13623.86376136226, 15634.765478518058, 12120.878791212328, 12175.634730958085, 13362.265075420944, 14133.717325653635, 14450.0, 11580.942095289469, 13965.650858728206, 14152.716945660823, 14219.573412797632, 14609.415623374945, 13744.86255137436, 14021.3690383935, 14027.158370497802, 14163.575092747235, 14225.502107426191, 11195.0, 11312.321260724382, 11371.43142842871, 11441.48513316886, 11513.88486115128, 10823.404712740874, 11281.605143819927, 11479.942600286946, 11540.192186546861, 11812.881871181522], "value": 7953.2993899388875, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1619.9, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 120.0, 155.0, 156.0, 119.0, 116.0, 114.0, 117.0, 116.0, 118.0], "value": 123.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 109.0, 135.0, 157.0, 110.0, 130.0, 127.0, 116.0, 198.0, 97.0], "value": 132.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [199.0, 196.0, 206.0, 233.0, 196.0, 202.0, 229.0, 275.0, 200.0, 197.0], "value": 213.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 83.0, 76.0, 136.0, 59.0, 79.0, 52.0, 82.0, 162.0, 80.0], "value": 87.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 74.0, 130.0, 71.0, 72.0, 71.0, 115.0, 71.0, 74.0, 115.0], "value": 86.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 88.0, 114.0, 131.0, 89.0, 86.0, 90.0, 88.0, 89.0, 87.0], "value": 95.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 95.0, 132.0, 149.0, 98.0, 98.0, 98.0, 97.0, 153.0], "value": 111.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 97.0, 91.0, 93.0, 93.0, 89.0, 91.0, 94.0, 91.0, 92.0], "value": 92.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 60.0, 55.0, 58.0, 55.0, 61.0, 77.0, 84.0, 86.0, 59.0], "value": 65.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 70.0, 70.0, 69.0, 77.0, 78.0, 72.0, 71.0, 68.0, 70.0], "value": 71.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 88.0, 87.0, 89.0, 87.0, 105.0, 100.0, 107.0, 108.0, 75.0], "value": 93.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 166.0, 158.0, 162.0, 156.0, 154.0, 168.0, 149.0, 195.0, 165.0], "value": 164.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [220.0, 184.0, 188.0, 185.0, 194.0, 260.0, 258.0, 186.0, 188.0, 188.0], "value": 205.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 89.0, 91.0, 90.0, 92.0, 71.0, 69.0, 69.0, 70.0, 72.0], "value": 78.3, "unit": "score"}]}]} 14:09:40 INFO - Return code: 0 14:09:40 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:09:40 ERROR - # TBPL SUCCESS # 14:09:40 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:09:40 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:09:40 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:09:40 INFO - 2016-07-08 14:09:40.737 screenresolution[1817:10623] starting screenresolution argv=screenresolution get 14:09:40 INFO - 2016-07-08 14:09:40.740 screenresolution[1817:10623] Display 0: 1600x1200x32@60 14:09:40 INFO - 2016-07-08 14:09:40.746 screenresolution[1818:10626] starting screenresolution argv=screenresolution list 14:09:40 INFO - Available Modes on Display 0 14:09:40 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:09:40 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:09:40 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:09:40 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:09:40 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:09:40 INFO - Intel Iris: 14:09:40 INFO - Chipset Model: Intel Iris 14:09:40 INFO - Type: GPU 14:09:40 INFO - Bus: Built-In 14:09:40 INFO - VRAM (Dynamic, Max): 1536 MB 14:09:40 INFO - Vendor: Intel (0x8086) 14:09:40 INFO - Device ID: 0x0a2e 14:09:40 INFO - Revision ID: 0x0009 14:09:40 INFO - Displays: 14:09:40 INFO - Display: 14:09:40 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:09:40 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:09:40 INFO - Display Serial Number: 1600x1200 60 14:09:40 INFO - Main Display: Yes 14:09:40 INFO - Mirror: Off 14:09:40 INFO - Online: Yes 14:09:40 INFO - Rotation: Supported 14:09:40 INFO - Return code: 0 14:09:40 INFO - Running post-action listener: _resource_record_post_action 14:09:40 INFO - ##### 14:09:40 INFO - ##### Finished run-tests step (success) 14:09:40 INFO - ##### 14:09:40 INFO - Running post-run listener: _resource_record_post_run 14:09:41 INFO - Total resource usage - Wall time: 1208s; CPU: 54.0%; Read bytes: 31571456; Write bytes: 708543488; Read time: 187; Write time: 2047 14:09:41 INFO - TinderboxPrint: CPU usage
54.4% 14:09:41 INFO - TinderboxPrint: I/O read bytes / time
31,571,456 / 187 14:09:41 INFO - TinderboxPrint: I/O write bytes / time
708,543,488 / 2,047 14:09:41 INFO - TinderboxPrint: CPU idle
2,203.0 (45.6%) 14:09:41 INFO - TinderboxPrint: CPU system
980.8 (20.3%) 14:09:41 INFO - TinderboxPrint: CPU user
1,649.8 (34.1%) 14:09:41 INFO - TinderboxPrint: Swap in / out
434,659,328 / 0 14:09:41 INFO - install - Wall time: 35s; CPU: 55.0%; Read bytes: 390361600; Write bytes: 384538112; Read time: 29029; Write time: 798 14:09:41 INFO - run-tests - Wall time: 1175s; CPU: 54.0%; Read bytes: 30641664; Write bytes: 298876416; Read time: 177; Write time: 1189 14:09:41 INFO - Running post-run listener: _upload_blobber_files 14:09:41 INFO - Blob upload gear active. 14:09:41 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:09:41 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 14:09:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 14:09:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 14:09:41 INFO - (blobuploader) - INFO - Open directory for files ... 14:09:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 14:09:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:09:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:09:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 14:09:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:09:42 INFO - (blobuploader) - INFO - Done attempting. 14:09:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 14:09:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:09:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:09:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 14:09:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:09:43 INFO - (blobuploader) - INFO - Done attempting. 14:09:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:09:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:09:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:09:46 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:09:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:09:46 INFO - (blobuploader) - INFO - Done attempting. 14:09:46 INFO - (blobuploader) - INFO - Iteration through files over. 14:09:46 INFO - Return code: 0 14:09:46 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:09:46 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:09:46 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fd416184966648084d979816c4db5db01a7560aaa862159cf60fc57ae793591c99471a6b4937060672836dd8fa561ebaddb6a2015f6c3a50994daa84fe44013a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c0bd1ed1877bc443636723c4dce9b05796b87ac4a3262086cfdaaee66d71d6b694c64b89c9cf75b6a318aa8cf49d821b8edcf0fb6be6f79f0863546f7890018a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e9a9d3a6621d6cbc95ff06d432304e3aa397a05ce9de1c7756ddada4cedcbe7f32783f2bfebabb2c14d298b6b9ac98f6f2bbfd1ecc5cadeb8d15355b33938c71"} 14:09:46 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:09:46 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:09:46 INFO - Contents: 14:09:46 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fd416184966648084d979816c4db5db01a7560aaa862159cf60fc57ae793591c99471a6b4937060672836dd8fa561ebaddb6a2015f6c3a50994daa84fe44013a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c0bd1ed1877bc443636723c4dce9b05796b87ac4a3262086cfdaaee66d71d6b694c64b89c9cf75b6a318aa8cf49d821b8edcf0fb6be6f79f0863546f7890018a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e9a9d3a6621d6cbc95ff06d432304e3aa397a05ce9de1c7756ddada4cedcbe7f32783f2bfebabb2c14d298b6b9ac98f6f2bbfd1ecc5cadeb8d15355b33938c71"} 14:09:46 INFO - Running post-run listener: copy_logs_to_upload_dir 14:09:46 INFO - Copying logs to upload dir... 14:09:46 INFO - mkdir: /builds/slave/test/build/upload/logs 14:09:46 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1287.095270 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 27 secs) (at 2016-07-08 14:09:46.143311) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-08 14:09:46.147064) ========= 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.nhXhCgx2Mr/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.CGcZYFE7uZ/Listeners TMPDIR=/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fd416184966648084d979816c4db5db01a7560aaa862159cf60fc57ae793591c99471a6b4937060672836dd8fa561ebaddb6a2015f6c3a50994daa84fe44013a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c0bd1ed1877bc443636723c4dce9b05796b87ac4a3262086cfdaaee66d71d6b694c64b89c9cf75b6a318aa8cf49d821b8edcf0fb6be6f79f0863546f7890018a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e9a9d3a6621d6cbc95ff06d432304e3aa397a05ce9de1c7756ddada4cedcbe7f32783f2bfebabb2c14d298b6b9ac98f6f2bbfd1ecc5cadeb8d15355b33938c71"} build_url:https://queue.taskcluster.net/v1/task/dePeT9xHSWCSRTVsfFMfKg/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011142 build_url: 'https://queue.taskcluster.net/v1/task/dePeT9xHSWCSRTVsfFMfKg/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fd416184966648084d979816c4db5db01a7560aaa862159cf60fc57ae793591c99471a6b4937060672836dd8fa561ebaddb6a2015f6c3a50994daa84fe44013a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c0bd1ed1877bc443636723c4dce9b05796b87ac4a3262086cfdaaee66d71d6b694c64b89c9cf75b6a318aa8cf49d821b8edcf0fb6be6f79f0863546f7890018a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e9a9d3a6621d6cbc95ff06d432304e3aa397a05ce9de1c7756ddada4cedcbe7f32783f2bfebabb2c14d298b6b9ac98f6f2bbfd1ecc5cadeb8d15355b33938c71"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-08 14:09:46.179051) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 14:09:46.179354) ========= 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.nhXhCgx2Mr/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.CGcZYFE7uZ/Listeners TMPDIR=/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/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.005180 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 14:09:46.227818) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-08 14:09:46.228189) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-08 14:09:46.228574) ========= ========= Total master_lag: 0.21 =========