builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0031 starttime: 1460721196.35 results: success (0) buildid: 20160415024048 builduid: 6740234a681f4710863c09b46d3b097c revision: 755a175b3cc735b575a9e3dd4fcfcd4c7a63695c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-15 04:53:16.354764) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-15 04:53:16.355193) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-15 04:53:16.355466) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-15 04:53:16.550849) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 04:53:16.551348) ========= 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.49TWEdDh20/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.yXApWZeoCA/Listeners TMPDIR=/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-04-15 04:53:16-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 60.9M=0s 2016-04-15 04:53:16 (60.9 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.088364 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 04:53:16.663107) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 04:53:16.663414) ========= 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.49TWEdDh20/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.yXApWZeoCA/Listeners TMPDIR=/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/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.025300 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 04:53:16.752676) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-15 04:53:16.753058) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 755a175b3cc735b575a9e3dd4fcfcd4c7a63695c --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 755a175b3cc735b575a9e3dd4fcfcd4c7a63695c --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.49TWEdDh20/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.yXApWZeoCA/Listeners TMPDIR=/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-04-15 04:53:16,833 truncating revision to first 12 chars 2016-04-15 04:53:16,834 Setting DEBUG logging. 2016-04-15 04:53:16,834 attempt 1/10 2016-04-15 04:53:16,834 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/755a175b3cc7?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-15 04:53:17,418 unpacking tar archive at: mozilla-central-755a175b3cc7/testing/mozharness/ program finished with exit code 0 elapsedTime=0.837614 ========= master_lag: 0.29 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-15 04:53:17.880893) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-15 04:53:17.881216) ========= script_repo_revision: 755a175b3cc735b575a9e3dd4fcfcd4c7a63695c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-15 04:53:17.881622) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-15 04:53:17.881902) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-15 04:53:17.906144) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2016-04-15 04:53:17.906408) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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.49TWEdDh20/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.yXApWZeoCA/Listeners TMPDIR=/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 04:53:18 INFO - MultiFileLogger online at 20160415 04:53:18 in /builds/slave/test 04:53:18 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 04:53:18 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:53:18 INFO - {'append_to_log': False, 04:53:18 INFO - 'base_work_dir': '/builds/slave/test', 04:53:18 INFO - 'blob_upload_branch': 'Firefox', 04:53:18 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:53:18 INFO - 'branch': 'Firefox', 04:53:18 INFO - 'buildbot_json_path': 'buildprops.json', 04:53:18 INFO - 'config_files': ('talos/mac_config.py',), 04:53:18 INFO - 'default_actions': ('clobber', 04:53:18 INFO - 'read-buildbot-config', 04:53:18 INFO - 'download-and-extract', 04:53:18 INFO - 'populate-webroot', 04:53:18 INFO - 'create-virtualenv', 04:53:18 INFO - 'install', 04:53:18 INFO - 'run-tests'), 04:53:18 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:53:18 INFO - 'download_minidump_stackwalk': True, 04:53:18 INFO - 'download_symbols': 'ondemand', 04:53:18 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:53:18 INFO - 'tooltool.py': '/tools/tooltool.py', 04:53:18 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:53:18 INFO - '/tools/misc-python/virtualenv.py')}, 04:53:18 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:53:18 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:53:18 INFO - 'installer_path': 'installer.exe', 04:53:18 INFO - 'log_level': 'info', 04:53:18 INFO - 'log_name': 'talos', 04:53:18 INFO - 'log_to_console': True, 04:53:18 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 04:53:18 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 04:53:18 INFO - 'opt_config_files': (), 04:53:18 INFO - 'pip_index': False, 04:53:18 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:53:18 INFO - 'cmd': ('bash', 04:53:18 INFO - '-c', 04:53:18 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:53:18 INFO - 'enabled': True, 04:53:18 INFO - 'halt_on_failure': False, 04:53:18 INFO - 'name': 'check_screen_resolution'},), 04:53:18 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:53:18 INFO - 'cmd': ('bash', 04:53:18 INFO - '-c', 04:53:18 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:53:18 INFO - 'enabled': True, 04:53:18 INFO - 'halt_on_failure': False, 04:53:18 INFO - 'name': 'check_screen_resolution'},), 04:53:18 INFO - 'run_cmd_checks_enabled': True, 04:53:18 INFO - 'sps_profile': False, 04:53:18 INFO - 'sps_profile_interval': 0, 04:53:18 INFO - 'suite': 'dromaeojs', 04:53:18 INFO - 'system_bits': '32', 04:53:18 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:53:18 INFO - 'title': 't-yosemite-r7-0031', 04:53:18 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:53:18 INFO - 'use_talos_json': True, 04:53:18 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:53:18 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:53:18 INFO - 'work_dir': 'build'} 04:53:18 INFO - ##### 04:53:18 INFO - ##### Running clobber step. 04:53:18 INFO - ##### 04:53:18 INFO - Running pre-action listener: _resource_record_pre_action 04:53:18 INFO - Running main action method: clobber 04:53:18 INFO - rmtree: /builds/slave/test/build 04:53:18 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:53:19 INFO - Running post-action listener: _resource_record_post_action 04:53:19 INFO - ##### 04:53:19 INFO - ##### Running read-buildbot-config step. 04:53:19 INFO - ##### 04:53:19 INFO - Running pre-action listener: _resource_record_pre_action 04:53:19 INFO - Running main action method: read_buildbot_config 04:53:19 INFO - Using buildbot properties: 04:53:19 INFO - { 04:53:19 INFO - "project": "", 04:53:19 INFO - "product": "firefox", 04:53:19 INFO - "script_repo_revision": "production", 04:53:19 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 04:53:19 INFO - "repository": "", 04:53:19 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 04:53:19 INFO - "buildid": "20160415024048", 04:53:19 INFO - "pgo_build": "False", 04:53:19 INFO - "basedir": "/builds/slave/test", 04:53:19 INFO - "buildnumber": 219, 04:53:19 INFO - "slavename": "t-yosemite-r7-0031", 04:53:19 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 04:53:19 INFO - "platform": "yosemite_r7", 04:53:19 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 04:53:19 INFO - "branch": "mozilla-central", 04:53:19 INFO - "repo_path": "mozilla-central", 04:53:19 INFO - "revision": "755a175b3cc735b575a9e3dd4fcfcd4c7a63695c", 04:53:19 INFO - "stage_platform": "macosx64", 04:53:19 INFO - "builduid": "6740234a681f4710863c09b46d3b097c", 04:53:19 INFO - "slavebuilddir": "test" 04:53:19 INFO - } 04:53:19 INFO - Found installer url https://queue.taskcluster.net/v1/task/W3vucRKoRTycp-0zgffbdw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg. 04:53:19 INFO - Running post-action listener: _resource_record_post_action 04:53:19 INFO - ##### 04:53:19 INFO - ##### Running download-and-extract step. 04:53:19 INFO - ##### 04:53:19 INFO - Running pre-action listener: _resource_record_pre_action 04:53:19 INFO - Running main action method: download_and_extract 04:53:19 INFO - mkdir: /builds/slave/test/build/tests 04:53:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:53:19 INFO - https://queue.taskcluster.net/v1/task/W3vucRKoRTycp-0zgffbdw/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 04:53:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W3vucRKoRTycp-0zgffbdw/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 04:53:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W3vucRKoRTycp-0zgffbdw/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 04:53:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W3vucRKoRTycp-0zgffbdw/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 04:53:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W3vucRKoRTycp-0zgffbdw/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json'}, attempt #1 04:53:26 INFO - Downloaded 1199 bytes. 04:53:26 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 04:53:26 INFO - Using the following test package requirements: 04:53:26 INFO - {u'common': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 04:53:26 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 04:53:26 INFO - u'firefox-48.0a1.en-US.mac.cppunittest.tests.zip'], 04:53:26 INFO - u'gtest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 04:53:26 INFO - u'firefox-48.0a1.en-US.mac.gtest.tests.zip'], 04:53:26 INFO - u'jittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 04:53:26 INFO - u'jsshell-mac.zip'], 04:53:26 INFO - u'mochitest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 04:53:26 INFO - u'firefox-48.0a1.en-US.mac.mochitest.tests.zip'], 04:53:26 INFO - u'mozbase': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 04:53:26 INFO - u'reftest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 04:53:26 INFO - u'firefox-48.0a1.en-US.mac.reftest.tests.zip'], 04:53:26 INFO - u'talos': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 04:53:26 INFO - u'firefox-48.0a1.en-US.mac.talos.tests.zip'], 04:53:26 INFO - u'web-platform': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 04:53:26 INFO - u'firefox-48.0a1.en-US.mac.web-platform.tests.zip'], 04:53:26 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 04:53:26 INFO - u'firefox-48.0a1.en-US.mac.xpcshell.tests.zip']} 04:53:26 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip'] for test suite category: common 04:53:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:53:26 INFO - https://queue.taskcluster.net/v1/task/W3vucRKoRTycp-0zgffbdw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 04:53:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W3vucRKoRTycp-0zgffbdw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 04:53:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W3vucRKoRTycp-0zgffbdw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 04:53:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W3vucRKoRTycp-0zgffbdw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip 04:53:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W3vucRKoRTycp-0zgffbdw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:53:27 INFO - Downloaded 18028983 bytes. 04:53:27 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:53:27 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 04:53:30 INFO - Return code: 0 04:53:30 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip', u'firefox-48.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 04:53: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')]} 04:53:30 INFO - https://queue.taskcluster.net/v1/task/W3vucRKoRTycp-0zgffbdw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 04:53:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W3vucRKoRTycp-0zgffbdw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 04:53:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W3vucRKoRTycp-0zgffbdw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 04:53:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W3vucRKoRTycp-0zgffbdw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip 04:53:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W3vucRKoRTycp-0zgffbdw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:53:33 INFO - Downloaded 18028983 bytes. 04:53:33 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:53:33 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 04:53:36 INFO - Return code: 0 04:53:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:53:36 INFO - https://queue.taskcluster.net/v1/task/W3vucRKoRTycp-0zgffbdw/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 04:53:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W3vucRKoRTycp-0zgffbdw/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 04:53:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W3vucRKoRTycp-0zgffbdw/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 04:53:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W3vucRKoRTycp-0zgffbdw/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip 04:53:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W3vucRKoRTycp-0zgffbdw/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip'}, attempt #1 04:53:37 INFO - Downloaded 10841076 bytes. 04:53:37 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:53:37 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 04:53:38 INFO - Return code: 0 04:53:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:53:38 INFO - https://queue.taskcluster.net/v1/task/W3vucRKoRTycp-0zgffbdw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 04:53:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W3vucRKoRTycp-0zgffbdw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 04:53:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W3vucRKoRTycp-0zgffbdw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 04:53:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W3vucRKoRTycp-0zgffbdw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg 04:53:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W3vucRKoRTycp-0zgffbdw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg'}, attempt #1 04:53:41 INFO - Downloaded 109856115 bytes. 04:53:41 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/W3vucRKoRTycp-0zgffbdw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 04:53:41 INFO - mkdir: /builds/slave/test/properties 04:53:41 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:53:41 INFO - Writing to file /builds/slave/test/properties/build_url 04:53:41 INFO - Contents: 04:53:41 INFO - build_url:https://queue.taskcluster.net/v1/task/W3vucRKoRTycp-0zgffbdw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 04:53:42 INFO - Running post-action listener: _resource_record_post_action 04:53:42 INFO - Running post-action listener: set_extra_try_arguments 04:53:42 INFO - ##### 04:53:42 INFO - ##### Running populate-webroot step. 04:53:42 INFO - ##### 04:53:42 INFO - Running pre-action listener: _resource_record_pre_action 04:53:42 INFO - Running main action method: populate_webroot 04:53:42 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:53:42 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:53:42 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:53:42 INFO - '--tppagecycles', 04:53:42 INFO - '7'], 04:53:42 INFO - 'tests': ['tsvgm']}}, 04:53:42 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:53:42 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:53:42 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:53:42 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:53:42 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:53:42 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:53:42 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:53:42 INFO - 'talos_options': ['--disable-e10s'], 04:53:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:53:42 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:53:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:53:42 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:53:42 INFO - 'talos_options': ['--disable-e10s'], 04:53:42 INFO - 'tests': ['damp', 'tps']}, 04:53:42 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:53:42 INFO - 'tests': ['damp', 'tps']}, 04:53:42 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:53:42 INFO - 'tests': ['dromaeo_dom']}, 04:53:42 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:53:42 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:53:42 INFO - 'tests': ['a11yr', 04:53:42 INFO - 'ts_paint', 04:53:42 INFO - 'tpaint', 04:53:42 INFO - 'sessionrestore', 04:53:42 INFO - 'sessionrestore_no_auto_restore', 04:53:42 INFO - 'tabpaint']}, 04:53:42 INFO - 'other-e10s': {'tests': ['a11yr', 04:53:42 INFO - 'ts_paint', 04:53:42 INFO - 'tpaint', 04:53:42 INFO - 'sessionrestore', 04:53:42 INFO - 'sessionrestore_no_auto_restore', 04:53:42 INFO - 'tabpaint']}, 04:53:42 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:53:42 INFO - 'ts_paint', 04:53:42 INFO - 'tpaint', 04:53:42 INFO - 'sessionrestore', 04:53:42 INFO - 'sessionrestore_no_auto_restore', 04:53:42 INFO - 'tabpaint']}, 04:53:42 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:53:42 INFO - 'ts_paint', 04:53:42 INFO - 'tpaint', 04:53:42 INFO - 'sessionrestore', 04:53:42 INFO - 'sessionrestore_no_auto_restore', 04:53:42 INFO - 'tabpaint']}, 04:53:42 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:53:42 INFO - 'tests': ['a11yr', 04:53:42 INFO - 'ts_paint', 04:53:42 INFO - 'tpaint', 04:53:42 INFO - 'sessionrestore', 04:53:42 INFO - 'sessionrestore_no_auto_restore', 04:53:42 INFO - 'tabpaint']}, 04:53:42 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:53:42 INFO - 'tests': ['a11yr', 04:53:42 INFO - 'ts_paint', 04:53:42 INFO - 'tpaint', 04:53:42 INFO - 'sessionrestore', 04:53:42 INFO - 'sessionrestore_no_auto_restore', 04:53:42 INFO - 'tabpaint']}, 04:53:42 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:53:42 INFO - 'tests': ['tsvgx', 04:53:42 INFO - 'tsvgr_opacity', 04:53:42 INFO - 'tart', 04:53:42 INFO - 'tscrollx', 04:53:42 INFO - 'cart']}, 04:53:42 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:53:42 INFO - 'tsvgr_opacity', 04:53:42 INFO - 'tart', 04:53:42 INFO - 'tscrollx', 04:53:42 INFO - 'cart']}, 04:53:42 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:53:42 INFO - 'talos_options': ['--disable-e10s'], 04:53:42 INFO - 'tests': ['tp5o']}, 04:53:42 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:53:42 INFO - 'tests': ['tp5o']}, 04:53:42 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:53:42 INFO - 'talos_options': ['--disable-e10s', 04:53:42 INFO - '--xperf_path', 04:53:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:53:43 INFO - 'tests': ['tp5n']}, 04:53:43 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:53:43 INFO - 'talos_options': ['--xperf_path', 04:53:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:53:43 INFO - 'tests': ['tp5n']}}, 04:53:43 INFO - 'talos.zip': {'path': '', 04:53:43 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:53:43 INFO - Running post-action listener: _resource_record_post_action 04:53:43 INFO - ##### 04:53:43 INFO - ##### Running create-virtualenv step. 04:53:43 INFO - ##### 04:53:43 INFO - Running pre-action listener: _resource_record_pre_action 04:53:43 INFO - Running main action method: create_virtualenv 04:53:43 INFO - Creating virtualenv /builds/slave/test/build/venv 04:53:43 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 04:53:43 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:53:43 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:53:43 INFO - Using real prefix '/tools/python27' 04:53:43 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:53:43 INFO - Installing distribute.............................................................................................................................................................................................done. 04:53:46 INFO - Installing pip.................done. 04:53:46 INFO - Return code: 0 04:53:46 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:53:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:53:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:53:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:53:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:53:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10fe01a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fe11420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb49a69a790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fca0e00>, '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 0x10fac9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fc9bb20>, '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.49TWEdDh20/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.yXApWZeoCA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:53:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 04:53:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:53:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.49TWEdDh20/Render', 04:53:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:53:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:53:46 INFO - 'HOME': '/Users/cltbld', 04:53:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:53:46 INFO - 'LOGNAME': 'cltbld', 04:53:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:53:46 INFO - 'MOZ_NO_REMOTE': '1', 04:53:46 INFO - 'NO_EM_RESTART': '1', 04:53:46 INFO - 'PAGER': '/bin/cat', 04:53:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:53:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:53:46 INFO - 'PWD': '/builds/slave/test', 04:53:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:53:46 INFO - 'SHELL': '/bin/bash', 04:53:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yXApWZeoCA/Listeners', 04:53:46 INFO - 'TMPDIR': '/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/', 04:53:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:53:46 INFO - 'USER': 'cltbld', 04:53:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:53:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:53:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:53:46 INFO - 'XPC_FLAGS': '0x0', 04:53:46 INFO - 'XPC_SERVICE_NAME': '0', 04:53:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:53:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:53:46 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 04:53:46 INFO - Cleaning up... 04:53:46 INFO - Return code: 0 04:53:46 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 04:53:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:53:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:53:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:53:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:53:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10fe01a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fe11420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb49a69a790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fca0e00>, '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 0x10fac9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fc9bb20>, '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.49TWEdDh20/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.yXApWZeoCA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:53:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 04:53:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 04:53:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.49TWEdDh20/Render', 04:53:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:53:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:53:47 INFO - 'HOME': '/Users/cltbld', 04:53:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:53:47 INFO - 'LOGNAME': 'cltbld', 04:53:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:53:47 INFO - 'MOZ_NO_REMOTE': '1', 04:53:47 INFO - 'NO_EM_RESTART': '1', 04:53:47 INFO - 'PAGER': '/bin/cat', 04:53:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:53:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:53:47 INFO - 'PWD': '/builds/slave/test', 04:53:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:53:47 INFO - 'SHELL': '/bin/bash', 04:53:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yXApWZeoCA/Listeners', 04:53:47 INFO - 'TMPDIR': '/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/', 04:53:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:53:47 INFO - 'USER': 'cltbld', 04:53:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:53:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:53:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:53:47 INFO - 'XPC_FLAGS': '0x0', 04:53:47 INFO - 'XPC_SERVICE_NAME': '0', 04:53:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:53:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:53:47 INFO - Downloading/unpacking psutil>=0.7.1 04:53:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:53:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:53:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:53:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:53:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:53:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:53:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:53:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:53:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:53:50 INFO - Installing collected packages: psutil 04:53:50 INFO - Running setup.py install for psutil 04:53:50 INFO - building 'psutil._psutil_osx' extension 04:53:50 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 04:53:50 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 04:53:51 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 04:53:51 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 04:53:51 INFO - building 'psutil._psutil_posix' extension 04:53:51 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 04:53:51 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 04:53:51 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 04:53:51 INFO - ^ 04:53:51 INFO - 1 warning generated. 04:53:51 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 04:53:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:53:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:53:51 INFO - Successfully installed psutil 04:53:51 INFO - Cleaning up... 04:53:51 INFO - Return code: 0 04:53:51 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 04:53:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:53:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:53:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:53:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:53:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10fe01a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fe11420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb49a69a790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fca0e00>, '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 0x10fac9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fc9bb20>, '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.49TWEdDh20/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.yXApWZeoCA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:53:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 04:53:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 04:53:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.49TWEdDh20/Render', 04:53:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:53:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:53:51 INFO - 'HOME': '/Users/cltbld', 04:53:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:53:51 INFO - 'LOGNAME': 'cltbld', 04:53:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:53:51 INFO - 'MOZ_NO_REMOTE': '1', 04:53:51 INFO - 'NO_EM_RESTART': '1', 04:53:51 INFO - 'PAGER': '/bin/cat', 04:53:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:53:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:53:51 INFO - 'PWD': '/builds/slave/test', 04:53:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:53:51 INFO - 'SHELL': '/bin/bash', 04:53:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yXApWZeoCA/Listeners', 04:53:51 INFO - 'TMPDIR': '/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/', 04:53:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:53:51 INFO - 'USER': 'cltbld', 04:53:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:53:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:53:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:53:51 INFO - 'XPC_FLAGS': '0x0', 04:53:51 INFO - 'XPC_SERVICE_NAME': '0', 04:53:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:53:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:53:51 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:53:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:53:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:53:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:53:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:53:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:53:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:53:54 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:53:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:53:54 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 04:53:54 INFO - Installing collected packages: mozsystemmonitor 04:53:54 INFO - Running setup.py install for mozsystemmonitor 04:53:54 INFO - Successfully installed mozsystemmonitor 04:53:54 INFO - Cleaning up... 04:53:54 INFO - Return code: 0 04:53:54 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:53:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:53:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:53:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:53:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:53:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53:54 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 0x10fe01a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fe11420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb49a69a790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fca0e00>, '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 0x10fac9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fc9bb20>, '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.49TWEdDh20/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.yXApWZeoCA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:53:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:53:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:53:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.49TWEdDh20/Render', 04:53:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:53:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:53:54 INFO - 'HOME': '/Users/cltbld', 04:53:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:53:54 INFO - 'LOGNAME': 'cltbld', 04:53:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:53:54 INFO - 'MOZ_NO_REMOTE': '1', 04:53:54 INFO - 'NO_EM_RESTART': '1', 04:53:54 INFO - 'PAGER': '/bin/cat', 04:53:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:53:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:53:54 INFO - 'PWD': '/builds/slave/test', 04:53:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:53:54 INFO - 'SHELL': '/bin/bash', 04:53:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yXApWZeoCA/Listeners', 04:53:54 INFO - 'TMPDIR': '/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/', 04:53:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:53:54 INFO - 'USER': 'cltbld', 04:53:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:53:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:53:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:53:54 INFO - 'XPC_FLAGS': '0x0', 04:53:54 INFO - 'XPC_SERVICE_NAME': '0', 04:53:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:53:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:53:54 INFO - Downloading/unpacking blobuploader==1.2.4 04:53:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:53:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:53:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:53:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:53:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:53:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:53:57 INFO - Downloading blobuploader-1.2.4.tar.gz 04:53:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:53:57 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:53:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:53:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:53:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:53:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:53:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:53:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:53:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:53:57 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:53:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:53:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:53:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:53:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:53:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:53:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:53:58 INFO - Downloading docopt-0.6.1.tar.gz 04:53:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:53:58 INFO - Installing collected packages: blobuploader, requests, docopt 04:53:58 INFO - Running setup.py install for blobuploader 04:53:58 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:53:58 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:53:58 INFO - Running setup.py install for requests 04:53:59 INFO - Running setup.py install for docopt 04:53:59 INFO - Successfully installed blobuploader requests docopt 04:53:59 INFO - Cleaning up... 04:53:59 INFO - Return code: 0 04:53:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:53:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:53:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:53:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:53:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:53:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53:59 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 0x10fe01a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fe11420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb49a69a790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fca0e00>, '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 0x10fac9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fc9bb20>, '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.49TWEdDh20/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.yXApWZeoCA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:53:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:53:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:53:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.49TWEdDh20/Render', 04:53:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:53:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:53:59 INFO - 'HOME': '/Users/cltbld', 04:53:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:53:59 INFO - 'LOGNAME': 'cltbld', 04:53:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:53:59 INFO - 'MOZ_NO_REMOTE': '1', 04:53:59 INFO - 'NO_EM_RESTART': '1', 04:53:59 INFO - 'PAGER': '/bin/cat', 04:53:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:53:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:53:59 INFO - 'PWD': '/builds/slave/test', 04:53:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:53:59 INFO - 'SHELL': '/bin/bash', 04:53:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yXApWZeoCA/Listeners', 04:53:59 INFO - 'TMPDIR': '/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/', 04:53:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:53:59 INFO - 'USER': 'cltbld', 04:53:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:53:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:53:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:53:59 INFO - 'XPC_FLAGS': '0x0', 04:53:59 INFO - 'XPC_SERVICE_NAME': '0', 04:53:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:53:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:53:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:53:59 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-OOmUso-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:54:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:54:00 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-_780hG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:54:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:54:00 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-2ZTLpS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:54:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:54:00 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-SEpXe3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:54:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:54:00 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-kFAQ60-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:54:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:54:00 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-xkL98R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:54:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:54:00 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-m4IcSy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:54:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:54:00 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-7uPuJr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:54:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:54:00 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-e76Cv0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:54:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:54:00 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-EBz18q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:54:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:54:00 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-HBnxlI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:54:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:54:01 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-Hygi9T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:54:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:54:01 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-j3quhu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:54:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:54:01 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-NoipyV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:54:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:54:01 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-pTA5Y1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:54:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:54:01 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-2Ii9aU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:54:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:54:01 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-EY2TGR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:54:01 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:54:01 INFO - Running setup.py install for manifestparser 04:54:01 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:54:01 INFO - Running setup.py install for mozcrash 04:54:01 INFO - Running setup.py install for mozdebug 04:54:02 INFO - Running setup.py install for mozdevice 04:54:02 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:54:02 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:54:02 INFO - Running setup.py install for mozfile 04:54:02 INFO - Running setup.py install for mozhttpd 04:54:02 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:54:02 INFO - Running setup.py install for mozinfo 04:54:02 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:54:02 INFO - Running setup.py install for mozInstall 04:54:02 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:54:02 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:54:02 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:54:02 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:54:02 INFO - Running setup.py install for mozleak 04:54:02 INFO - Running setup.py install for mozlog 04:54:03 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:54:03 INFO - Running setup.py install for moznetwork 04:54:03 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:54:03 INFO - Running setup.py install for mozprocess 04:54:03 INFO - Running setup.py install for mozprofile 04:54:03 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:54:03 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:54:03 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:54:03 INFO - Running setup.py install for mozrunner 04:54:03 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:54:03 INFO - Running setup.py install for mozscreenshot 04:54:03 INFO - Running setup.py install for moztest 04:54:04 INFO - Running setup.py install for mozversion 04:54:04 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:54:04 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:54:04 INFO - Cleaning up... 04:54:04 INFO - Return code: 0 04:54:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:54:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:54:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:54:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:54:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:54:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:54:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:54:04 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 0x10fe01a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fe11420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb49a69a790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fca0e00>, '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 0x10fac9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fc9bb20>, '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.49TWEdDh20/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.yXApWZeoCA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:54:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:54:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:54:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.49TWEdDh20/Render', 04:54:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:54:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:54:04 INFO - 'HOME': '/Users/cltbld', 04:54:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:54:04 INFO - 'LOGNAME': 'cltbld', 04:54:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:54:04 INFO - 'MOZ_NO_REMOTE': '1', 04:54:04 INFO - 'NO_EM_RESTART': '1', 04:54:04 INFO - 'PAGER': '/bin/cat', 04:54:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:54:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:54:04 INFO - 'PWD': '/builds/slave/test', 04:54:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:54:04 INFO - 'SHELL': '/bin/bash', 04:54:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yXApWZeoCA/Listeners', 04:54:04 INFO - 'TMPDIR': '/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/', 04:54:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:54:04 INFO - 'USER': 'cltbld', 04:54:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:54:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:54:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:54:04 INFO - 'XPC_FLAGS': '0x0', 04:54:04 INFO - 'XPC_SERVICE_NAME': '0', 04:54:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:54:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:54:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:54:04 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-QxLorB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:54:04 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 04:54:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:54:04 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-U8LaFQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:54:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:54:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:54:04 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-LBMoWi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:54:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:54:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:54:04 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-Ecy528-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:54:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:54:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:54:04 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-FhBSvr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:54:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 04:54:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:54:05 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-zBuLaH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:54:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 04:54:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:54:05 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-Y5pb4u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:54:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 04:54:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:54:05 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-pMhs0o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:54:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 04:54:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:54:05 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-yQwrqr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:54:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 04:54:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:54:05 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-LlPjdl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:54:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:54:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:54:05 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-fy_Ftr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:54:05 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 04:54:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:54:05 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-_5cEX4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:54:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 04:54:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:54:05 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-0BIatF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:54:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 04:54:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:54:05 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-kp95IM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:54:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 04:54:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:54:06 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-qzWTrQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:54:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 04:54:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:54:06 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-d_IG32-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:54:06 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 04:54:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:54:06 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-oyHoTV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:54:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 04:54:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:54:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:54:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:54:06 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:54:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:54:06 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:54:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:54:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:54:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:54:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:54:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:54:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:54:09 INFO - Downloading blessings-1.6.tar.gz 04:54:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:54:09 INFO - Installing collected packages: blessings 04:54:09 INFO - Running setup.py install for blessings 04:54:09 INFO - Successfully installed blessings 04:54:09 INFO - Cleaning up... 04:54:09 INFO - Return code: 0 04:54:09 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:54:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:54:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:54:09 INFO - Reading from file tmpfile_stdout 04:54:09 INFO - Current package versions: 04:54:09 INFO - blessings == 1.6 04:54:09 INFO - blobuploader == 1.2.4 04:54:09 INFO - docopt == 0.6.1 04:54:09 INFO - manifestparser == 1.1 04:54:09 INFO - mozInstall == 1.12 04:54:09 INFO - mozcrash == 0.17 04:54:09 INFO - mozdebug == 0.1 04:54:09 INFO - mozdevice == 0.48 04:54:09 INFO - mozfile == 1.2 04:54:09 INFO - mozhttpd == 0.7 04:54:09 INFO - mozinfo == 0.9 04:54:09 INFO - mozleak == 0.1 04:54:09 INFO - mozlog == 3.1 04:54:09 INFO - moznetwork == 0.27 04:54:09 INFO - mozprocess == 0.22 04:54:09 INFO - mozprofile == 0.28 04:54:09 INFO - mozrunner == 6.11 04:54:09 INFO - mozscreenshot == 0.1 04:54:09 INFO - mozsystemmonitor == 0.0 04:54:09 INFO - moztest == 0.7 04:54:09 INFO - mozversion == 1.4 04:54:09 INFO - psutil == 3.1.1 04:54:09 INFO - requests == 1.2.3 04:54:09 INFO - wsgiref == 0.1.2 04:54:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:54: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')]} 04:54:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:54:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:54: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')]} 04:54:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:54:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:54:09 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 0x10fe01a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fe11420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb49a69a790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fca0e00>, '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 0x10fac9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fc9bb20>, '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.49TWEdDh20/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.yXApWZeoCA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:54:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 04:54:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:54:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.49TWEdDh20/Render', 04:54:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:54:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:54:09 INFO - 'HOME': '/Users/cltbld', 04:54:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:54:09 INFO - 'LOGNAME': 'cltbld', 04:54:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:54:09 INFO - 'MOZ_NO_REMOTE': '1', 04:54:09 INFO - 'NO_EM_RESTART': '1', 04:54:09 INFO - 'PAGER': '/bin/cat', 04:54:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:54:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:54:09 INFO - 'PWD': '/builds/slave/test', 04:54:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:54:09 INFO - 'SHELL': '/bin/bash', 04:54:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yXApWZeoCA/Listeners', 04:54:09 INFO - 'TMPDIR': '/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/', 04:54:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:54:09 INFO - 'USER': 'cltbld', 04:54:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:54:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:54:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:54:09 INFO - 'XPC_FLAGS': '0x0', 04:54:09 INFO - 'XPC_SERVICE_NAME': '0', 04:54:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:54:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:54:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:54:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 04:54:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 04:54:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:54:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 04:54:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 04:54:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 04:54:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 04:54:10 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 04:54:10 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:54:10 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:54:10 INFO - Cleaning up... 04:54:10 INFO - Return code: 0 04:54:10 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:54:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:54:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:54:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:54:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:54:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:54:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:54:10 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 0x10fe01a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fe11420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb49a69a790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fca0e00>, '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 0x10fac9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fc9bb20>, '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.49TWEdDh20/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.yXApWZeoCA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:54:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 04:54:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 04:54:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.49TWEdDh20/Render', 04:54:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:54:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:54:10 INFO - 'HOME': '/Users/cltbld', 04:54:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:54:10 INFO - 'LOGNAME': 'cltbld', 04:54:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:54:10 INFO - 'MOZ_NO_REMOTE': '1', 04:54:10 INFO - 'NO_EM_RESTART': '1', 04:54:10 INFO - 'PAGER': '/bin/cat', 04:54:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:54:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:54:10 INFO - 'PWD': '/builds/slave/test', 04:54:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:54:10 INFO - 'SHELL': '/bin/bash', 04:54:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yXApWZeoCA/Listeners', 04:54:10 INFO - 'TMPDIR': '/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/', 04:54:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:54:10 INFO - 'USER': 'cltbld', 04:54:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:54:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:54:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:54:10 INFO - 'XPC_FLAGS': '0x0', 04:54:10 INFO - 'XPC_SERVICE_NAME': '0', 04:54:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:54:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:54:10 INFO - Downloading/unpacking jsonschema 04:54:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:54:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:54:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:54:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:54:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:54:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:54:12 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:54:12 INFO - Downloading/unpacking functools32 (from jsonschema) 04:54:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:54:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:54:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:54:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:54:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:54:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:54:13 INFO - Downloading functools32-3.2.3-2.tar.gz 04:54:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:54:13 INFO - warning: no files found matching '*.txt' 04:54:13 INFO - no previously-included directories found matching 'build' 04:54:13 INFO - no previously-included directories found matching 'dist' 04:54:13 INFO - no previously-included directories found matching '.git*' 04:54:13 INFO - Installing collected packages: jsonschema, functools32 04:54:13 INFO - Running setup.py install for functools32 04:54:13 INFO - warning: no files found matching '*.txt' 04:54:13 INFO - no previously-included directories found matching 'build' 04:54:13 INFO - no previously-included directories found matching 'dist' 04:54:13 INFO - no previously-included directories found matching '.git*' 04:54:13 INFO - Successfully installed jsonschema functools32 04:54:13 INFO - Cleaning up... 04:54:13 INFO - Return code: 0 04:54:13 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:54:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:54:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:54:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:54:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:54:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:54:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:54:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10fe01a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fe11420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb49a69a790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fca0e00>, '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 0x10fac9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fc9bb20>, '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.49TWEdDh20/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.yXApWZeoCA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:54:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 04:54:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 04:54:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.49TWEdDh20/Render', 04:54:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:54:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:54:13 INFO - 'HOME': '/Users/cltbld', 04:54:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:54:13 INFO - 'LOGNAME': 'cltbld', 04:54:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:54:13 INFO - 'MOZ_NO_REMOTE': '1', 04:54:13 INFO - 'NO_EM_RESTART': '1', 04:54:13 INFO - 'PAGER': '/bin/cat', 04:54:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:54:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:54:13 INFO - 'PWD': '/builds/slave/test', 04:54:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:54:13 INFO - 'SHELL': '/bin/bash', 04:54:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yXApWZeoCA/Listeners', 04:54:13 INFO - 'TMPDIR': '/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/', 04:54:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:54:13 INFO - 'USER': 'cltbld', 04:54:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:54:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:54:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:54:13 INFO - 'XPC_FLAGS': '0x0', 04:54:13 INFO - 'XPC_SERVICE_NAME': '0', 04:54:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:54:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:54:13 INFO - Downloading/unpacking flake8 04:54:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:54:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:54:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:54:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:54:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:54:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:54:16 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:54:16 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:54: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 04:54: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 04:54: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 04:54: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 04:54: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 04:54: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 04:54:16 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:54:16 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:54: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 04:54: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 04:54: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 04:54: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 04:54: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 04:54: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 04:54:16 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:54: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 04:54: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 04:54: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 04:54: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 04:54: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 04:54: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 04:54:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:54:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:54:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:54:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:54:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:54:17 INFO - no previously-included directories found matching 'docs/_build' 04:54:17 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:54:17 INFO - Running setup.py install for pep8 04:54:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:54:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:54:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:54:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:54:17 INFO - no previously-included directories found matching 'docs/_build' 04:54:17 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:54:17 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:54:17 INFO - Cleaning up... 04:54:17 INFO - Return code: 0 04:54:17 INFO - Running post-action listener: _resource_record_post_action 04:54:17 INFO - Running post-action listener: _start_resource_monitoring 04:54:17 INFO - Starting resource monitoring. 04:54:17 INFO - ##### 04:54:17 INFO - ##### Running install step. 04:54:17 INFO - ##### 04:54:17 INFO - Running pre-action listener: _resource_record_pre_action 04:54:17 INFO - Running main action method: install 04:54:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:54:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:54:18 INFO - Reading from file tmpfile_stdout 04:54:18 INFO - Detecting whether we're running mozinstall >=1.0... 04:54:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:54:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:54:18 INFO - Reading from file tmpfile_stdout 04:54:18 INFO - Output received: 04:54:18 INFO - Usage: mozinstall [options] installer 04:54:18 INFO - Options: 04:54:18 INFO - -h, --help show this help message and exit 04:54:18 INFO - -d DEST, --destination=DEST 04:54:18 INFO - Directory to install application into. [default: 04:54:18 INFO - "/builds/slave/test"] 04:54:18 INFO - --app=APP Application being installed. [default: firefox] 04:54:18 INFO - mkdir: /builds/slave/test/build/application 04:54:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 04:54:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 04:54:51 INFO - Reading from file tmpfile_stdout 04:54:51 INFO - Output received: 04:54:51 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 04:54:51 INFO - Running post-action listener: _resource_record_post_action 04:54:51 INFO - ##### 04:54:51 INFO - ##### Running run-tests step. 04:54:51 INFO - ##### 04:54:51 INFO - Running pre-action listener: _resource_record_pre_action 04:54:51 INFO - Running main action method: run_tests 04:54:51 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:54:51 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:54:51 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:54:51 INFO - 2016-04-15 04:54:51.454 screenresolution[1645:7636] starting screenresolution argv=screenresolution get 04:54:51 INFO - 2016-04-15 04:54:51.456 screenresolution[1645:7636] Display 0: 1600x1200x32@60 04:54:51 INFO - 2016-04-15 04:54:51.461 screenresolution[1646:7638] starting screenresolution argv=screenresolution list 04:54:51 INFO - Available Modes on Display 0 04:54:51 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:54:51 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:54:51 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:54:51 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:54:51 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:54:51 INFO - Intel Iris: 04:54:51 INFO - Chipset Model: Intel Iris 04:54:51 INFO - Type: GPU 04:54:51 INFO - Bus: Built-In 04:54:51 INFO - VRAM (Dynamic, Max): 1536 MB 04:54:51 INFO - Vendor: Intel (0x8086) 04:54:51 INFO - Device ID: 0x0a2e 04:54:51 INFO - Revision ID: 0x0009 04:54:51 INFO - Displays: 04:54:51 INFO - Display: 04:54:51 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:54:51 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:54:51 INFO - Display Serial Number: 1600x1200 60 04:54:51 INFO - Main Display: Yes 04:54:51 INFO - Mirror: Off 04:54:51 INFO - Online: Yes 04:54:51 INFO - Rotation: Supported 04:54:51 INFO - Return code: 0 04:54:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:54:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:54:51 INFO - Python 2.7.3 04:54:51 INFO - Return code: 0 04:54:51 INFO - grabbing minidump binary from tooltool 04:54:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:54:51 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fca0e00>, '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 0x10fac9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fc9bb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:54:51 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 04:54:51 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 04:54:51 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:54:51 INFO - Return code: 0 04:54:51 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 04:54:51 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:54:51 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:54:51 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 04:54:51 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:54:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:54:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:54:52 INFO - Return code: 0 04:54:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/W3vucRKoRTycp-0zgffbdw/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0031', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 04:54:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/W3vucRKoRTycp-0zgffbdw/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0031 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 04:54:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.49TWEdDh20/Render', 04:54:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:54:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:54:52 INFO - 'HOME': '/Users/cltbld', 04:54:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:54:52 INFO - 'LOGNAME': 'cltbld', 04:54:52 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:54:52 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 04:54:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:54:52 INFO - 'MOZ_NO_REMOTE': '1', 04:54:52 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:54:52 INFO - 'NO_EM_RESTART': '1', 04:54:52 INFO - 'PAGER': '/bin/cat', 04:54:52 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:54:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:54:52 INFO - 'PWD': '/builds/slave/test', 04:54:52 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:54:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:54:52 INFO - 'SHELL': '/bin/bash', 04:54:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yXApWZeoCA/Listeners', 04:54:52 INFO - 'TMPDIR': '/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/', 04:54:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:54:52 INFO - 'USER': 'cltbld', 04:54:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:54:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:54:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:54:52 INFO - 'XPC_FLAGS': '0x0', 04:54:52 INFO - 'XPC_SERVICE_NAME': '0', 04:54:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:54:52 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/W3vucRKoRTycp-0zgffbdw/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0031', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 04:54:53 INFO - mozversion application_buildid: 20160415024048 04:54:53 INFO - mozversion application_changeset: 755a175b3cc735b575a9e3dd4fcfcd4c7a63695c 04:54:53 INFO - mozversion application_display_name: Nightly 04:54:53 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:54:53 INFO - mozversion application_name: Firefox 04:54:53 INFO - mozversion application_remotingname: firefox 04:54:53 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:54:53 INFO - mozversion application_vendor: Mozilla 04:54:53 INFO - mozversion application_version: 48.0a1 04:54:53 INFO - mozversion platform_buildid: 20160415024048 04:54:53 INFO - mozversion platform_changeset: 755a175b3cc735b575a9e3dd4fcfcd4c7a63695c 04:54:53 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:54:53 INFO - mozversion platform_version: 48.0a1 04:54:53 INFO - using testdate: 1460721293 04:54:53 INFO - actual date: 1460721293 04:54:53 INFO - starting webserver on 'localhost:49276' 04:54:53 INFO - SUITE-START | Running 2 tests 04:54:53 INFO - TEST-START | dromaeo_css 04:54:53 INFO - operating with platform_type : mac_ 04:54:53 INFO - Initialising browser for dromaeo_css test... 04:54:53 INFO - TEST-INFO | started process 1664 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/tmpqw9I9R/profile http://localhost:49276/getInfo.html) 04:54:55 INFO - PROCESS | 1664 | __metrics Screen width/height:1600/1200 04:54:55 INFO - PROCESS | 1664 | colorDepth:24 04:54:55 INFO - PROCESS | 1664 | Browser inner width/height: 1024/689 04:54:55 INFO - PROCESS | 1664 | __metrics 04:54:55 INFO - PROCESS | 1664 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 04:54:55 ERROR - PROCESS | 1664 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 04:54:56 INFO - TEST-INFO | 1664: exit 0 04:54:56 INFO - Browser initialized. 04:54:56 INFO - Running cycle 1/1 for dromaeo_css test... 04:54:56 INFO - TEST-INFO | started process 1666 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/tmpqw9I9R/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:55:08 INFO - PROCESS | 1666 | RSS: Main: 237510656 04:55:08 INFO - PROCESS | 1666 | 04:55:59 INFO - PROCESS | 1666 | 1460721359308 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 04:58:09 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49276/tests/dromaeo/cssquery-ext.html) 04:58:10 INFO - PROCESS | 1666 | RSS: Main: 377630720 04:58:10 INFO - PROCESS | 1666 | 05:01:13 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-ext.html (next: http://localhost:49276/tests/dromaeo/cssquery-jquery.html) 05:01:14 INFO - PROCESS | 1666 | RSS: Main: 375980032 05:01:14 INFO - PROCESS | 1666 | 05:04:16 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49276/tests/dromaeo/cssquery-mootools.html) 05:04:16 INFO - PROCESS | 1666 | RSS: Main: 372793344 05:04:16 INFO - PROCESS | 1666 | 05:07:19 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49276/tests/dromaeo/cssquery-prototype.html) 05:07:19 INFO - PROCESS | 1666 | RSS: Main: 373915648 05:07:19 INFO - PROCESS | 1666 | 05:10:22 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49276/tests/dromaeo/cssquery-yui.html) 05:10:23 INFO - PROCESS | 1666 | RSS: Main: 340590592 05:10:23 INFO - PROCESS | 1666 | 05:13:26 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-yui.html (next: http://localhost:49276/tests/dromaeo/cssquery-dojo.html) 05:13:26 INFO - PROCESS | 1666 | RSS: Main: 413986816 05:13:26 INFO - PROCESS | 1666 | 05:13:26 INFO - PROCESS | 1666 | __start_tp_report 05:13:26 INFO - PROCESS | 1666 | _x_x_mozilla_page_load 05:13:26 INFO - PROCESS | 1666 | _x_x_mozilla_page_load_details 05:13:26 INFO - PROCESS | 1666 | |i|pagename|runs| 05:13:26 INFO - PROCESS | 1666 | |0;dojo.html;3376.3584918865413;3459.066052165915;3486.9476957845627;3494.1614012636974;3514.8418321175545;5561.972190139054;5627.409122042183;5659.349174844894;5669.829905102848;5684;5636.746346414411;5649.8587535311635;5697.373288938203;5791.102379131231;5808.564357673181;4615.907681846361;5074.568661663745;5115.335006449175;5133.204353325241;5144.639875208737;5067.873303167414;5219.373675158986;5255.421903590621;5271.077561426754;5330.493603107718;5093.821716239951;5100.821471248507;5166.018456493254;5206.088934436496;5229.843104706865;5150.4334523202415;5179.637425380225;5182.818601348972;5191.428942816287;5194.870128246786;5126.666766660155;5130.563902068328;5164.896702065976;5175.068487672217;5184.429712731597;5486.862828429281;5522.834314970557;5586.636868603528;5606.915896261559;5644.4073372295725;6162.96918515409;6184.319724830265;6207.534434917399;6209.130721698965;6219.160413344186;6178.135061091451;6209.720562574695;6228.5951413158455;6240.781572644981;6243.282022567372;5634.774609015675;5713.457221563945;5735.799247026334;5765.135229715576;5780.277465316835;6196.1015652731;6250.1874756281395;6282.4974002079725;6304.338044505353;6310.0534919761485;5983.640981541122;6041.546883983631;6059.394060593993;6068.21113255274;6072.7570897164505;6130.386961303834;6158.846028849225;6211.3478084801345;6223.439890409885;6235.127082208494;6067.150598916155;6117.583823141572;6120.908186377208;6130.092410195624;6137.662428566382;5608.850185711919;5808.88382232353;6168.167297414791;6185.257769067741;6195;4556.815228040667;4786.8085276589245;4883.902321953541;4892.241702536113;4897.730624815598;4381.123775244963;4474.530174331713;4475.686701930834;4479.641628669699;4479.992001799569;5615.129654903497;5637.689927054052;5661.3206415229615;5683.573731970118;5702.372738998707;6114.236541168675;6140.473573783631;6177.536684748662;6199.194104766351;6221.129041934133;4760.262159365304;5692.060809966392;5692.402297758676;5694.658320500783;5729.054705973551;5375.731213439312;5376.8118115865755;5394.460553944653;5396.91904621431;5420.07858664028;6150.892839288971;6200;6215.844603884849;6249.6562689052535;6249.843753906189;6159.969200153971;6223.813285601439;6241.531885108544;6265.091561723433;6269.310375858743;5617.775288988558;6200.503959683305;6328.968355158195;6338.90491642635;6341.239051313872;6088.573799833969;6111.77406523465;6122.234720659918;6140.13616995759;6140.258857967814;5677.261955945701;6210.285817131088;6221.720022598904;6222.253329600477;6236.719347629459;5821.214136091573;6004.339522652417;6076.058210977306;6082.878342433038;6084.300305464928;6055;6058.333583305921;6061.454469097803;6069.302030266399;6115.021596544531;5857.26784151981;5883;5898.528117750656;5913.970430147821;5946.583739138218;5824.330202026821;6024.216851809237;6063;6070.696465176635;6132.264128304632;5917.733701983507;5919.85200369977;5926.318473375444;5927.911081333697;5957.791477298274 05:13:26 INFO - PROCESS | 1666 | |1;ext.html;502.0636512903434;543.3805461773578;548.391285672903;564.9237352957349;602.250198502864;29118.27204319893;37075.443868341965;37982.25221847273;38085.80957095217;38097.80951095241;42491.78754106225;43395.91510212246;43439;43439.34840977388;43555;8478.321734261275;9430.198433133191;9661.855072173923;9680.225581953462;9688.03119688029;8609.526476043815;8723.60743766532;8724.912750872474;8730.563471826415;11234.49444774987;11356.034737047361;11414.086873050135;11417;11435.028022618088;11442.542298308057;11345.319280843176;11441.199116061878;11458.083353331755;11460;11467.426628668616;8519.701810436605;9746.902530974741;11232.98903098725;11297.661070167826;11536.423178841109;37409.81295093507;37963.43054854179;38004;38085.23829523394;38185.18148185187;3263.543103965447;3292.061762397729;3526.788392696421;3589.94615080774;4051.817668204938;28548.571771423445;28561.85719071412;28841;28967.42065158706;29055.70944290551;2721.319670082479;2730.331068888115;2764.129299270723;2770.5290100682732;2842.4173044525824;484361;486429;488939;489081;490040.5497972523;58977.70511147417;59141.70429147913;59303;59347.81304373888;59479.40520594738;61885.69057154685;62287.688561556904;62327;62336.37663623306;62338.0649290261;15766.76349854753;16318.75521867173;16328.67342653164;16358.509244722678;16416.589585260226;12689.936550317374;12829.358532073358;12841.614751557468;12863.678408039874;12872.420741066488;13908.860911390757;15188;15508.612284692746;15539.378424863105;15658.25980453416;6027.9095813562835;6081.746265747804;6133.473252879612;6143.754249829957;6150.969245153746;946.5030858799186;973.7078876337071;1032.1123833503182;1054.2040759226888;1120.8879112088725;29196.562051569243;29345.413091738046;29772.255693607833;29874.701252987627;30072.548911766342;1119.2780656476689;1178.1693905796565;1182.6688527212393;1217.446062041769;1243.975120497585;15021;15058.849411505964;15105;15360.385584576716;15458.381664733284;593284;598503;600606;603061;605717;57105;58966.70516647389;59012;59060;59067.70466147642;1334.426196735413;1358.4973559782745;1463.5975106845704;1493.4996776080136;1553.968920621604;28085.157445276673;28095.016674416296;28360.716392835806;28821.855890720413;28850.711492885643;44086.33870491881;44556;44996.77501612602;45146.322805157295;45159.19363225434;400829.9917000793;411259;412323;412368;413288;32797.836010819796;38702.80648596739;39766.60233397629;39785.20429591334;40412.79793601131;44527;44564.88587785331;44648.55351446444;45927.77036114798;46067;30224.395512089195;35314.293714126085;36571.81714091519;37590.812045939594;37598.62401376061;34382.14044648904;35668.46497302595;35886.820565897004;36103.63896361003;36941;36154.4576831353;36346.90959271226;36836.447453287685;37032.814835925645;37301;30849.691503085578;32179.195520112185;32263.677363226067;32317.838410807795;32402.83798580992;19727.210911563376;23599.93800279026;23978.52042959096;24006.63990040116;24279.271621851374 05:13:26 INFO - PROCESS | 1666 | |2;jquery.html;394.50686641697877;396.6846357146069;400.1197365795251;401.3478098090599;412.55650176060726;17700.734488982675;18270.360537381162;18481.42907852834;18484.537886552844;20260.39218823434;19734.90132549339;19833.702494462595;19906.20375184991;20669.896650516763;20681.276155334566;5455.1271796512565;5698.373178950312;6180.629162250257;6187.907181392283;6192.009278515438;5962.135490353896;6085.087236914476;6105.8168254952425;6150.384961503859;6154.292256390505;5366.436524164965;5512.476314750113;5542.362628297757;5543.029969755276;5549.139883318092;5533.667979921198;5597.412271711472;5600.747966341524;5609.1305847593685;5609.551235901118;5746.195532625436;5769.105788602773;5770.278715160605;5771.134329850514;5775.682337471438;13406.865931340659;13613.931930340384;13975.440982360693;14010;14025.966234895883;2028.543577695007;2039.7348344715092;2053.8459615528745;2103.579284143162;2254.0870947266385;9701.417914925127;9899.35654182483;10011.79976400468;10049.447280399576;10339.172866170764;1751.842334189929;1766.1345940489196;1789.7404876292994;1816.7547381103645;1839.4297767692058;77665;105195;105485;106134;109703.45148274208;9995.050470205319;11531.827022594667;11690.298582085103;11695.356755378536;11736.823947640793;14825.851741482662;15236.923815380853;15315.234238288042;15326.157061361731;15334.156621385708;7090;8477.194666506795;8516.637338025886;8645.265152461985;8741.956290218635;8400.327973762085;8410.705625303208;8417.873731894026;8527;8527;4590.9540904591195;4692.202325604655;4692.741899195577;4729.763511824395;4764.166270902579;1664.1112337497027;1972.7829938706732;1986.602679464113;2008.56815784607;2021.2117274263048;794.8728203487415;835.9247667709935;940.4357385568604;964.4406244378243;1034.1881622925966;19845.702314465296;20457.48856278575;20501.897490512452;20736.896315518326;20741.481462963246;846.8856704344958;966.535698416899;971.6251504121589;981.7840075183448;983.5623147699205;10622.89377106219;11059.22585419029;11071.501782419811;11077.612283570037;11087.667369978913;605260;615806;623443;625052;626366.8681656562;87949;122756.38621807013;127715;129828.70171298354;138343;992.8858181309098;1015.7714514234239;1027.6762819711766;1029.0275689473526;1032.1845741863845;17498.91250543739;17951.192196350934;18342.358017469323;18460.630787384445;18623.90688046551;38446.23107537778;50283;50770.49229507805;51555.48444515507;51702.48297516977;75747;76610.6169469149;78190.6090469544;78237.4352512958;80568.79146812686;7026.8945965809535;7468.626568671653;7553.509021913558;7562.659680314509;7838.608069596383;7843.764687059397;9506.95246523763;10217.846732299171;10555.102816260396;13441.663958401119;10230.232732545237;10462.424566648908;11124.332540047622;11169.497372618089;11380.146489013192;8203.507789532647;10869.728256793644;10983.83524247121;11322.433878306216;11395.886041139815;11358.488868001125;11487.942560287145;11712.472938717949;11755.823662645238;11810.645680629596;6712.261651218264;7728.497647652885;7780.066392032993;8398.706045288385;8431.620577074169;9353.579088941151;10076.294659374067;11063.059639930696;11218.83171752408;11427.200095993201 05:13:26 INFO - PROCESS | 1666 | |3;mootools.html;1421.0763004047374;1604.310146636946;1617.1429142554446;1894.84841212703;2022.5651484930727;7888.842223155533;8541.786455338619;8734.344924130699;8758.08040155784;8762.605682744268;8366;8603.139686031394;8615.827683446343;8622.137786221374;8624.827503449927;2378.916737914173;2403.2790162951046;2406.470576473173;2409.674693916325;2411.7949974252124;2392.0431827269144;2422.9394265143424;2430.9392265193333;2432.8418652787514;2442.3514127963645;2081.843861710378;2420.4432980414517;2438.036975394718;2450.8652024138664;2452.865092419916;2196.4399078235106;2392.413858604653;2413.2036427978724;2420.9636855447184;2427.8543287402813;2229.832762542816;2366.077229880348;2399.4961058177805;2401.735809061002;2402.7356990731005;7498.4376171787335;8468.44955077918;8638.093000234947;8705.825883482295;8705.956470217672;5224.50367215114;5419.810306639288;5437.238786569884;5456.236126942231;5462.535684466825;3240.675932406764;3392.932141357184;3394.032700680319;3529.4882242075014;3604.621514740967;1015.451656105702;1042.8644276244115;1043.546057465005;1051.9053285204293;1057.302180560834;11240.718982025433;11435.313881167156;11442.656720298404;11443.542258309657;11444.713882153013;4689.601383882408;4783.689060211075;4840.976368221199;4895.461499235082;4950.331705219749;9931.553080111413;9948.602055917681;9966.50167491637;9983.550740216708;9990.950045249727;5403.891922161535;5404.702741349185;5407.107827208545;5416.51251387377;5421.322334708161;4027.35562310029;4428.2914733642465;4697.895994441304;4834.057358815067;4915.238138088602;3963.841446342114;3980.5024371953505;4066.573009833984;4091.8363265469047;4109.3425051991535;1323.2523624152516;1353.29628593133;1357.2331632627534;1371.2252577293798;1372.7872179812146;624.6970219443566;895.0601868038664;930.5021813329836;949.1647350331664;964.4358050540372;5287.233351164136;5702.486776190163;5817.214676018768;5863.331118010547;6027.487663548647;929.9907000929904;981.7594689301167;1022.9821327778908;1032.0659802878406;1047.4919663962971;3826.8469261229798;3895.824687888995;3964.0486283291802;3992.82032308541;3994.3609022556834;9964.750881228027;10111.696649100539;10426.270161088803;10510.527026283835;10538.89461105379;10300.381977081399;10329.018743219382;10470.738231544272;10481;10627.043566078935;6814.795556133324;7566.583837888859;7984.121746607869;8166.877496837552;8173.673053078048;5631.408702086222;5812.709364531672;5814.94185058144;5888.676122813286;5908.438698323825;9804.36271642341;9804.803903921738;9949.154321882721;9962.601495940082;9974.650887218913;8478.491290522588;9488.14606685374;9749.122578967927;9984.500774961369;10108.292419530857;6347.39699728525;6537.084808126961;6711.4966377520905;6894.310568943066;7070.292970702889;8190.959045204736;8193.83612327762;8277.089520152898;8287.875681864656;8295.211954864279;7238.710451581877;7316.670749816165;7332.743353982798;7444.292792184734;7509.699612015458;6970.372666460043;7216.7834964951135;7284.745033923788;7293.307135822089;7316.268373162641;6907.240203577502;6995.965020174866;6996.790096297119;6996.825079373057;7001.859962800817;4016.758994460342;4825.565699086958;4830.275458681226;4830.372051633265;4957.900841983213;4575.816967321403;4668.11305851887;4803.567678908915;4861.003494283734;5003.624728145331 05:13:26 INFO - PROCESS | 1666 | |4;prototype.html;304.29859174602547;312.26928986172356;322.3150804540352;324.24127541552764;326.6309070750052;4907.411110666725;4964.304997300376;5363.865903352408;5626.184203290521;5840.182374467573;5084.034033533626;5232.764525596348;5472.017750326072;5607.158926161078;5885.146653735206;3627.691646210069;4023.982013489883;4396.274614688573;4405.889852753675;4413.426254586915;3804.4673745675627;4254.936175957363;4404.581564751344;4423.845165419211;4436.844710435135;3982.5021872265966;4052.898677533056;4377.978110109445;4378.1462614790125;4380.605745482906;3684.7420680552373;4046.6358027777346;4202.936955945664;4384.991451966066;4405.339199120125;3811.1805961718087;3828.693704503633;3831.616838316174;3837.982934522354;3841.7887016214377;5082.847514574569;5292.100342941709;5478.424765399655;5634.239377684001;5643.266375371217;4536.024754677727;4769.76151192439;4888.682235654671;4918.631102667314;4931.013797240566;5384.353877534721;5491.533219676332;5625.184348269478;6048.971674815292;6144.446999769997;3806.4480650305827;3884.7280690351686;3889.9222015559812;4036.869676490587;4108.753474791522;6497.317781632955;6574.441172500343;6588.93411065888;6591.604503729792;6621.668916554153;3681.466187402865;3888.650021498079;4165.604267594574;4167.229062623424;4182.372644103409;4181.560936101726;4234.470691163605;4238.830446782094;4244.511881133647;4266.360045993064;4949.7030178189425;4973;4974.915552357562;4987.80048798044;4997.325361076281;5461.371942226695;5939.881202376015;6222.719977601018;6224.439800417984;6277.968610157011;1232.4022848918266;1438.928053597316;1459.9051061680957;1463.1879306984727;1465.765477523591;925.7594822937161;940.3323640215386;954.7804005078732;955.2787645327733;957.0859828863419;5308.629020571964;5663.688497132614;5793.507551858055;5833.67914764692;5835.795747148914;6404;6439.259485159267;6456.9354306456335;6472.805815825533;6513.511486638521;4788.018456216468;4866.562009419169;5320.787168513216;5805.82582522525;5831.746174572402;3377.1725927147513;3379.5268662387284;3398.2693720850134;3410.36908171989;3428.6914177724125;5020.698758074454;6393.712282947278;6719.227288861844;6737.831554211086;6757.547127367639;6646.169228846395;6657.600543967377;6657.667116644148;6686.398224159849;6687.398134167851;5960.523158147251;6052.03167493199;6753.696083676246;6819.727210911508;6820.624865632339;4888.2178851383605;5278.709670968134;6005;6479.546431749733;6510;6316.399942005502;6390.648514331757;6399.264084630141;6429.22849258092;6429.38920802523;6502.382273683992;6780.321967803377;6794.855138365692;6810.8637827244165;6839.829004274933;3553.307105114478;3923.489946306962;4040.3535434330365;4045.8179381927293;4154.169166166839;5330.573554115739;5661.830145095653;6146.985747351637;6193.739285160974;6360.618362898241;5507.807226747044;5891;5977.3424923257535;6189.381061893775;6205.317415084247;5111;5266.868328291824;5505.284313039279;6286.705352546379;6298.905516417349;5131.717755523333;6147.631142131487;6153.446189842935;6153.600015998945;6205.22434695663;4924.01519696055;6012.488938440281;6286.811395658137;6304.211973503312;6314.400131987454;5150.510701483353;5863.442972917566;6096.908546371719;6163.630182189083;6175.752969881334 05:13:26 INFO - PROCESS | 1666 | |5;yui.html;663.4791688524508;670.7417644206979;686.2896901706731;712.6258714175061;732.9152853776411;15003;15491.22543872806;15499.84500154998;15508.922455387707;15514.689706205869;13992.020558560906;14145.222012789292;14359.210243436606;14368.066075705072;14377.784333234984;775.7633921653893;937.9577918993627;956.3879117364892;956.4404823178448;961.4904100826573;756.1455555222591;785.2657764989724;795.9602019899011;956.7321150077989;960.8750862387915;1003.3979612232675;1007.1590222164465;1008.4503945349802;1012.5494155100984;1014.8579198912158;793.9007624046994;1000.0999100809257;1005.8642083318731;1006.6376104602338;1007.1741172238767;603.423730337531;604.066716922356;604.0817956705827;730.5762657658545;755.1014292991323;15056.774148387783;15102.924485377613;15110.39558417662;15137.848621513755;15170.772438413433;12399.13206075575;12437.564685235973;12489.937550312281;12493.937530312382;12866.549670761571;9945.5027248638;10022.9498852506;10126;10326.48367581618;10788.406518223659;3529.5764508258917;3538.6461353864665;3553.4847447120283;3736.4395340698843;3773.2830762155104;79230.60384698039;79810.20189798086;79869.60065199695;79893;79921.60039199825;9489.715308540755;9658.420494770337;9843.901560984441;9870.901290987142;9917.702468925943;21857.781422185893;22125.66811497829;22134;22159.667604985938;22185.889070554866;7179.353858152791;7374.631268436664;7467;7475.663595138232;7548.207438219018;4149.751014939114;4200.5169405518145;4244.575542445731;4265.1043280910735;4331.003869110123;3516.701080408194;3655.4882316475714;3658.835352409148;3660.7071434285194;3662.6886714629554;647.9352064793483;657.7204688007578;661.441082285468;663.9966800166064;668.345021878552;518.142474205191;594.46201187925;616.7378863982879;621.3072424246932;629.6883042893705;6608.570442921195;7839.84320313602;7927;7941.9205807942335;7970.402219833536;504.7678068088647;590.7577893063823;591.9260092488439;612.5558969746987;616.140484024783;3680.6135355787255;3835.079580900564;3853.5761066282685;3871;3897.8830635080994;83606.581967091;85692.57153714316;85785.58584585712;85818.57090714507;86773;58726;66915;72443.18892027636;72640;72785;50680.746596266785;56295;59709.70145149333;59988;60409.69795150996;7513.248675132443;7569.735059272899;7610.200928902385;7625.771226863203;7651.196624354363;39387;39790.00524986783;40768.18463630651;40774.9806254846;42299.78850105853;56941;58189.70905145447;58610;60161.699191503765;60832.479188020654;10787.784244314913;10873.293235939955;11051.005409513182;11729.47217375203;11743.236689615147;10768.246222764332;11715.121365897421;11974.880251197725;12147.331896745764;12375.257484550955;9586.520673966133;10839.512221950188;11581.363025033705;11607.129465290305;11959.282443053444;10327.277090603586;11612.593559225386;11652.126090543412;11668.591599294323;12401.069919755873;10650.041496265063;10952.507137179005;10969.177311701815;11185.440727963407;11313.943430283125;9479.383840050376;9621.807563848824;9708.805823883342;9717.757056073655;9842.212622990286;9249.630014799333;9747.512624368896;9781.462019588706;9825.4104753715;9897.752556186153 05:13:26 INFO - PROCESS | 1666 | __end_tp_report 05:13:26 INFO - PROCESS | 1666 | __start_cc_report 05:13:26 INFO - PROCESS | 1666 | _x_x_mozilla_cycle_collect,1298 05:13:26 INFO - PROCESS | 1666 | __end_cc_report 05:13:26 INFO - PROCESS | 1666 | __startTimestamp1460722406570__endTimestamp 05:13:26 INFO - PROCESS | 1666 | 05:13:26 INFO - PROCESS | 1666 | ------- Summary: start ------- 05:13:26 INFO - PROCESS | 1666 | Number of tests: 6 05:13:26 INFO - PROCESS | 1666 | 05:13:26 INFO - PROCESS | 1666 | [#0] dojo.html Cycles:165 Average:5687.03 Median:5883.00 stddev:622.28 (10.6%) stddev-sans-first:597.20 05:13:26 INFO - PROCESS | 1666 | Values: 3376.4 3459.1 3486.9 3494.2 3514.8 5562.0 5627.4 5659.3 5669.8 5684.0 5636.7 5649.9 5697.4 5791.1 5808.6 4615.9 5074.6 5115.3 5133.2 5144.6 5067.9 5219.4 5255.4 5271.1 5330.5 5093.8 5100.8 5166.0 5206.1 5229.8 5150.4 5179.6 5182.8 5191.4 5194.9 5126.7 5130.6 5164.9 5175.1 5184.4 5486.9 5522.8 5586.6 5606.9 5644.4 6163.0 6184.3 6207.5 6209.1 6219.2 6178.1 6209.7 6228.6 6240.8 6243.3 5634.8 5713.5 5735.8 5765.1 5780.3 6196.1 6250.2 6282.5 6304.3 6310.1 5983.6 6041.5 6059.4 6068.2 6072.8 6130.4 6158.8 6211.3 6223.4 6235.1 6067.2 6117.6 6120.9 6130.1 6137.7 5608.9 5808.9 6168.2 6185.3 6195.0 4556.8 4786.8 4883.9 4892.2 4897.7 4381.1 4474.5 4475.7 4479.6 4480.0 5615.1 5637.7 5661.3 5683.6 5702.4 6114.2 6140.5 6177.5 6199.2 6221.1 4760.3 5692.1 5692.4 5694.7 5729.1 5375.7 5376.8 5394.5 5396.9 5420.1 6150.9 6200.0 6215.8 6249.7 6249.8 6160.0 6223.8 6241.5 6265.1 6269.3 5617.8 6200.5 6329.0 6338.9 6341.2 6088.6 6111.8 6122.2 6140.1 6140.3 5677.3 6210.3 6221.7 6222.3 6236.7 5821.2 6004.3 6076.1 6082.9 6084.3 6055.0 6058.3 6061.5 6069.3 6115.0 5857.3 5883.0 5898.5 5914.0 5946.6 5824.3 6024.2 6063.0 6070.7 6132.3 5917.7 5919.9 5926.3 5927.9 5957.8 05:13:26 INFO - PROCESS | 1666 | 05:13:26 INFO - PROCESS | 1666 | [#1] ext.html Cycles:180 Average:63933.09 Median:36459.36 stddev:134709.33 (369.5%) stddev-sans-first:135003.04 05:13:26 INFO - PROCESS | 1666 | Values: 502.1 543.4 548.4 564.9 602.3 29118.3 37075.4 37982.3 38085.8 38097.8 42491.8 43395.9 43439.0 43439.3 43555.0 8478.3 9430.2 9661.9 9680.2 9688.0 8609.5 8723.6 8724.9 8730.6 11234.5 11356.0 11414.1 11417.0 11435.0 11442.5 11345.3 11441.2 11458.1 11460.0 11467.4 8519.7 9746.9 11233.0 11297.7 11536.4 37409.8 37963.4 38004.0 38085.2 38185.2 3263.5 3292.1 3526.8 3589.9 4051.8 28548.6 28561.9 28841.0 28967.4 29055.7 2721.3 2730.3 2764.1 2770.5 2842.4 484361.0 486429.0 488939.0 489081.0 490040.5 58977.7 59141.7 59303.0 59347.8 59479.4 61885.7 62287.7 62327.0 62336.4 62338.1 15766.8 16318.8 16328.7 16358.5 16416.6 12689.9 12829.4 12841.6 12863.7 12872.4 13908.9 15188.0 15508.6 15539.4 15658.3 6027.9 6081.7 6133.5 6143.8 6151.0 946.5 973.7 1032.1 1054.2 1120.9 29196.6 29345.4 29772.3 29874.7 30072.5 1119.3 1178.2 1182.7 1217.4 1244.0 15021.0 15058.8 15105.0 15360.4 15458.4 593284.0 598503.0 600606.0 603061.0 605717.0 57105.0 58966.7 59012.0 59060.0 59067.7 1334.4 1358.5 1463.6 1493.5 1554.0 28085.2 28095.0 28360.7 28821.9 28850.7 44086.3 44556.0 44996.8 45146.3 45159.2 400830.0 411259.0 412323.0 412368.0 413288.0 32797.8 38702.8 39766.6 39785.2 40412.8 44527.0 44564.9 44648.6 45927.8 46067.0 30224.4 35314.3 36571.8 37590.8 37598.6 34382.1 35668.5 35886.8 36103.6 36941.0 36154.5 36346.9 36836.4 37032.8 37301.0 30849.7 32179.2 32263.7 32317.8 32402.8 19727.2 23599.9 23978.5 24006.6 24279.3 05:13:26 INFO - PROCESS | 1666 | 05:13:26 INFO - PROCESS | 1666 | [#2] jquery.html Cycles:180 Average:34312.91 Median:20350.16 stddev:102778.54 (505.1%) stddev-sans-first:103035.30 05:13:26 INFO - PROCESS | 1666 | Values: 394.5 396.7 400.1 401.3 412.6 17700.7 18270.4 18481.4 18484.5 20260.4 19734.9 19833.7 19906.2 20669.9 20681.3 5455.1 5698.4 6180.6 6187.9 6192.0 5962.1 6085.1 6105.8 6150.4 6154.3 5366.4 5512.5 5542.4 5543.0 5549.1 5533.7 5597.4 5600.7 5609.1 5609.6 5746.2 5769.1 5770.3 5771.1 5775.7 13406.9 13613.9 13975.4 14010.0 14026.0 2028.5 2039.7 2053.8 2103.6 2254.1 9701.4 9899.4 10011.8 10049.4 10339.2 1751.8 1766.1 1789.7 1816.8 1839.4 77665.0 105195.0 105485.0 106134.0 109703.5 9995.1 11531.8 11690.3 11695.4 11736.8 14825.9 15236.9 15315.2 15326.2 15334.2 7090.0 8477.2 8516.6 8645.3 8742.0 8400.3 8410.7 8417.9 8527.0 8527.0 4591.0 4692.2 4692.7 4729.8 4764.2 1664.1 1972.8 1986.6 2008.6 2021.2 794.9 835.9 940.4 964.4 1034.2 19845.7 20457.5 20501.9 20736.9 20741.5 846.9 966.5 971.6 981.8 983.6 10622.9 11059.2 11071.5 11077.6 11087.7 605260.0 615806.0 623443.0 625052.0 626366.9 87949.0 122756.4 127715.0 129828.7 138343.0 992.9 1015.8 1027.7 1029.0 1032.2 17498.9 17951.2 18342.4 18460.6 18623.9 38446.2 50283.0 50770.5 51555.5 51702.5 75747.0 76610.6 78190.6 78237.4 80568.8 7026.9 7468.6 7553.5 7562.7 7838.6 7843.8 9507.0 10217.8 10555.1 13441.7 10230.2 10462.4 11124.3 11169.5 11380.1 8203.5 10869.7 10983.8 11322.4 11395.9 11358.5 11487.9 11712.5 11755.8 11810.6 6712.3 7728.5 7780.1 8398.7 8431.6 9353.6 10076.3 11063.1 11218.8 11427.2 05:13:26 INFO - PROCESS | 1666 | 05:13:26 INFO - PROCESS | 1666 | [#3] mootools.html Cycles:180 Average:5608.92 Median:4954.12 stddev:3091.09 (62.4%) stddev-sans-first:3083.74 05:13:26 INFO - PROCESS | 1666 | Values: 1421.1 1604.3 1617.1 1894.8 2022.6 7888.8 8541.8 8734.3 8758.1 8762.6 8366.0 8603.1 8615.8 8622.1 8624.8 2378.9 2403.3 2406.5 2409.7 2411.8 2392.0 2422.9 2430.9 2432.8 2442.4 2081.8 2420.4 2438.0 2450.9 2452.9 2196.4 2392.4 2413.2 2421.0 2427.9 2229.8 2366.1 2399.5 2401.7 2402.7 7498.4 8468.4 8638.1 8705.8 8706.0 5224.5 5419.8 5437.2 5456.2 5462.5 3240.7 3392.9 3394.0 3529.5 3604.6 1015.5 1042.9 1043.5 1051.9 1057.3 11240.7 11435.3 11442.7 11443.5 11444.7 4689.6 4783.7 4841.0 4895.5 4950.3 9931.6 9948.6 9966.5 9983.6 9991.0 5403.9 5404.7 5407.1 5416.5 5421.3 4027.4 4428.3 4697.9 4834.1 4915.2 3963.8 3980.5 4066.6 4091.8 4109.3 1323.3 1353.3 1357.2 1371.2 1372.8 624.7 895.1 930.5 949.2 964.4 5287.2 5702.5 5817.2 5863.3 6027.5 930.0 981.8 1023.0 1032.1 1047.5 3826.8 3895.8 3964.0 3992.8 3994.4 9964.8 10111.7 10426.3 10510.5 10538.9 10300.4 10329.0 10470.7 10481.0 10627.0 6814.8 7566.6 7984.1 8166.9 8173.7 5631.4 5812.7 5814.9 5888.7 5908.4 9804.4 9804.8 9949.2 9962.6 9974.7 8478.5 9488.1 9749.1 9984.5 10108.3 6347.4 6537.1 6711.5 6894.3 7070.3 8191.0 8193.8 8277.1 8287.9 8295.2 7238.7 7316.7 7332.7 7444.3 7509.7 6970.4 7216.8 7284.7 7293.3 7316.3 6907.2 6996.0 6996.8 6996.8 7001.9 4016.8 4825.6 4830.3 4830.4 4957.9 4575.8 4668.1 4803.6 4861.0 5003.6 05:13:26 INFO - PROCESS | 1666 | 05:13:26 INFO - PROCESS | 1666 | [#4] prototype.html Cycles:180 Average:4959.03 Median:5422.86 stddev:1578.88 (29.1%) stddev-sans-first:1544.17 05:13:26 INFO - PROCESS | 1666 | Values: 304.3 312.3 322.3 324.2 326.6 4907.4 4964.3 5363.9 5626.2 5840.2 5084.0 5232.8 5472.0 5607.2 5885.1 3627.7 4024.0 4396.3 4405.9 4413.4 3804.5 4254.9 4404.6 4423.8 4436.8 3982.5 4052.9 4378.0 4378.1 4380.6 3684.7 4046.6 4202.9 4385.0 4405.3 3811.2 3828.7 3831.6 3838.0 3841.8 5082.8 5292.1 5478.4 5634.2 5643.3 4536.0 4769.8 4888.7 4918.6 4931.0 5384.4 5491.5 5625.2 6049.0 6144.4 3806.4 3884.7 3889.9 4036.9 4108.8 6497.3 6574.4 6588.9 6591.6 6621.7 3681.5 3888.7 4165.6 4167.2 4182.4 4181.6 4234.5 4238.8 4244.5 4266.4 4949.7 4973.0 4974.9 4987.8 4997.3 5461.4 5939.9 6222.7 6224.4 6278.0 1232.4 1438.9 1459.9 1463.2 1465.8 925.8 940.3 954.8 955.3 957.1 5308.6 5663.7 5793.5 5833.7 5835.8 6404.0 6439.3 6456.9 6472.8 6513.5 4788.0 4866.6 5320.8 5805.8 5831.7 3377.2 3379.5 3398.3 3410.4 3428.7 5020.7 6393.7 6719.2 6737.8 6757.5 6646.2 6657.6 6657.7 6686.4 6687.4 5960.5 6052.0 6753.7 6819.7 6820.6 4888.2 5278.7 6005.0 6479.5 6510.0 6316.4 6390.6 6399.3 6429.2 6429.4 6502.4 6780.3 6794.9 6810.9 6839.8 3553.3 3923.5 4040.4 4045.8 4154.2 5330.6 5661.8 6147.0 6193.7 6360.6 5507.8 5891.0 5977.3 6189.4 6205.3 5111.0 5266.9 5505.3 6286.7 6298.9 5131.7 6147.6 6153.4 6153.6 6205.2 4924.0 6012.5 6286.8 6304.2 6314.4 5150.5 5863.4 6096.9 6163.6 6175.8 05:13:26 INFO - PROCESS | 1666 | 05:13:26 INFO - PROCESS | 1666 | [#5] yui.html Cycles:180 Average:16981.40 Median:56618.00 stddev:23076.78 (40.8%) stddev-sans-first:23108.98 05:13:26 INFO - PROCESS | 1666 | Values: 663.5 670.7 686.3 712.6 732.9 15003.0 15491.2 15499.8 15508.9 15514.7 13992.0 14145.2 14359.2 14368.1 14377.8 775.8 938.0 956.4 956.4 961.5 756.1 785.3 796.0 956.7 960.9 1003.4 1007.2 1008.5 1012.5 1014.9 793.9 1000.1 1005.9 1006.6 1007.2 603.4 604.1 604.1 730.6 755.1 15056.8 15102.9 15110.4 15137.8 15170.8 12399.1 12437.6 12489.9 12493.9 12866.5 9945.5 10022.9 10126.0 10326.5 10788.4 3529.6 3538.6 3553.5 3736.4 3773.3 79230.6 79810.2 79869.6 79893.0 79921.6 9489.7 9658.4 9843.9 9870.9 9917.7 21857.8 22125.7 22134.0 22159.7 22185.9 7179.4 7374.6 7467.0 7475.7 7548.2 4149.8 4200.5 4244.6 4265.1 4331.0 3516.7 3655.5 3658.8 3660.7 3662.7 647.9 657.7 661.4 664.0 668.3 518.1 594.5 616.7 621.3 629.7 6608.6 7839.8 7927.0 7941.9 7970.4 504.8 590.8 591.9 612.6 616.1 3680.6 3835.1 3853.6 3871.0 3897.9 83606.6 85692.6 85785.6 85818.6 86773.0 58726.0 66915.0 72443.2 72640.0 72785.0 50680.7 56295.0 59709.7 59988.0 60409.7 7513.2 7569.7 7610.2 7625.8 7651.2 39387.0 39790.0 40768.2 40775.0 42299.8 56941.0 58189.7 58610.0 60161.7 60832.5 10787.8 10873.3 11051.0 11729.5 11743.2 10768.2 11715.1 11974.9 12147.3 12375.3 9586.5 10839.5 11581.4 11607.1 11959.3 10327.3 11612.6 11652.1 11668.6 12401.1 10650.0 10952.5 10969.2 11185.4 11313.9 9479.4 9621.8 9708.8 9717.8 9842.2 9249.6 9747.5 9781.5 9825.4 9897.8 05:13:26 INFO - PROCESS | 1666 | -------- Summary: end -------- 05:13:26 INFO - PROCESS | 1666 | 05:13:27 INFO - TEST-INFO | 1666: exit 0 05:13:27 INFO - TEST-OK | dromaeo_css | took 1113971ms 05:13:27 INFO - TEST-START | kraken 05:13:27 INFO - operating with platform_type : mac_ 05:13:27 INFO - Initialising browser for kraken test... 05:13:27 INFO - TEST-INFO | started process 1675 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/tmp7a6M5S/profile http://localhost:49276/getInfo.html) 05:13:29 INFO - PROCESS | 1675 | __metrics Screen width/height:1600/1200 05:13:29 INFO - PROCESS | 1675 | colorDepth:24 05:13:29 INFO - PROCESS | 1675 | Browser inner width/height: 1024/689 05:13:29 INFO - PROCESS | 1675 | __metrics 05:13:29 INFO - PROCESS | 1675 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 05:13:29 ERROR - PROCESS | 1675 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 05:13:29 INFO - TEST-INFO | 1675: exit 0 05:13:29 INFO - Browser initialized. 05:13:29 INFO - Running cycle 1/1 for kraken test... 05:13:29 INFO - TEST-INFO | started process 1677 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/tmp7a6M5S/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:13:41 INFO - PROCESS | 1677 | RSS: Main: 237842432 05:13:41 INFO - PROCESS | 1677 | 05:13:44 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49276/tests/kraken/driver.html?testName=audio-beat-detection) 05:13:45 INFO - PROCESS | 1677 | RSS: Main: 286310400 05:13:45 INFO - PROCESS | 1677 | 05:13:48 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49276/tests/kraken/driver.html?testName=audio-dft) 05:13:48 INFO - PROCESS | 1677 | RSS: Main: 299749376 05:13:48 INFO - PROCESS | 1677 | 05:13:52 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49276/tests/kraken/driver.html?testName=audio-fft) 05:13:52 INFO - PROCESS | 1677 | RSS: Main: 386088960 05:13:52 INFO - PROCESS | 1677 | 05:13:54 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49276/tests/kraken/driver.html?testName=audio-oscillator) 05:13:55 INFO - PROCESS | 1677 | RSS: Main: 286748672 05:13:55 INFO - PROCESS | 1677 | 05:13:57 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49276/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:13:58 INFO - PROCESS | 1677 | RSS: Main: 290697216 05:13:58 INFO - PROCESS | 1677 | 05:14:01 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49276/tests/kraken/driver.html?testName=imaging-darkroom) 05:14:01 INFO - PROCESS | 1677 | RSS: Main: 329691136 05:14:01 INFO - PROCESS | 1677 | 05:14:04 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49276/tests/kraken/driver.html?testName=imaging-desaturate) 05:14:05 INFO - PROCESS | 1677 | RSS: Main: 329981952 05:14:05 INFO - PROCESS | 1677 | 05:14:07 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49276/tests/kraken/driver.html?testName=json-parse-financial) 05:14:08 INFO - PROCESS | 1677 | RSS: Main: 327434240 05:14:08 INFO - PROCESS | 1677 | 05:14:10 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49276/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:14:10 INFO - PROCESS | 1677 | RSS: Main: 320176128 05:14:10 INFO - PROCESS | 1677 | 05:14:12 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:14:13 INFO - PROCESS | 1677 | RSS: Main: 326987776 05:14:13 INFO - PROCESS | 1677 | 05:14:15 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:14:16 INFO - PROCESS | 1677 | RSS: Main: 329859072 05:14:16 INFO - PROCESS | 1677 | 05:14:19 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:14:19 INFO - PROCESS | 1677 | RSS: Main: 331055104 05:14:19 INFO - PROCESS | 1677 | 05:14:22 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:14:23 INFO - PROCESS | 1677 | RSS: Main: 326782976 05:14:23 INFO - PROCESS | 1677 | 05:14:25 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49276/tests/kraken/driver.html?testName=ai-astar) 05:14:25 INFO - PROCESS | 1677 | RSS: Main: 391147520 05:14:25 INFO - PROCESS | 1677 | 05:14:25 INFO - PROCESS | 1677 | __start_tp_report 05:14:25 INFO - PROCESS | 1677 | _x_x_mozilla_page_load 05:14:25 INFO - PROCESS | 1677 | _x_x_mozilla_page_load_details 05:14:25 INFO - PROCESS | 1677 | |i|pagename|runs| 05:14:25 INFO - PROCESS | 1677 | |0;ai-astar;112;108;110;111;111;113;117;110;110;111 05:14:25 INFO - PROCESS | 1677 | |1;audio-beat-detection;156;128;140;169;113;144;142;118;170;119 05:14:25 INFO - PROCESS | 1677 | |2;audio-dft;183;183;184;183;184;180;184;193;217;235 05:14:25 INFO - PROCESS | 1677 | |3;audio-fft;77;74;84;89;56;58;58;84;114;70 05:14:25 INFO - PROCESS | 1677 | |4;audio-oscillator;90;95;134;76;78;80;122;104;114;158 05:14:25 INFO - PROCESS | 1677 | |5;imaging-gaussian-blur;86;84;88;84;90;84;86;85;87;84 05:14:25 INFO - PROCESS | 1677 | |6;imaging-darkroom;93;94;94;93;93;93;94;94;92;91 05:14:25 INFO - PROCESS | 1677 | |7;imaging-desaturate;86;84;87;86;85;84;85;88;84;85 05:14:25 INFO - PROCESS | 1677 | |8;json-parse-financial;59;61;61;62;58;57;60;80;57;56 05:14:25 INFO - PROCESS | 1677 | |9;json-stringify-tinderbox;64;63;71;79;69;69;68;69;67;70 05:14:25 INFO - PROCESS | 1677 | |10;stanford-crypto-aes;83;104;112;112;112;86;86;86;85;86 05:14:25 INFO - PROCESS | 1677 | |11;stanford-crypto-ccm;145;144;146;143;144;141;145;184;244;156 05:14:25 INFO - PROCESS | 1677 | |12;stanford-crypto-pbkdf2;169;168;170;165;168;166;168;169;176;167 05:14:25 INFO - PROCESS | 1677 | |13;stanford-crypto-sha256-iterative;67;68;69;71;67;69;68;70;70;66 05:14:25 INFO - PROCESS | 1677 | __end_tp_report 05:14:25 INFO - PROCESS | 1677 | __start_cc_report 05:14:25 INFO - PROCESS | 1677 | _x_x_mozilla_cycle_collect,1903 05:14:25 INFO - PROCESS | 1677 | __end_cc_report 05:14:25 INFO - PROCESS | 1677 | __startTimestamp1460722465254__endTimestamp 05:14:25 INFO - PROCESS | 1677 | 05:14:25 INFO - PROCESS | 1677 | ------- Summary: start ------- 05:14:25 INFO - PROCESS | 1677 | Number of tests: 14 05:14:25 INFO - PROCESS | 1677 | 05:14:25 INFO - PROCESS | 1677 | [#0] ai-astar Cycles:10 Average:111.30 Median:111.00 stddev:2.41 (2.2%) stddev-sans-first:2.54 05:14:25 INFO - PROCESS | 1677 | Values: 112.0 108.0 110.0 111.0 111.0 113.0 117.0 110.0 110.0 111.0 05:14:25 INFO - PROCESS | 1677 | 05:14:25 INFO - PROCESS | 1677 | [#1] audio-beat-detection Cycles:10 Average:139.90 Median:143.00 stddev:20.59 (14.4%) stddev-sans-first:21.00 05:14:25 INFO - PROCESS | 1677 | Values: 156.0 128.0 140.0 169.0 113.0 144.0 142.0 118.0 170.0 119.0 05:14:25 INFO - PROCESS | 1677 | 05:14:25 INFO - PROCESS | 1677 | [#2] audio-dft Cycles:10 Average:192.60 Median:184.00 stddev:18.41 (10.0%) stddev-sans-first:19.20 05:14:25 INFO - PROCESS | 1677 | Values: 183.0 183.0 184.0 183.0 184.0 180.0 184.0 193.0 217.0 235.0 05:14:25 INFO - PROCESS | 1677 | 05:14:25 INFO - PROCESS | 1677 | [#3] audio-fft Cycles:10 Average:76.40 Median:75.50 stddev:17.73 (23.5%) stddev-sans-first:18.80 05:14:25 INFO - PROCESS | 1677 | Values: 77.0 74.0 84.0 89.0 56.0 58.0 58.0 84.0 114.0 70.0 05:14:25 INFO - PROCESS | 1677 | 05:14:25 INFO - PROCESS | 1677 | [#4] audio-oscillator Cycles:10 Average:105.10 Median:77.00 stddev:26.96 (35.0%) stddev-sans-first:28.03 05:14:25 INFO - PROCESS | 1677 | Values: 90.0 95.0 134.0 76.0 78.0 80.0 122.0 104.0 114.0 158.0 05:14:25 INFO - PROCESS | 1677 | 05:14:25 INFO - PROCESS | 1677 | [#5] imaging-gaussian-blur Cycles:10 Average:85.80 Median:86.00 stddev:2.04 (2.4%) stddev-sans-first:2.17 05:14:25 INFO - PROCESS | 1677 | Values: 86.0 84.0 88.0 84.0 90.0 84.0 86.0 85.0 87.0 84.0 05:14:25 INFO - PROCESS | 1677 | 05:14:25 INFO - PROCESS | 1677 | [#6] imaging-darkroom Cycles:10 Average:93.10 Median:93.50 stddev:0.99 (1.1%) stddev-sans-first:1.05 05:14:25 INFO - PROCESS | 1677 | Values: 93.0 94.0 94.0 93.0 93.0 93.0 94.0 94.0 92.0 91.0 05:14:25 INFO - PROCESS | 1677 | 05:14:25 INFO - PROCESS | 1677 | [#7] imaging-desaturate Cycles:10 Average:85.40 Median:85.50 stddev:1.35 (1.6%) stddev-sans-first:1.41 05:14:25 INFO - PROCESS | 1677 | Values: 86.0 84.0 87.0 86.0 85.0 84.0 85.0 88.0 84.0 85.0 05:14:25 INFO - PROCESS | 1677 | 05:14:25 INFO - PROCESS | 1677 | [#8] json-parse-financial Cycles:10 Average:61.10 Median:60.50 stddev:6.94 (11.5%) stddev-sans-first:7.31 05:14:25 INFO - PROCESS | 1677 | Values: 59.0 61.0 61.0 62.0 58.0 57.0 60.0 80.0 57.0 56.0 05:14:25 INFO - PROCESS | 1677 | 05:14:25 INFO - PROCESS | 1677 | [#9] json-stringify-tinderbox Cycles:10 Average:68.90 Median:69.00 stddev:4.36 (6.3%) stddev-sans-first:4.25 05:14:25 INFO - PROCESS | 1677 | Values: 64.0 63.0 71.0 79.0 69.0 69.0 68.0 69.0 67.0 70.0 05:14:25 INFO - PROCESS | 1677 | 05:14:25 INFO - PROCESS | 1677 | [#10] stanford-crypto-aes Cycles:10 Average:95.20 Median:85.50 stddev:12.98 (15.2%) stddev-sans-first:12.99 05:14:25 INFO - PROCESS | 1677 | Values: 83.0 104.0 112.0 112.0 112.0 86.0 86.0 86.0 85.0 86.0 05:14:25 INFO - PROCESS | 1677 | 05:14:25 INFO - PROCESS | 1677 | [#11] stanford-crypto-ccm Cycles:10 Average:159.20 Median:145.50 stddev:32.40 (22.3%) stddev-sans-first:33.96 05:14:25 INFO - PROCESS | 1677 | Values: 145.0 144.0 146.0 143.0 144.0 141.0 145.0 184.0 244.0 156.0 05:14:25 INFO - PROCESS | 1677 | 05:14:25 INFO - PROCESS | 1677 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:168.60 Median:168.50 stddev:2.99 (1.8%) stddev-sans-first:3.17 05:14:25 INFO - PROCESS | 1677 | Values: 169.0 168.0 170.0 165.0 168.0 166.0 168.0 169.0 176.0 167.0 05:14:25 INFO - PROCESS | 1677 | 05:14:25 INFO - PROCESS | 1677 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.50 Median:69.00 stddev:1.58 (2.3%) stddev-sans-first:1.58 05:14:25 INFO - PROCESS | 1677 | Values: 67.0 68.0 69.0 71.0 67.0 69.0 68.0 70.0 70.0 66.0 05:14:25 INFO - PROCESS | 1677 | -------- Summary: end -------- 05:14:25 INFO - PROCESS | 1677 | 05:14:25 INFO - TEST-INFO | 1677: exit 0 05:14:26 INFO - TEST-OK | kraken | took 58836ms 05:14:26 INFO - SUITE-END | took 1172s 05:14:26 INFO - Completed test suite (00:19:33) 05:14:26 INFO - javascript benchmark 05:14:26 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3376.3584918865413, 3459.066052165915, 3486.9476957845627, 3494.1614012636974, 3514.8418321175545, 5561.972190139054, 5627.409122042183, 5659.349174844894, 5669.829905102848, 5684.0, 5636.746346414411, 5649.8587535311635, 5697.373288938203, 5791.102379131231, 5808.564357673181, 4615.907681846361, 5074.568661663745, 5115.335006449175, 5133.204353325241, 5144.639875208737, 5067.873303167414, 5219.373675158986, 5255.421903590621, 5271.077561426754, 5330.493603107718, 5093.821716239951, 5100.821471248507, 5166.018456493254, 5206.088934436496, 5229.843104706865, 5150.4334523202415, 5179.637425380225, 5182.818601348972, 5191.428942816287, 5194.870128246786, 5126.666766660155, 5130.563902068328, 5164.896702065976, 5175.068487672217, 5184.429712731597, 5486.862828429281, 5522.834314970557, 5586.636868603528, 5606.915896261559, 5644.4073372295725, 6162.96918515409, 6184.319724830265, 6207.534434917399, 6209.130721698965, 6219.160413344186, 6178.135061091451, 6209.720562574695, 6228.5951413158455, 6240.781572644981, 6243.282022567372, 5634.774609015675, 5713.457221563945, 5735.799247026334, 5765.135229715576, 5780.277465316835, 6196.1015652731, 6250.1874756281395, 6282.4974002079725, 6304.338044505353, 6310.0534919761485, 5983.640981541122, 6041.546883983631, 6059.394060593993, 6068.21113255274, 6072.7570897164505, 6130.386961303834, 6158.846028849225, 6211.3478084801345, 6223.439890409885, 6235.127082208494, 6067.150598916155, 6117.583823141572, 6120.908186377208, 6130.092410195624, 6137.662428566382, 5608.850185711919, 5808.88382232353, 6168.167297414791, 6185.257769067741, 6195.0, 4556.815228040667, 4786.8085276589245, 4883.902321953541, 4892.241702536113, 4897.730624815598, 4381.123775244963, 4474.530174331713, 4475.686701930834, 4479.641628669699, 4479.992001799569, 5615.129654903497, 5637.689927054052, 5661.3206415229615, 5683.573731970118, 5702.372738998707, 6114.236541168675, 6140.473573783631, 6177.536684748662, 6199.194104766351, 6221.129041934133, 4760.262159365304, 5692.060809966392, 5692.402297758676, 5694.658320500783, 5729.054705973551, 5375.731213439312, 5376.8118115865755, 5394.460553944653, 5396.91904621431, 5420.07858664028, 6150.892839288971, 6200.0, 6215.844603884849, 6249.6562689052535, 6249.843753906189, 6159.969200153971, 6223.813285601439, 6241.531885108544, 6265.091561723433, 6269.310375858743, 5617.775288988558, 6200.503959683305, 6328.968355158195, 6338.90491642635, 6341.239051313872, 6088.573799833969, 6111.77406523465, 6122.234720659918, 6140.13616995759, 6140.258857967814, 5677.261955945701, 6210.285817131088, 6221.720022598904, 6222.253329600477, 6236.719347629459, 5821.214136091573, 6004.339522652417, 6076.058210977306, 6082.878342433038, 6084.300305464928, 6055.0, 6058.333583305921, 6061.454469097803, 6069.302030266399, 6115.021596544531, 5857.26784151981, 5883.0, 5898.528117750656, 5913.970430147821, 5946.583739138218, 5824.330202026821, 6024.216851809237, 6063.0, 6070.696465176635, 6132.264128304632, 5917.733701983507, 5919.85200369977, 5926.318473375444, 5927.911081333697, 5957.791477298274], "value": 5648.87627999627, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [502.0636512903434, 543.3805461773578, 548.391285672903, 564.9237352957349, 602.250198502864, 29118.27204319893, 37075.443868341965, 37982.25221847273, 38085.80957095217, 38097.80951095241, 42491.78754106225, 43395.91510212246, 43439.0, 43439.34840977388, 43555.0, 8478.321734261275, 9430.198433133191, 9661.855072173923, 9680.225581953462, 9688.03119688029, 8609.526476043815, 8723.60743766532, 8724.912750872474, 8730.563471826415, 11234.49444774987, 11356.034737047361, 11414.086873050135, 11417.0, 11435.028022618088, 11442.542298308057, 11345.319280843176, 11441.199116061878, 11458.083353331755, 11460.0, 11467.426628668616, 8519.701810436605, 9746.902530974741, 11232.98903098725, 11297.661070167826, 11536.423178841109, 37409.81295093507, 37963.43054854179, 38004.0, 38085.23829523394, 38185.18148185187, 3263.543103965447, 3292.061762397729, 3526.788392696421, 3589.94615080774, 4051.817668204938, 28548.571771423445, 28561.85719071412, 28841.0, 28967.42065158706, 29055.70944290551, 2721.319670082479, 2730.331068888115, 2764.129299270723, 2770.5290100682732, 2842.4173044525824, 484361.0, 486429.0, 488939.0, 489081.0, 490040.5497972523, 58977.70511147417, 59141.70429147913, 59303.0, 59347.81304373888, 59479.40520594738, 61885.69057154685, 62287.688561556904, 62327.0, 62336.37663623306, 62338.0649290261, 15766.76349854753, 16318.75521867173, 16328.67342653164, 16358.509244722678, 16416.589585260226, 12689.936550317374, 12829.358532073358, 12841.614751557468, 12863.678408039874, 12872.420741066488, 13908.860911390757, 15188.0, 15508.612284692746, 15539.378424863105, 15658.25980453416, 6027.9095813562835, 6081.746265747804, 6133.473252879612, 6143.754249829957, 6150.969245153746, 946.5030858799186, 973.7078876337071, 1032.1123833503182, 1054.2040759226888, 1120.8879112088725, 29196.562051569243, 29345.413091738046, 29772.255693607833, 29874.701252987627, 30072.548911766342, 1119.2780656476689, 1178.1693905796565, 1182.6688527212393, 1217.446062041769, 1243.975120497585, 15021.0, 15058.849411505964, 15105.0, 15360.385584576716, 15458.381664733284, 593284.0, 598503.0, 600606.0, 603061.0, 605717.0, 57105.0, 58966.70516647389, 59012.0, 59060.0, 59067.70466147642, 1334.426196735413, 1358.4973559782745, 1463.5975106845704, 1493.4996776080136, 1553.968920621604, 28085.157445276673, 28095.016674416296, 28360.716392835806, 28821.855890720413, 28850.711492885643, 44086.33870491881, 44556.0, 44996.77501612602, 45146.322805157295, 45159.19363225434, 400829.9917000793, 411259.0, 412323.0, 412368.0, 413288.0, 32797.836010819796, 38702.80648596739, 39766.60233397629, 39785.20429591334, 40412.79793601131, 44527.0, 44564.88587785331, 44648.55351446444, 45927.77036114798, 46067.0, 30224.395512089195, 35314.293714126085, 36571.81714091519, 37590.812045939594, 37598.62401376061, 34382.14044648904, 35668.46497302595, 35886.820565897004, 36103.63896361003, 36941.0, 36154.4576831353, 36346.90959271226, 36836.447453287685, 37032.814835925645, 37301.0, 30849.691503085578, 32179.195520112185, 32263.677363226067, 32317.838410807795, 32402.83798580992, 19727.210911563376, 23599.93800279026, 23978.52042959096, 24006.63990040116, 24279.271621851374], "value": 19595.16351803746, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [394.50686641697877, 396.6846357146069, 400.1197365795251, 401.3478098090599, 412.55650176060726, 17700.734488982675, 18270.360537381162, 18481.42907852834, 18484.537886552844, 20260.39218823434, 19734.90132549339, 19833.702494462595, 19906.20375184991, 20669.896650516763, 20681.276155334566, 5455.1271796512565, 5698.373178950312, 6180.629162250257, 6187.907181392283, 6192.009278515438, 5962.135490353896, 6085.087236914476, 6105.8168254952425, 6150.384961503859, 6154.292256390505, 5366.436524164965, 5512.476314750113, 5542.362628297757, 5543.029969755276, 5549.139883318092, 5533.667979921198, 5597.412271711472, 5600.747966341524, 5609.1305847593685, 5609.551235901118, 5746.195532625436, 5769.105788602773, 5770.278715160605, 5771.134329850514, 5775.682337471438, 13406.865931340659, 13613.931930340384, 13975.440982360693, 14010.0, 14025.966234895883, 2028.543577695007, 2039.7348344715092, 2053.8459615528745, 2103.579284143162, 2254.0870947266385, 9701.417914925127, 9899.35654182483, 10011.79976400468, 10049.447280399576, 10339.172866170764, 1751.842334189929, 1766.1345940489196, 1789.7404876292994, 1816.7547381103645, 1839.4297767692058, 77665.0, 105195.0, 105485.0, 106134.0, 109703.45148274208, 9995.050470205319, 11531.827022594667, 11690.298582085103, 11695.356755378536, 11736.823947640793, 14825.851741482662, 15236.923815380853, 15315.234238288042, 15326.157061361731, 15334.156621385708, 7090.0, 8477.194666506795, 8516.637338025886, 8645.265152461985, 8741.956290218635, 8400.327973762085, 8410.705625303208, 8417.873731894026, 8527.0, 8527.0, 4590.9540904591195, 4692.202325604655, 4692.741899195577, 4729.763511824395, 4764.166270902579, 1664.1112337497027, 1972.7829938706732, 1986.602679464113, 2008.56815784607, 2021.2117274263048, 794.8728203487415, 835.9247667709935, 940.4357385568604, 964.4406244378243, 1034.1881622925966, 19845.702314465296, 20457.48856278575, 20501.897490512452, 20736.896315518326, 20741.481462963246, 846.8856704344958, 966.535698416899, 971.6251504121589, 981.7840075183448, 983.5623147699205, 10622.89377106219, 11059.22585419029, 11071.501782419811, 11077.612283570037, 11087.667369978913, 605260.0, 615806.0, 623443.0, 625052.0, 626366.8681656562, 87949.0, 122756.38621807013, 127715.0, 129828.70171298354, 138343.0, 992.8858181309098, 1015.7714514234239, 1027.6762819711766, 1029.0275689473526, 1032.1845741863845, 17498.91250543739, 17951.192196350934, 18342.358017469323, 18460.630787384445, 18623.90688046551, 38446.23107537778, 50283.0, 50770.49229507805, 51555.48444515507, 51702.48297516977, 75747.0, 76610.6169469149, 78190.6090469544, 78237.4352512958, 80568.79146812686, 7026.8945965809535, 7468.626568671653, 7553.509021913558, 7562.659680314509, 7838.608069596383, 7843.764687059397, 9506.95246523763, 10217.846732299171, 10555.102816260396, 13441.663958401119, 10230.232732545237, 10462.424566648908, 11124.332540047622, 11169.497372618089, 11380.146489013192, 8203.507789532647, 10869.728256793644, 10983.83524247121, 11322.433878306216, 11395.886041139815, 11358.488868001125, 11487.942560287145, 11712.472938717949, 11755.823662645238, 11810.645680629596, 6712.261651218264, 7728.497647652885, 7780.066392032993, 8398.706045288385, 8431.620577074169, 9353.579088941151, 10076.294659374067, 11063.059639930696, 11218.83171752408, 11427.200095993201], "value": 9196.403880548289, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1421.0763004047374, 1604.310146636946, 1617.1429142554446, 1894.84841212703, 2022.5651484930727, 7888.842223155533, 8541.786455338619, 8734.344924130699, 8758.08040155784, 8762.605682744268, 8366.0, 8603.139686031394, 8615.827683446343, 8622.137786221374, 8624.827503449927, 2378.916737914173, 2403.2790162951046, 2406.470576473173, 2409.674693916325, 2411.7949974252124, 2392.0431827269144, 2422.9394265143424, 2430.9392265193333, 2432.8418652787514, 2442.3514127963645, 2081.843861710378, 2420.4432980414517, 2438.036975394718, 2450.8652024138664, 2452.865092419916, 2196.4399078235106, 2392.413858604653, 2413.2036427978724, 2420.9636855447184, 2427.8543287402813, 2229.832762542816, 2366.077229880348, 2399.4961058177805, 2401.735809061002, 2402.7356990731005, 7498.4376171787335, 8468.44955077918, 8638.093000234947, 8705.825883482295, 8705.956470217672, 5224.50367215114, 5419.810306639288, 5437.238786569884, 5456.236126942231, 5462.535684466825, 3240.675932406764, 3392.932141357184, 3394.032700680319, 3529.4882242075014, 3604.621514740967, 1015.451656105702, 1042.8644276244115, 1043.546057465005, 1051.9053285204293, 1057.302180560834, 11240.718982025433, 11435.313881167156, 11442.656720298404, 11443.542258309657, 11444.713882153013, 4689.601383882408, 4783.689060211075, 4840.976368221199, 4895.461499235082, 4950.331705219749, 9931.553080111413, 9948.602055917681, 9966.50167491637, 9983.550740216708, 9990.950045249727, 5403.891922161535, 5404.702741349185, 5407.107827208545, 5416.51251387377, 5421.322334708161, 4027.35562310029, 4428.2914733642465, 4697.895994441304, 4834.057358815067, 4915.238138088602, 3963.841446342114, 3980.5024371953505, 4066.573009833984, 4091.8363265469047, 4109.3425051991535, 1323.2523624152516, 1353.29628593133, 1357.2331632627534, 1371.2252577293798, 1372.7872179812146, 624.6970219443566, 895.0601868038664, 930.5021813329836, 949.1647350331664, 964.4358050540372, 5287.233351164136, 5702.486776190163, 5817.214676018768, 5863.331118010547, 6027.487663548647, 929.9907000929904, 981.7594689301167, 1022.9821327778908, 1032.0659802878406, 1047.4919663962971, 3826.8469261229798, 3895.824687888995, 3964.0486283291802, 3992.82032308541, 3994.3609022556834, 9964.750881228027, 10111.696649100539, 10426.270161088803, 10510.527026283835, 10538.89461105379, 10300.381977081399, 10329.018743219382, 10470.738231544272, 10481.0, 10627.043566078935, 6814.795556133324, 7566.583837888859, 7984.121746607869, 8166.877496837552, 8173.673053078048, 5631.408702086222, 5812.709364531672, 5814.94185058144, 5888.676122813286, 5908.438698323825, 9804.36271642341, 9804.803903921738, 9949.154321882721, 9962.601495940082, 9974.650887218913, 8478.491290522588, 9488.14606685374, 9749.122578967927, 9984.500774961369, 10108.292419530857, 6347.39699728525, 6537.084808126961, 6711.4966377520905, 6894.310568943066, 7070.292970702889, 8190.959045204736, 8193.83612327762, 8277.089520152898, 8287.875681864656, 8295.211954864279, 7238.710451581877, 7316.670749816165, 7332.743353982798, 7444.292792184734, 7509.699612015458, 6970.372666460043, 7216.7834964951135, 7284.745033923788, 7293.307135822089, 7316.268373162641, 6907.240203577502, 6995.965020174866, 6996.790096297119, 6996.825079373057, 7001.859962800817, 4016.758994460342, 4825.565699086958, 4830.275458681226, 4830.372051633265, 4957.900841983213, 4575.816967321403, 4668.11305851887, 4803.567678908915, 4861.003494283734, 5003.624728145331], "value": 4550.470638738978, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [304.29859174602547, 312.26928986172356, 322.3150804540352, 324.24127541552764, 326.6309070750052, 4907.411110666725, 4964.304997300376, 5363.865903352408, 5626.184203290521, 5840.182374467573, 5084.034033533626, 5232.764525596348, 5472.017750326072, 5607.158926161078, 5885.146653735206, 3627.691646210069, 4023.982013489883, 4396.274614688573, 4405.889852753675, 4413.426254586915, 3804.4673745675627, 4254.936175957363, 4404.581564751344, 4423.845165419211, 4436.844710435135, 3982.5021872265966, 4052.898677533056, 4377.978110109445, 4378.1462614790125, 4380.605745482906, 3684.7420680552373, 4046.6358027777346, 4202.936955945664, 4384.991451966066, 4405.339199120125, 3811.1805961718087, 3828.693704503633, 3831.616838316174, 3837.982934522354, 3841.7887016214377, 5082.847514574569, 5292.100342941709, 5478.424765399655, 5634.239377684001, 5643.266375371217, 4536.024754677727, 4769.76151192439, 4888.682235654671, 4918.631102667314, 4931.013797240566, 5384.353877534721, 5491.533219676332, 5625.184348269478, 6048.971674815292, 6144.446999769997, 3806.4480650305827, 3884.7280690351686, 3889.9222015559812, 4036.869676490587, 4108.753474791522, 6497.317781632955, 6574.441172500343, 6588.93411065888, 6591.604503729792, 6621.668916554153, 3681.466187402865, 3888.650021498079, 4165.604267594574, 4167.229062623424, 4182.372644103409, 4181.560936101726, 4234.470691163605, 4238.830446782094, 4244.511881133647, 4266.360045993064, 4949.7030178189425, 4973.0, 4974.915552357562, 4987.80048798044, 4997.325361076281, 5461.371942226695, 5939.881202376015, 6222.719977601018, 6224.439800417984, 6277.968610157011, 1232.4022848918266, 1438.928053597316, 1459.9051061680957, 1463.1879306984727, 1465.765477523591, 925.7594822937161, 940.3323640215386, 954.7804005078732, 955.2787645327733, 957.0859828863419, 5308.629020571964, 5663.688497132614, 5793.507551858055, 5833.67914764692, 5835.795747148914, 6404.0, 6439.259485159267, 6456.9354306456335, 6472.805815825533, 6513.511486638521, 4788.018456216468, 4866.562009419169, 5320.787168513216, 5805.82582522525, 5831.746174572402, 3377.1725927147513, 3379.5268662387284, 3398.2693720850134, 3410.36908171989, 3428.6914177724125, 5020.698758074454, 6393.712282947278, 6719.227288861844, 6737.831554211086, 6757.547127367639, 6646.169228846395, 6657.600543967377, 6657.667116644148, 6686.398224159849, 6687.398134167851, 5960.523158147251, 6052.03167493199, 6753.696083676246, 6819.727210911508, 6820.624865632339, 4888.2178851383605, 5278.709670968134, 6005.0, 6479.546431749733, 6510.0, 6316.399942005502, 6390.648514331757, 6399.264084630141, 6429.22849258092, 6429.38920802523, 6502.382273683992, 6780.321967803377, 6794.855138365692, 6810.8637827244165, 6839.829004274933, 3553.307105114478, 3923.489946306962, 4040.3535434330365, 4045.8179381927293, 4154.169166166839, 5330.573554115739, 5661.830145095653, 6146.985747351637, 6193.739285160974, 6360.618362898241, 5507.807226747044, 5891.0, 5977.3424923257535, 6189.381061893775, 6205.317415084247, 5111.0, 5266.868328291824, 5505.284313039279, 6286.705352546379, 6298.905516417349, 5131.717755523333, 6147.631142131487, 6153.446189842935, 6153.600015998945, 6205.22434695663, 4924.01519696055, 6012.488938440281, 6286.811395658137, 6304.211973503312, 6314.400131987454, 5150.510701483353, 5863.442972917566, 6096.908546371719, 6163.630182189083, 6175.752969881334], "value": 4452.453897465231, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [663.4791688524508, 670.7417644206979, 686.2896901706731, 712.6258714175061, 732.9152853776411, 15003.0, 15491.22543872806, 15499.84500154998, 15508.922455387707, 15514.689706205869, 13992.020558560906, 14145.222012789292, 14359.210243436606, 14368.066075705072, 14377.784333234984, 775.7633921653893, 937.9577918993627, 956.3879117364892, 956.4404823178448, 961.4904100826573, 756.1455555222591, 785.2657764989724, 795.9602019899011, 956.7321150077989, 960.8750862387915, 1003.3979612232675, 1007.1590222164465, 1008.4503945349802, 1012.5494155100984, 1014.8579198912158, 793.9007624046994, 1000.0999100809257, 1005.8642083318731, 1006.6376104602338, 1007.1741172238767, 603.423730337531, 604.066716922356, 604.0817956705827, 730.5762657658545, 755.1014292991323, 15056.774148387783, 15102.924485377613, 15110.39558417662, 15137.848621513755, 15170.772438413433, 12399.13206075575, 12437.564685235973, 12489.937550312281, 12493.937530312382, 12866.549670761571, 9945.5027248638, 10022.9498852506, 10126.0, 10326.48367581618, 10788.406518223659, 3529.5764508258917, 3538.6461353864665, 3553.4847447120283, 3736.4395340698843, 3773.2830762155104, 79230.60384698039, 79810.20189798086, 79869.60065199695, 79893.0, 79921.60039199825, 9489.715308540755, 9658.420494770337, 9843.901560984441, 9870.901290987142, 9917.702468925943, 21857.781422185893, 22125.66811497829, 22134.0, 22159.667604985938, 22185.889070554866, 7179.353858152791, 7374.631268436664, 7467.0, 7475.663595138232, 7548.207438219018, 4149.751014939114, 4200.5169405518145, 4244.575542445731, 4265.1043280910735, 4331.003869110123, 3516.701080408194, 3655.4882316475714, 3658.835352409148, 3660.7071434285194, 3662.6886714629554, 647.9352064793483, 657.7204688007578, 661.441082285468, 663.9966800166064, 668.345021878552, 518.142474205191, 594.46201187925, 616.7378863982879, 621.3072424246932, 629.6883042893705, 6608.570442921195, 7839.84320313602, 7927.0, 7941.9205807942335, 7970.402219833536, 504.7678068088647, 590.7577893063823, 591.9260092488439, 612.5558969746987, 616.140484024783, 3680.6135355787255, 3835.079580900564, 3853.5761066282685, 3871.0, 3897.8830635080994, 83606.581967091, 85692.57153714316, 85785.58584585712, 85818.57090714507, 86773.0, 58726.0, 66915.0, 72443.18892027636, 72640.0, 72785.0, 50680.746596266785, 56295.0, 59709.70145149333, 59988.0, 60409.69795150996, 7513.248675132443, 7569.735059272899, 7610.200928902385, 7625.771226863203, 7651.196624354363, 39387.0, 39790.00524986783, 40768.18463630651, 40774.9806254846, 42299.78850105853, 56941.0, 58189.70905145447, 58610.0, 60161.699191503765, 60832.479188020654, 10787.784244314913, 10873.293235939955, 11051.005409513182, 11729.47217375203, 11743.236689615147, 10768.246222764332, 11715.121365897421, 11974.880251197725, 12147.331896745764, 12375.257484550955, 9586.520673966133, 10839.512221950188, 11581.363025033705, 11607.129465290305, 11959.282443053444, 10327.277090603586, 11612.593559225386, 11652.126090543412, 11668.591599294323, 12401.069919755873, 10650.041496265063, 10952.507137179005, 10969.177311701815, 11185.440727963407, 11313.943430283125, 9479.383840050376, 9621.807563848824, 9708.805823883342, 9717.757056073655, 9842.212622990286, 9249.630014799333, 9747.512624368896, 9781.462019588706, 9825.4104753715, 9897.752556186153], "value": 6763.068558570689, "unit": "score"}], "name": "dromaeo_css", "value": 7201.589433927418, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 108.0, 110.0, 111.0, 111.0, 113.0, 117.0, 110.0, 110.0, 111.0], "value": 111.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 128.0, 140.0, 169.0, 113.0, 144.0, 142.0, 118.0, 170.0, 119.0], "value": 139.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 183.0, 184.0, 183.0, 184.0, 180.0, 184.0, 193.0, 217.0, 235.0], "value": 192.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 74.0, 84.0, 89.0, 56.0, 58.0, 58.0, 84.0, 114.0, 70.0], "value": 76.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 95.0, 134.0, 76.0, 78.0, 80.0, 122.0, 104.0, 114.0, 158.0], "value": 105.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 84.0, 88.0, 84.0, 90.0, 84.0, 86.0, 85.0, 87.0, 84.0], "value": 85.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 94.0, 94.0, 93.0, 93.0, 93.0, 94.0, 94.0, 92.0, 91.0], "value": 93.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 84.0, 87.0, 86.0, 85.0, 84.0, 85.0, 88.0, 84.0, 85.0], "value": 85.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 61.0, 61.0, 62.0, 58.0, 57.0, 60.0, 80.0, 57.0, 56.0], "value": 61.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 63.0, 71.0, 79.0, 69.0, 69.0, 68.0, 69.0, 67.0, 70.0], "value": 68.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 104.0, 112.0, 112.0, 112.0, 86.0, 86.0, 86.0, 85.0, 86.0], "value": 95.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 144.0, 146.0, 143.0, 144.0, 141.0, 145.0, 184.0, 244.0, 156.0], "value": 159.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 168.0, 170.0, 165.0, 168.0, 166.0, 168.0, 169.0, 176.0, 167.0], "value": 168.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 69.0, 71.0, 67.0, 69.0, 68.0, 70.0, 70.0, 66.0], "value": 68.5, "unit": "score"}], "name": "kraken", "value": 1511.1, "alertThreshold": 2.0}]} 05:14:26 INFO - Return code: 0 05:14:26 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 05:14:26 ERROR - # TBPL SUCCESS # 05:14:26 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:14:26 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:14:26 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:14:26 INFO - 2016-04-15 05:14:26.561 screenresolution[1681:9932] starting screenresolution argv=screenresolution get 05:14:26 INFO - 2016-04-15 05:14:26.564 screenresolution[1681:9932] Display 0: 1600x1200x32@60 05:14:26 INFO - 2016-04-15 05:14:26.570 screenresolution[1682:9935] starting screenresolution argv=screenresolution list 05:14:26 INFO - Available Modes on Display 0 05:14:26 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:14:26 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:14:26 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:14:26 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:14:26 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:14:26 INFO - Intel Iris: 05:14:26 INFO - Chipset Model: Intel Iris 05:14:26 INFO - Type: GPU 05:14:26 INFO - Bus: Built-In 05:14:26 INFO - VRAM (Dynamic, Max): 1536 MB 05:14:26 INFO - Vendor: Intel (0x8086) 05:14:26 INFO - Device ID: 0x0a2e 05:14:26 INFO - Revision ID: 0x0009 05:14:26 INFO - Displays: 05:14:26 INFO - Display: 05:14:26 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:14:26 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:14:26 INFO - Display Serial Number: 1600x1200 60 05:14:26 INFO - Main Display: Yes 05:14:26 INFO - Mirror: Off 05:14:26 INFO - Online: Yes 05:14:26 INFO - Rotation: Supported 05:14:26 INFO - Return code: 0 05:14:26 INFO - Running post-action listener: _resource_record_post_action 05:14:26 INFO - Running post-run listener: _resource_record_post_run 05:14:27 INFO - Total resource usage - Wall time: 1208s; CPU: 53.0%; Read bytes: 37787136; Write bytes: 692576256; Read time: 394; Write time: 1799 05:14:27 INFO - install - Wall time: 34s; CPU: 55.0%; Read bytes: 381626880; Write bytes: 375670784; Read time: 28206; Write time: 655 05:14:27 INFO - run-tests - Wall time: 1175s; CPU: 53.0%; Read bytes: 36849152; Write bytes: 296007680; Read time: 379; Write time: 1103 05:14:27 INFO - Running post-run listener: _upload_blobber_files 05:14:27 INFO - Blob upload gear active. 05:14:27 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:14:27 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 05:14:27 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'] 05:14:27 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 05:14:28 INFO - (blobuploader) - INFO - Open directory for files ... 05:14:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:14:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:14:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:14:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:14:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:14:29 INFO - (blobuploader) - INFO - Done attempting. 05:14:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:14:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:14:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:14:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:14:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:14:30 INFO - (blobuploader) - INFO - Done attempting. 05:14:30 INFO - (blobuploader) - INFO - Iteration through files over. 05:14:30 INFO - Return code: 0 05:14:30 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:14:30 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:14:30 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/dff56c824ccdcf4f700ebb263363299be43cc359e752ca20f138ad66d913ce418695d15664a8eb98cd1dd7173fd262fbe3e4a7289131937a5683b3c05d3a15d6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5b1290a3f79e37ac3d17bf931c4ddb7836a89b796b8a4ea6eb53fa4c5ebcafd9f69aadbf84b4232992eadfba5cc8bee733f545092c4073585a72ee8a35bb9625"} 05:14:30 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:14:30 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:14:30 INFO - Contents: 05:14:30 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/dff56c824ccdcf4f700ebb263363299be43cc359e752ca20f138ad66d913ce418695d15664a8eb98cd1dd7173fd262fbe3e4a7289131937a5683b3c05d3a15d6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5b1290a3f79e37ac3d17bf931c4ddb7836a89b796b8a4ea6eb53fa4c5ebcafd9f69aadbf84b4232992eadfba5cc8bee733f545092c4073585a72ee8a35bb9625"} 05:14:30 INFO - Running post-run listener: copy_logs_to_upload_dir 05:14:30 INFO - Copying logs to upload dir... 05:14:30 INFO - mkdir: /builds/slave/test/build/upload/logs 05:14:30 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1272.403332 ========= master_lag: 0.38 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2016-04-15 05:14:30.684870) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-15 05:14:30.688052) ========= 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.49TWEdDh20/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.yXApWZeoCA/Listeners TMPDIR=/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/dff56c824ccdcf4f700ebb263363299be43cc359e752ca20f138ad66d913ce418695d15664a8eb98cd1dd7173fd262fbe3e4a7289131937a5683b3c05d3a15d6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5b1290a3f79e37ac3d17bf931c4ddb7836a89b796b8a4ea6eb53fa4c5ebcafd9f69aadbf84b4232992eadfba5cc8bee733f545092c4073585a72ee8a35bb9625"} build_url:https://queue.taskcluster.net/v1/task/W3vucRKoRTycp-0zgffbdw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011329 build_url: 'https://queue.taskcluster.net/v1/task/W3vucRKoRTycp-0zgffbdw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/dff56c824ccdcf4f700ebb263363299be43cc359e752ca20f138ad66d913ce418695d15664a8eb98cd1dd7173fd262fbe3e4a7289131937a5683b3c05d3a15d6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5b1290a3f79e37ac3d17bf931c4ddb7836a89b796b8a4ea6eb53fa4c5ebcafd9f69aadbf84b4232992eadfba5cc8bee733f545092c4073585a72ee8a35bb9625"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-15 05:14:30.716298) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 05:14:30.716615) ========= 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.49TWEdDh20/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.yXApWZeoCA/Listeners TMPDIR=/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/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.004459 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 05:14:30.764493) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-15 05:14:30.764856) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-15 05:14:30.765293) ========= ========= Total master_lag: 0.81 =========