builder: mozilla-aurora_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0030 starttime: 1461616286.22 results: success (0) buildid: 20160425103006 builduid: 1a87fa8d522747ab8b0da4138352f4b4 revision: 0d6a91c76a9eddf2219caf028dea130f2d683ec2 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-25 13:31:26.215748) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-25 13:31:26.216158) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-25 13:31:26.216428) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-25 13:31:27.111876) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 13:31:27.112250) ========= 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.u0flkajzJ2/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.FYCdulBKvA/Listeners TMPDIR=/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/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-25 13:31:27-- 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% 159M=0s 2016-04-25 13:31:27 (159 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.102971 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 13:31:27.233612) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 13:31:27.233956) ========= 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.u0flkajzJ2/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.FYCdulBKvA/Listeners TMPDIR=/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/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.027408 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 13:31:27.282743) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-25 13:31:27.283188) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 0d6a91c76a9eddf2219caf028dea130f2d683ec2 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 0d6a91c76a9eddf2219caf028dea130f2d683ec2 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.u0flkajzJ2/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.FYCdulBKvA/Listeners TMPDIR=/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/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-25 13:31:27,349 truncating revision to first 12 chars 2016-04-25 13:31:27,349 Setting DEBUG logging. 2016-04-25 13:31:27,349 attempt 1/10 2016-04-25 13:31:27,349 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/0d6a91c76a9e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-25 13:31:29,038 unpacking tar archive at: mozilla-aurora-0d6a91c76a9e/testing/mozharness/ program finished with exit code 0 elapsedTime=1.940703 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-25 13:31:29.240602) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-25 13:31:29.243982) ========= script_repo_revision: 0d6a91c76a9eddf2219caf028dea130f2d683ec2 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-25 13:31:29.244418) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-25 13:31:29.244704) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-25 13:31:29.258690) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2016-04-25 13:31:29.259055) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.u0flkajzJ2/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.FYCdulBKvA/Listeners TMPDIR=/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 13:31:29 INFO - MultiFileLogger online at 20160425 13:31:29 in /builds/slave/test 13:31:29 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 13:31:29 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:31:29 INFO - {'append_to_log': False, 13:31:29 INFO - 'base_work_dir': '/builds/slave/test', 13:31:29 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 13:31:29 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:31:29 INFO - 'branch': 'Mozilla-Aurora', 13:31:29 INFO - 'buildbot_json_path': 'buildprops.json', 13:31:29 INFO - 'config_files': ('talos/mac_config.py',), 13:31:29 INFO - 'default_actions': ('clobber', 13:31:29 INFO - 'read-buildbot-config', 13:31:29 INFO - 'download-and-extract', 13:31:29 INFO - 'populate-webroot', 13:31:29 INFO - 'create-virtualenv', 13:31:29 INFO - 'install', 13:31:29 INFO - 'run-tests'), 13:31:29 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:31:29 INFO - 'download_minidump_stackwalk': True, 13:31:29 INFO - 'download_symbols': 'ondemand', 13:31:29 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:31:29 INFO - 'tooltool.py': '/tools/tooltool.py', 13:31:29 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:31:29 INFO - '/tools/misc-python/virtualenv.py')}, 13:31:29 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:31:29 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:31:29 INFO - 'installer_path': 'installer.exe', 13:31:29 INFO - 'log_level': 'info', 13:31:29 INFO - 'log_name': 'talos', 13:31:29 INFO - 'log_to_console': True, 13:31:29 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 13:31:29 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 13:31:29 INFO - 'opt_config_files': (), 13:31:29 INFO - 'pip_index': False, 13:31:29 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 13:31:29 INFO - 'cmd': ('bash', 13:31:29 INFO - '-c', 13:31:29 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 13:31:29 INFO - 'enabled': True, 13:31:29 INFO - 'halt_on_failure': False, 13:31:29 INFO - 'name': 'check_screen_resolution'},), 13:31:29 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 13:31:29 INFO - 'cmd': ('bash', 13:31:29 INFO - '-c', 13:31:29 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 13:31:29 INFO - 'enabled': True, 13:31:29 INFO - 'halt_on_failure': False, 13:31:29 INFO - 'name': 'check_screen_resolution'},), 13:31:29 INFO - 'run_cmd_checks_enabled': True, 13:31:29 INFO - 'sps_profile': False, 13:31:29 INFO - 'sps_profile_interval': 0, 13:31:29 INFO - 'suite': 'dromaeojs-e10s', 13:31:29 INFO - 'system_bits': '32', 13:31:29 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:31:29 INFO - 'title': 't-yosemite-r7-0030', 13:31:29 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:31:29 INFO - 'use_talos_json': True, 13:31:29 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:31:29 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:31:29 INFO - 'work_dir': 'build'} 13:31:29 INFO - ##### 13:31:29 INFO - ##### Running clobber step. 13:31:29 INFO - ##### 13:31:29 INFO - Running pre-action listener: _resource_record_pre_action 13:31:29 INFO - Running main action method: clobber 13:31:29 INFO - rmtree: /builds/slave/test/build 13:31:29 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:31:31 INFO - Running post-action listener: _resource_record_post_action 13:31:31 INFO - ##### 13:31:31 INFO - ##### Running read-buildbot-config step. 13:31:31 INFO - ##### 13:31:31 INFO - Running pre-action listener: _resource_record_pre_action 13:31:31 INFO - Running main action method: read_buildbot_config 13:31:31 INFO - Using buildbot properties: 13:31:31 INFO - { 13:31:31 INFO - "project": "", 13:31:31 INFO - "product": "firefox", 13:31:31 INFO - "script_repo_revision": "production", 13:31:31 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs-e10s", 13:31:31 INFO - "repository": "", 13:31:31 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs-e10s", 13:31:31 INFO - "buildid": "20160425103006", 13:31:31 INFO - "pgo_build": "False", 13:31:31 INFO - "basedir": "/builds/slave/test", 13:31:31 INFO - "buildnumber": 298, 13:31:31 INFO - "slavename": "t-yosemite-r7-0030", 13:31:31 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 13:31:31 INFO - "platform": "yosemite_r7", 13:31:31 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 13:31:31 INFO - "branch": "mozilla-aurora", 13:31:31 INFO - "repo_path": "releases/mozilla-aurora", 13:31:31 INFO - "revision": "0d6a91c76a9eddf2219caf028dea130f2d683ec2", 13:31:31 INFO - "stage_platform": "macosx64", 13:31:31 INFO - "builduid": "1a87fa8d522747ab8b0da4138352f4b4", 13:31:31 INFO - "slavebuilddir": "test" 13:31:31 INFO - } 13:31:31 INFO - Found installer url https://queue.taskcluster.net/v1/task/MTnAsegCRLKbQhmwYdMOFQ/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg. 13:31:31 INFO - Running post-action listener: _resource_record_post_action 13:31:31 INFO - ##### 13:31:31 INFO - ##### Running download-and-extract step. 13:31:31 INFO - ##### 13:31:31 INFO - Running pre-action listener: _resource_record_pre_action 13:31:31 INFO - Running main action method: download_and_extract 13:31:31 INFO - mkdir: /builds/slave/test/build/tests 13:31:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:31:31 INFO - https://queue.taskcluster.net/v1/task/MTnAsegCRLKbQhmwYdMOFQ/artifacts/public/build/firefox-48.0a2.en-US.mac.test_packages.json matches https://queue.taskcluster.net 13:31:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MTnAsegCRLKbQhmwYdMOFQ/artifacts/public/build/firefox-48.0a2.en-US.mac.test_packages.json 13:31:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MTnAsegCRLKbQhmwYdMOFQ/artifacts/public/build/firefox-48.0a2.en-US.mac.test_packages.json 13:31:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MTnAsegCRLKbQhmwYdMOFQ/artifacts/public/build/firefox-48.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-48.0a2.en-US.mac.test_packages.json 13:31:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MTnAsegCRLKbQhmwYdMOFQ/artifacts/public/build/firefox-48.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a2.en-US.mac.test_packages.json'}, attempt #1 13:31:32 INFO - Downloaded 1199 bytes. 13:31:32 INFO - Reading from file /builds/slave/test/build/firefox-48.0a2.en-US.mac.test_packages.json 13:31:32 INFO - Using the following test package requirements: 13:31:32 INFO - {u'common': [u'firefox-48.0a2.en-US.mac.common.tests.zip'], 13:31:32 INFO - u'cppunittest': [u'firefox-48.0a2.en-US.mac.common.tests.zip', 13:31:32 INFO - u'firefox-48.0a2.en-US.mac.cppunittest.tests.zip'], 13:31:32 INFO - u'gtest': [u'firefox-48.0a2.en-US.mac.common.tests.zip', 13:31:32 INFO - u'firefox-48.0a2.en-US.mac.gtest.tests.zip'], 13:31:32 INFO - u'jittest': [u'firefox-48.0a2.en-US.mac.common.tests.zip', 13:31:32 INFO - u'jsshell-mac.zip'], 13:31:32 INFO - u'mochitest': [u'firefox-48.0a2.en-US.mac.common.tests.zip', 13:31:32 INFO - u'firefox-48.0a2.en-US.mac.mochitest.tests.zip'], 13:31:32 INFO - u'mozbase': [u'firefox-48.0a2.en-US.mac.common.tests.zip'], 13:31:32 INFO - u'reftest': [u'firefox-48.0a2.en-US.mac.common.tests.zip', 13:31:32 INFO - u'firefox-48.0a2.en-US.mac.reftest.tests.zip'], 13:31:32 INFO - u'talos': [u'firefox-48.0a2.en-US.mac.common.tests.zip', 13:31:32 INFO - u'firefox-48.0a2.en-US.mac.talos.tests.zip'], 13:31:32 INFO - u'web-platform': [u'firefox-48.0a2.en-US.mac.common.tests.zip', 13:31:32 INFO - u'firefox-48.0a2.en-US.mac.web-platform.tests.zip'], 13:31:32 INFO - u'xpcshell': [u'firefox-48.0a2.en-US.mac.common.tests.zip', 13:31:32 INFO - u'firefox-48.0a2.en-US.mac.xpcshell.tests.zip']} 13:31:32 INFO - Downloading packages: [u'firefox-48.0a2.en-US.mac.common.tests.zip'] for test suite category: common 13:31:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:31:32 INFO - https://queue.taskcluster.net/v1/task/MTnAsegCRLKbQhmwYdMOFQ/artifacts/public/build/firefox-48.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 13:31:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MTnAsegCRLKbQhmwYdMOFQ/artifacts/public/build/firefox-48.0a2.en-US.mac.common.tests.zip 13:31:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MTnAsegCRLKbQhmwYdMOFQ/artifacts/public/build/firefox-48.0a2.en-US.mac.common.tests.zip 13:31:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MTnAsegCRLKbQhmwYdMOFQ/artifacts/public/build/firefox-48.0a2.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.mac.common.tests.zip 13:31:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MTnAsegCRLKbQhmwYdMOFQ/artifacts/public/build/firefox-48.0a2.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.mac.common.tests.zip'}, attempt #1 13:31:34 INFO - Downloaded 18109567 bytes. 13:31:34 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 13:31:34 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 13:31:37 INFO - Return code: 0 13:31:37 INFO - Downloading packages: [u'firefox-48.0a2.en-US.mac.common.tests.zip', u'firefox-48.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 13:31:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:31:37 INFO - https://queue.taskcluster.net/v1/task/MTnAsegCRLKbQhmwYdMOFQ/artifacts/public/build/firefox-48.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 13:31:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MTnAsegCRLKbQhmwYdMOFQ/artifacts/public/build/firefox-48.0a2.en-US.mac.common.tests.zip 13:31:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MTnAsegCRLKbQhmwYdMOFQ/artifacts/public/build/firefox-48.0a2.en-US.mac.common.tests.zip 13:31:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MTnAsegCRLKbQhmwYdMOFQ/artifacts/public/build/firefox-48.0a2.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.mac.common.tests.zip 13:31:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MTnAsegCRLKbQhmwYdMOFQ/artifacts/public/build/firefox-48.0a2.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.mac.common.tests.zip'}, attempt #1 13:31:38 INFO - Downloaded 18109567 bytes. 13:31:38 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 13:31:38 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 13:31:41 INFO - Return code: 0 13:31:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:31:41 INFO - https://queue.taskcluster.net/v1/task/MTnAsegCRLKbQhmwYdMOFQ/artifacts/public/build/firefox-48.0a2.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 13:31:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MTnAsegCRLKbQhmwYdMOFQ/artifacts/public/build/firefox-48.0a2.en-US.mac.talos.tests.zip 13:31:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MTnAsegCRLKbQhmwYdMOFQ/artifacts/public/build/firefox-48.0a2.en-US.mac.talos.tests.zip 13:31:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MTnAsegCRLKbQhmwYdMOFQ/artifacts/public/build/firefox-48.0a2.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.mac.talos.tests.zip 13:31:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MTnAsegCRLKbQhmwYdMOFQ/artifacts/public/build/firefox-48.0a2.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.mac.talos.tests.zip'}, attempt #1 13:31:42 INFO - Downloaded 10840145 bytes. 13:31:42 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 13:31:42 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 13:31:43 INFO - Return code: 0 13:31:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:31:43 INFO - https://queue.taskcluster.net/v1/task/MTnAsegCRLKbQhmwYdMOFQ/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg matches https://queue.taskcluster.net 13:31:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MTnAsegCRLKbQhmwYdMOFQ/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg 13:31:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MTnAsegCRLKbQhmwYdMOFQ/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg 13:31:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MTnAsegCRLKbQhmwYdMOFQ/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0a2.en-US.mac.dmg 13:31:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MTnAsegCRLKbQhmwYdMOFQ/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-48.0a2.en-US.mac.dmg'}, attempt #1 13:31:46 INFO - Downloaded 114074910 bytes. 13:31:46 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/MTnAsegCRLKbQhmwYdMOFQ/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg 13:31:46 INFO - mkdir: /builds/slave/test/properties 13:31:46 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:31:46 INFO - Writing to file /builds/slave/test/properties/build_url 13:31:46 INFO - Contents: 13:31:46 INFO - build_url:https://queue.taskcluster.net/v1/task/MTnAsegCRLKbQhmwYdMOFQ/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg 13:31:47 INFO - Running post-action listener: _resource_record_post_action 13:31:47 INFO - Running post-action listener: set_extra_try_arguments 13:31:47 INFO - ##### 13:31:47 INFO - ##### Running populate-webroot step. 13:31:47 INFO - ##### 13:31:47 INFO - Running pre-action listener: _resource_record_pre_action 13:31:47 INFO - Running main action method: populate_webroot 13:31:47 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:31:47 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:31:47 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:31:47 INFO - '--tppagecycles', 13:31:47 INFO - '7'], 13:31:47 INFO - 'tests': ['tsvgm']}}, 13:31:47 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:31:47 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:31:47 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:31:47 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:31:47 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:31:47 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:31:47 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:31:47 INFO - 'talos_options': ['--disable-e10s'], 13:31:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:31:47 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:31:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:31:47 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:31:47 INFO - 'talos_options': ['--disable-e10s'], 13:31:47 INFO - 'tests': ['damp', 'tps']}, 13:31:47 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:31:47 INFO - 'tests': ['damp', 'tps']}, 13:31:47 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:31:47 INFO - 'tests': ['dromaeo_dom']}, 13:31:47 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:31:47 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:31:47 INFO - 'tests': ['a11yr', 13:31:47 INFO - 'ts_paint', 13:31:47 INFO - 'tpaint', 13:31:47 INFO - 'sessionrestore', 13:31:47 INFO - 'sessionrestore_no_auto_restore', 13:31:47 INFO - 'tabpaint']}, 13:31:47 INFO - 'other-e10s': {'tests': ['a11yr', 13:31:47 INFO - 'ts_paint', 13:31:47 INFO - 'tpaint', 13:31:47 INFO - 'sessionrestore', 13:31:47 INFO - 'sessionrestore_no_auto_restore', 13:31:47 INFO - 'tabpaint']}, 13:31:47 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:31:47 INFO - 'ts_paint', 13:31:47 INFO - 'tpaint', 13:31:47 INFO - 'sessionrestore', 13:31:47 INFO - 'sessionrestore_no_auto_restore', 13:31:47 INFO - 'tabpaint']}, 13:31:47 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:31:47 INFO - 'ts_paint', 13:31:47 INFO - 'tpaint', 13:31:47 INFO - 'sessionrestore', 13:31:47 INFO - 'sessionrestore_no_auto_restore', 13:31:47 INFO - 'tabpaint']}, 13:31:47 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:31:47 INFO - 'tests': ['a11yr', 13:31:47 INFO - 'ts_paint', 13:31:47 INFO - 'tpaint', 13:31:47 INFO - 'sessionrestore', 13:31:47 INFO - 'sessionrestore_no_auto_restore', 13:31:47 INFO - 'tabpaint']}, 13:31:47 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:31:47 INFO - 'tests': ['a11yr', 13:31:47 INFO - 'ts_paint', 13:31:47 INFO - 'tpaint', 13:31:47 INFO - 'sessionrestore', 13:31:47 INFO - 'sessionrestore_no_auto_restore', 13:31:47 INFO - 'tabpaint']}, 13:31:47 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:31:47 INFO - 'tests': ['tsvgx', 13:31:47 INFO - 'tsvgr_opacity', 13:31:47 INFO - 'tart', 13:31:47 INFO - 'tscrollx', 13:31:47 INFO - 'cart']}, 13:31:47 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:31:47 INFO - 'tsvgr_opacity', 13:31:47 INFO - 'tart', 13:31:47 INFO - 'tscrollx', 13:31:47 INFO - 'cart']}, 13:31:47 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:31:47 INFO - 'talos_options': ['--disable-e10s'], 13:31:47 INFO - 'tests': ['tp5o']}, 13:31:47 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:31:47 INFO - 'tests': ['tp5o']}, 13:31:47 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:31:47 INFO - 'talos_options': ['--disable-e10s', 13:31:47 INFO - '--xperf_path', 13:31:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:31:47 INFO - 'tests': ['tp5n']}, 13:31:47 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:31:47 INFO - 'talos_options': ['--xperf_path', 13:31:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:31:47 INFO - 'tests': ['tp5n']}}, 13:31:47 INFO - 'talos.zip': {'path': '', 13:31:47 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:31:47 INFO - Running post-action listener: _resource_record_post_action 13:31:47 INFO - ##### 13:31:47 INFO - ##### Running create-virtualenv step. 13:31:47 INFO - ##### 13:31:47 INFO - Running pre-action listener: _resource_record_pre_action 13:31:47 INFO - Running main action method: create_virtualenv 13:31:47 INFO - Creating virtualenv /builds/slave/test/build/venv 13:31:47 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 13:31:47 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:31:47 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:31:47 INFO - Using real prefix '/tools/python27' 13:31:47 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:31:47 INFO - Installing distribute.............................................................................................................................................................................................done. 13:31:50 INFO - Installing pip.................done. 13:31:50 INFO - Return code: 0 13:31:50 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:31:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:31:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:31:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:31:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:31:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:31:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:31:50 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 0x1013eda30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1013fd420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe470c77a20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10128ce00>, '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 0x1010f5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101287b20>, '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.u0flkajzJ2/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.FYCdulBKvA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 13:31:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 13:31:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 13:31:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.u0flkajzJ2/Render', 13:31:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:31:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:31:50 INFO - 'HOME': '/Users/cltbld', 13:31:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:31:50 INFO - 'LOGNAME': 'cltbld', 13:31:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:31:50 INFO - 'MOZ_NO_REMOTE': '1', 13:31:50 INFO - 'NO_EM_RESTART': '1', 13:31:50 INFO - 'PAGER': '/bin/cat', 13:31:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:31:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:31:50 INFO - 'PWD': '/builds/slave/test', 13:31:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:31:50 INFO - 'SHELL': '/bin/bash', 13:31:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FYCdulBKvA/Listeners', 13:31:50 INFO - 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/', 13:31:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:31:50 INFO - 'USER': 'cltbld', 13:31:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:31:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:31:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:31:50 INFO - 'XPC_FLAGS': '0x0', 13:31:50 INFO - 'XPC_SERVICE_NAME': '0', 13:31:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:31:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:31:51 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 13:31:51 INFO - Cleaning up... 13:31:51 INFO - Return code: 0 13:31:51 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 13:31: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')]} 13:31:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:31:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:31: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')]} 13:31:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:31:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:31: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', '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 0x1013eda30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1013fd420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe470c77a20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10128ce00>, '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 0x1010f5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101287b20>, '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.u0flkajzJ2/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.FYCdulBKvA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 13:31: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', 'psutil>=0.7.1'] in /builds/slave/test/build 13:31: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 psutil>=0.7.1 13:31:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.u0flkajzJ2/Render', 13:31:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:31:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:31:51 INFO - 'HOME': '/Users/cltbld', 13:31:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:31:51 INFO - 'LOGNAME': 'cltbld', 13:31:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:31:51 INFO - 'MOZ_NO_REMOTE': '1', 13:31:51 INFO - 'NO_EM_RESTART': '1', 13:31:51 INFO - 'PAGER': '/bin/cat', 13:31:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:31:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:31:51 INFO - 'PWD': '/builds/slave/test', 13:31:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:31:51 INFO - 'SHELL': '/bin/bash', 13:31:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FYCdulBKvA/Listeners', 13:31:51 INFO - 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/', 13:31:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:31:51 INFO - 'USER': 'cltbld', 13:31:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:31:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:31:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:31:51 INFO - 'XPC_FLAGS': '0x0', 13:31:51 INFO - 'XPC_SERVICE_NAME': '0', 13:31:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:31:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:31:51 INFO - Downloading/unpacking psutil>=0.7.1 13:31: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 13:31: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 13:31: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 13:31: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 13:31: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 13:31: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 13:31:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:31:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:31:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:31:54 INFO - Installing collected packages: psutil 13:31:54 INFO - Running setup.py install for psutil 13:31:54 INFO - building 'psutil._psutil_osx' extension 13:31:54 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 13:31:54 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 13:31:55 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 13:31:55 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 13:31:55 INFO - building 'psutil._psutil_posix' extension 13:31:55 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 13:31:55 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 13:31:55 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 13:31:55 INFO - ^ 13:31:55 INFO - 1 warning generated. 13:31:55 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 13:31:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:31:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:31:55 INFO - Successfully installed psutil 13:31:55 INFO - Cleaning up... 13:31:55 INFO - Return code: 0 13:31:55 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 13:31:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:31:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:31:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:31:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:31:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:31:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:31:55 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 0x1013eda30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1013fd420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe470c77a20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10128ce00>, '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 0x1010f5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101287b20>, '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.u0flkajzJ2/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.FYCdulBKvA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 13:31:55 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 13:31:55 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 13:31:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.u0flkajzJ2/Render', 13:31:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:31:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:31:55 INFO - 'HOME': '/Users/cltbld', 13:31:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:31:55 INFO - 'LOGNAME': 'cltbld', 13:31:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:31:55 INFO - 'MOZ_NO_REMOTE': '1', 13:31:55 INFO - 'NO_EM_RESTART': '1', 13:31:55 INFO - 'PAGER': '/bin/cat', 13:31:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:31:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:31:55 INFO - 'PWD': '/builds/slave/test', 13:31:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:31:55 INFO - 'SHELL': '/bin/bash', 13:31:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FYCdulBKvA/Listeners', 13:31:55 INFO - 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/', 13:31:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:31:55 INFO - 'USER': 'cltbld', 13:31:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:31:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:31:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:31:55 INFO - 'XPC_FLAGS': '0x0', 13:31:55 INFO - 'XPC_SERVICE_NAME': '0', 13:31:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:31:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:31:56 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 13:31:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:31:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:31:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:31:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:31:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:31:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:31:58 INFO - Downloading mozsystemmonitor-0.0.tar.gz 13:31:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:31:59 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 13:31:59 INFO - Installing collected packages: mozsystemmonitor 13:31:59 INFO - Running setup.py install for mozsystemmonitor 13:31:59 INFO - Successfully installed mozsystemmonitor 13:31:59 INFO - Cleaning up... 13:31:59 INFO - Return code: 0 13:31:59 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:31: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')]} 13:31:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:31:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:31: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')]} 13:31:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:31:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:31:59 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 0x1013eda30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1013fd420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe470c77a20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10128ce00>, '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 0x1010f5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101287b20>, '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.u0flkajzJ2/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.FYCdulBKvA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 13:31:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 13:31:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 13:31:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.u0flkajzJ2/Render', 13:31:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:31:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:31:59 INFO - 'HOME': '/Users/cltbld', 13:31:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:31:59 INFO - 'LOGNAME': 'cltbld', 13:31:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:31:59 INFO - 'MOZ_NO_REMOTE': '1', 13:31:59 INFO - 'NO_EM_RESTART': '1', 13:31:59 INFO - 'PAGER': '/bin/cat', 13:31:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:31:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:31:59 INFO - 'PWD': '/builds/slave/test', 13:31:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:31:59 INFO - 'SHELL': '/bin/bash', 13:31:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FYCdulBKvA/Listeners', 13:31:59 INFO - 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/', 13:31:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:31:59 INFO - 'USER': 'cltbld', 13:31:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:31:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:31:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:31:59 INFO - 'XPC_FLAGS': '0x0', 13:31:59 INFO - 'XPC_SERVICE_NAME': '0', 13:31:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:31:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:31:59 INFO - Downloading/unpacking blobuploader==1.2.4 13:31:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:31:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:31:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:31:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:31:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:31:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:32:02 INFO - Downloading blobuploader-1.2.4.tar.gz 13:32:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:32:02 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:32:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:32:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:32:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:32:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:32:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:32:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:32:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:32:02 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:32:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:32:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:32:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:32:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:32:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:32:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:32:03 INFO - Downloading docopt-0.6.1.tar.gz 13:32:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:32:03 INFO - Installing collected packages: blobuploader, requests, docopt 13:32:03 INFO - Running setup.py install for blobuploader 13:32:03 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:32:03 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:32:03 INFO - Running setup.py install for requests 13:32:03 INFO - Running setup.py install for docopt 13:32:04 INFO - Successfully installed blobuploader requests docopt 13:32:04 INFO - Cleaning up... 13:32:04 INFO - Return code: 0 13:32:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:32:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:32:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:32:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:32:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:32:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:32:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:32:04 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 0x1013eda30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1013fd420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe470c77a20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10128ce00>, '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 0x1010f5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101287b20>, '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.u0flkajzJ2/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.FYCdulBKvA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 13:32:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 13:32:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 13:32:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.u0flkajzJ2/Render', 13:32:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:32:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:32:04 INFO - 'HOME': '/Users/cltbld', 13:32:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:32:04 INFO - 'LOGNAME': 'cltbld', 13:32:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:32:04 INFO - 'MOZ_NO_REMOTE': '1', 13:32:04 INFO - 'NO_EM_RESTART': '1', 13:32:04 INFO - 'PAGER': '/bin/cat', 13:32:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:32:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:32:04 INFO - 'PWD': '/builds/slave/test', 13:32:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:32:04 INFO - 'SHELL': '/bin/bash', 13:32:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FYCdulBKvA/Listeners', 13:32:04 INFO - 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/', 13:32:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:32:04 INFO - 'USER': 'cltbld', 13:32:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:32:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:32:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:32:04 INFO - 'XPC_FLAGS': '0x0', 13:32:04 INFO - 'XPC_SERVICE_NAME': '0', 13:32:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:32:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:32:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:32:04 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-42m5ks-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:32:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:32:04 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-HDtMto-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:32:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:32:04 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-co0UIH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:32:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:32:04 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-6Nj_ot-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:32:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:32:04 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-uV5ade-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:32:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:32:04 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-z1vtzb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:32:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:32:05 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-blib6k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:32:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:32:05 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-PTolJy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:32:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:32:05 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-ILiE2h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:32:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:32:05 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-bkuPdn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:32:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:32:05 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-dB5gNp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:32:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:32:05 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-QOYydx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:32:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:32:05 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-YTTnLg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:32:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:32:05 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-0qpnRd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:32:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:32:05 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-pTYdir-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:32:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:32:05 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-Qv6w5y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:32:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:32:06 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-nN9oGn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:32:06 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:32:06 INFO - Running setup.py install for manifestparser 13:32:06 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:32:06 INFO - Running setup.py install for mozcrash 13:32:06 INFO - Running setup.py install for mozdebug 13:32:06 INFO - Running setup.py install for mozdevice 13:32:06 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:32:06 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:32:06 INFO - Running setup.py install for mozfile 13:32:06 INFO - Running setup.py install for mozhttpd 13:32:06 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:32:07 INFO - Running setup.py install for mozinfo 13:32:07 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:32:07 INFO - Running setup.py install for mozInstall 13:32:07 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:32:07 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:32:07 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:32:07 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:32:07 INFO - Running setup.py install for mozleak 13:32:07 INFO - Running setup.py install for mozlog 13:32:07 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:32:07 INFO - Running setup.py install for moznetwork 13:32:07 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:32:07 INFO - Running setup.py install for mozprocess 13:32:07 INFO - Running setup.py install for mozprofile 13:32:08 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:32:08 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:32:08 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:32:08 INFO - Running setup.py install for mozrunner 13:32:08 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:32:08 INFO - Running setup.py install for mozscreenshot 13:32:08 INFO - Running setup.py install for moztest 13:32:08 INFO - Running setup.py install for mozversion 13:32:08 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:32:08 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:32:08 INFO - Cleaning up... 13:32:08 INFO - Return code: 0 13:32:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:32:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:32:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:32:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:32:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:32:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:32:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:32:08 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 0x1013eda30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1013fd420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe470c77a20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10128ce00>, '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 0x1010f5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101287b20>, '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.u0flkajzJ2/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.FYCdulBKvA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 13:32:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 13:32:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 13:32:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.u0flkajzJ2/Render', 13:32:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:32:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:32:08 INFO - 'HOME': '/Users/cltbld', 13:32:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:32:08 INFO - 'LOGNAME': 'cltbld', 13:32:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:32:08 INFO - 'MOZ_NO_REMOTE': '1', 13:32:08 INFO - 'NO_EM_RESTART': '1', 13:32:08 INFO - 'PAGER': '/bin/cat', 13:32:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:32:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:32:08 INFO - 'PWD': '/builds/slave/test', 13:32:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:32:08 INFO - 'SHELL': '/bin/bash', 13:32:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FYCdulBKvA/Listeners', 13:32:08 INFO - 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/', 13:32:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:32:08 INFO - 'USER': 'cltbld', 13:32:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:32:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:32:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:32:08 INFO - 'XPC_FLAGS': '0x0', 13:32:08 INFO - 'XPC_SERVICE_NAME': '0', 13:32:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:32:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:32:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:32:08 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-8yrFvn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:32:09 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 13:32:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:32:09 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-dd_XcM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:32:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 13:32:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:32:09 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-KcDtZ6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:32:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 13:32:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:32:09 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-8_aJPZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:32:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 13:32:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:32:09 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-XnwBxR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:32:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 13:32:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:32:09 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-OHD84r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:32:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 13:32:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:32:09 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-yb4p_W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:32:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 13:32:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:32:09 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-ojDhs3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:32:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 13:32:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:32:09 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-Wa2VcR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:32:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 13:32:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:32:09 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-42ncBH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:32:09 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)) 13:32:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:32:09 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-JrW306-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:32:10 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 13:32:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:32:10 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-G7tuvW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:32:10 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)) 13:32:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:32:10 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-E78foE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:32:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 13:32:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:32:10 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-2dMl57-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:32:10 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)) 13:32:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:32:10 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-IqGzSa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:32:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 13:32:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:32:10 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-2prBYr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:32:10 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 13:32:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:32:10 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-M59u40-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:32:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 13:32:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 13:32:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 13:32:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 13:32:10 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 13:32:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 13:32:10 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:32: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 13:32: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 13:32: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 13:32: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 13:32: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 13:32: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 13:32:13 INFO - Downloading blessings-1.6.tar.gz 13:32:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:32:13 INFO - Installing collected packages: blessings 13:32:13 INFO - Running setup.py install for blessings 13:32:13 INFO - Successfully installed blessings 13:32:13 INFO - Cleaning up... 13:32:13 INFO - Return code: 0 13:32:13 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:32:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:32:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:32:13 INFO - Reading from file tmpfile_stdout 13:32:13 INFO - Current package versions: 13:32:13 INFO - blessings == 1.6 13:32:13 INFO - blobuploader == 1.2.4 13:32:13 INFO - docopt == 0.6.1 13:32:13 INFO - manifestparser == 1.1 13:32:13 INFO - mozInstall == 1.12 13:32:13 INFO - mozcrash == 0.17 13:32:13 INFO - mozdebug == 0.1 13:32:13 INFO - mozdevice == 0.48 13:32:13 INFO - mozfile == 1.2 13:32:13 INFO - mozhttpd == 0.7 13:32:13 INFO - mozinfo == 0.9 13:32:13 INFO - mozleak == 0.1 13:32:13 INFO - mozlog == 3.1 13:32:13 INFO - moznetwork == 0.27 13:32:13 INFO - mozprocess == 0.22 13:32:13 INFO - mozprofile == 0.28 13:32:13 INFO - mozrunner == 6.11 13:32:13 INFO - mozscreenshot == 0.1 13:32:13 INFO - mozsystemmonitor == 0.0 13:32:13 INFO - moztest == 0.7 13:32:13 INFO - mozversion == 1.4 13:32:13 INFO - psutil == 3.1.1 13:32:13 INFO - requests == 1.2.3 13:32:13 INFO - wsgiref == 0.1.2 13:32:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:32: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')]} 13:32:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:32:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:32: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')]} 13:32:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:32:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:32:13 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 0x1013eda30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1013fd420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe470c77a20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10128ce00>, '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 0x1010f5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101287b20>, '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.u0flkajzJ2/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.FYCdulBKvA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 13:32:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 13:32:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 13:32:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.u0flkajzJ2/Render', 13:32:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:32:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:32:13 INFO - 'HOME': '/Users/cltbld', 13:32:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:32:13 INFO - 'LOGNAME': 'cltbld', 13:32:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:32:13 INFO - 'MOZ_NO_REMOTE': '1', 13:32:13 INFO - 'NO_EM_RESTART': '1', 13:32:13 INFO - 'PAGER': '/bin/cat', 13:32:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:32:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:32:13 INFO - 'PWD': '/builds/slave/test', 13:32:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:32:13 INFO - 'SHELL': '/bin/bash', 13:32:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FYCdulBKvA/Listeners', 13:32:13 INFO - 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/', 13:32:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:32:13 INFO - 'USER': 'cltbld', 13:32:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:32:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:32:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:32:13 INFO - 'XPC_FLAGS': '0x0', 13:32:13 INFO - 'XPC_SERVICE_NAME': '0', 13:32:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:32:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:32:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 13:32:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 13:32:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 13:32:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 13:32:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 13:32:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 13:32:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 13:32:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 13:32:14 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 13:32:14 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 13:32:14 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 13:32:14 INFO - Cleaning up... 13:32:14 INFO - Return code: 0 13:32:14 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:32:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:32:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:32:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:32:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:32:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:32:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:32:14 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 0x1013eda30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1013fd420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe470c77a20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10128ce00>, '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 0x1010f5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101287b20>, '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.u0flkajzJ2/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.FYCdulBKvA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 13:32:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 13:32:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 13:32:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.u0flkajzJ2/Render', 13:32:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:32:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:32:14 INFO - 'HOME': '/Users/cltbld', 13:32:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:32:14 INFO - 'LOGNAME': 'cltbld', 13:32:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:32:14 INFO - 'MOZ_NO_REMOTE': '1', 13:32:14 INFO - 'NO_EM_RESTART': '1', 13:32:14 INFO - 'PAGER': '/bin/cat', 13:32:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:32:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:32:14 INFO - 'PWD': '/builds/slave/test', 13:32:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:32:14 INFO - 'SHELL': '/bin/bash', 13:32:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FYCdulBKvA/Listeners', 13:32:14 INFO - 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/', 13:32:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:32:14 INFO - 'USER': 'cltbld', 13:32:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:32:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:32:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:32:14 INFO - 'XPC_FLAGS': '0x0', 13:32:14 INFO - 'XPC_SERVICE_NAME': '0', 13:32:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:32:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:32:14 INFO - Downloading/unpacking jsonschema 13:32:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:32:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:32:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:32:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:32:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:32:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:32:16 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:32:16 INFO - Downloading/unpacking functools32 (from jsonschema) 13:32:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:32:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:32:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:32:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:32:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:32:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:32:17 INFO - Downloading functools32-3.2.3-2.tar.gz 13:32:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:32:17 INFO - warning: no files found matching '*.txt' 13:32:17 INFO - no previously-included directories found matching 'build' 13:32:17 INFO - no previously-included directories found matching 'dist' 13:32:17 INFO - no previously-included directories found matching '.git*' 13:32:17 INFO - Installing collected packages: jsonschema, functools32 13:32:17 INFO - Running setup.py install for functools32 13:32:17 INFO - warning: no files found matching '*.txt' 13:32:17 INFO - no previously-included directories found matching 'build' 13:32:17 INFO - no previously-included directories found matching 'dist' 13:32:17 INFO - no previously-included directories found matching '.git*' 13:32:17 INFO - Successfully installed jsonschema functools32 13:32:17 INFO - Cleaning up... 13:32:17 INFO - Return code: 0 13:32:17 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 13:32:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:32:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:32:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:32:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:32:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:32:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:32:17 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 0x1013eda30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1013fd420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe470c77a20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10128ce00>, '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 0x1010f5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101287b20>, '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.u0flkajzJ2/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.FYCdulBKvA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 13:32:17 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 13:32:17 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 13:32:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.u0flkajzJ2/Render', 13:32:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:32:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:32:17 INFO - 'HOME': '/Users/cltbld', 13:32:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:32:17 INFO - 'LOGNAME': 'cltbld', 13:32:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:32:17 INFO - 'MOZ_NO_REMOTE': '1', 13:32:17 INFO - 'NO_EM_RESTART': '1', 13:32:17 INFO - 'PAGER': '/bin/cat', 13:32:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:32:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:32:17 INFO - 'PWD': '/builds/slave/test', 13:32:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:32:17 INFO - 'SHELL': '/bin/bash', 13:32:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FYCdulBKvA/Listeners', 13:32:17 INFO - 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/', 13:32:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:32:17 INFO - 'USER': 'cltbld', 13:32:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:32:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:32:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:32:17 INFO - 'XPC_FLAGS': '0x0', 13:32:17 INFO - 'XPC_SERVICE_NAME': '0', 13:32:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:32:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:32:17 INFO - Downloading/unpacking flake8 13:32:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:32:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:32:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:32:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:32:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:32:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:32:20 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 13:32:20 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 13:32:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:32:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:32:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:32:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:32:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:32:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:32:20 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 13:32:20 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 13:32:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:32:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:32:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:32:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:32:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:32:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:32:21 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 13:32:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:32:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:32:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:32:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:32:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:32:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:32:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 13:32:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:32:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:32:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:32:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:32:21 INFO - no previously-included directories found matching 'docs/_build' 13:32:21 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 13:32:21 INFO - Running setup.py install for pep8 13:32:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:32:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:32:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:32:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:32:21 INFO - no previously-included directories found matching 'docs/_build' 13:32:21 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 13:32:21 INFO - Successfully installed flake8 mccabe pyflakes pep8 13:32:21 INFO - Cleaning up... 13:32:21 INFO - Return code: 0 13:32:21 INFO - Running post-action listener: _resource_record_post_action 13:32:21 INFO - Running post-action listener: _start_resource_monitoring 13:32:21 INFO - Starting resource monitoring. 13:32:21 INFO - ##### 13:32:21 INFO - ##### Running install step. 13:32:21 INFO - ##### 13:32:21 INFO - Running pre-action listener: _resource_record_pre_action 13:32:21 INFO - Running main action method: install 13:32:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:32:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:32:22 INFO - Reading from file tmpfile_stdout 13:32:22 INFO - Detecting whether we're running mozinstall >=1.0... 13:32:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:32:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:32:22 INFO - Reading from file tmpfile_stdout 13:32:22 INFO - Output received: 13:32:22 INFO - Usage: mozinstall [options] installer 13:32:22 INFO - Options: 13:32:22 INFO - -h, --help show this help message and exit 13:32:22 INFO - -d DEST, --destination=DEST 13:32:22 INFO - Directory to install application into. [default: 13:32:22 INFO - "/builds/slave/test"] 13:32:22 INFO - --app=APP Application being installed. [default: firefox] 13:32:22 INFO - mkdir: /builds/slave/test/build/application 13:32:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 13:32:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 13:32:54 INFO - Reading from file tmpfile_stdout 13:32:54 INFO - Output received: 13:32:54 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 13:32:54 INFO - Running post-action listener: _resource_record_post_action 13:32:54 INFO - ##### 13:32:54 INFO - ##### Running run-tests step. 13:32:54 INFO - ##### 13:32:54 INFO - Running pre-action listener: _resource_record_pre_action 13:32:54 INFO - Running main action method: run_tests 13:32:54 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 13:32:54 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 13:32:54 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 13:32:54 INFO - 2016-04-25 13:32:54.089 screenresolution[1647:7541] starting screenresolution argv=screenresolution get 13:32:54 INFO - 2016-04-25 13:32:54.091 screenresolution[1647:7541] Display 0: 1600x1200x32@60 13:32:54 INFO - 2016-04-25 13:32:54.097 screenresolution[1648:7543] starting screenresolution argv=screenresolution list 13:32:54 INFO - Available Modes on Display 0 13:32:54 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 13:32:54 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 13:32:54 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 13:32:54 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 13:32:54 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 13:32:54 INFO - Intel Iris: 13:32:54 INFO - Chipset Model: Intel Iris 13:32:54 INFO - Type: GPU 13:32:54 INFO - Bus: Built-In 13:32:54 INFO - VRAM (Dynamic, Max): 1536 MB 13:32:54 INFO - Vendor: Intel (0x8086) 13:32:54 INFO - Device ID: 0x0a2e 13:32:54 INFO - Revision ID: 0x0009 13:32:54 INFO - Displays: 13:32:54 INFO - Display: 13:32:54 INFO - Resolution: 1600 x 1200 @ 60 Hz 13:32:54 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 13:32:54 INFO - Display Serial Number: 1600x1200 60 13:32:54 INFO - Main Display: Yes 13:32:54 INFO - Mirror: Off 13:32:54 INFO - Online: Yes 13:32:54 INFO - Rotation: Supported 13:32:54 INFO - Return code: 0 13:32:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:32:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:32:54 INFO - Python 2.7.3 13:32:54 INFO - Return code: 0 13:32:54 INFO - grabbing minidump binary from tooltool 13:32: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')]} 13:32:54 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 0x10128ce00>, '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 0x1010f5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101287b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:32:54 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 13:32:54 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 13:32:54 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:32:54 INFO - Return code: 0 13:32:54 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 13:32:54 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:32:54 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:32:54 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 13:32:54 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:32:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 13:32:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 13:32:55 INFO - Return code: 0 13:32:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/MTnAsegCRLKbQhmwYdMOFQ/artifacts/public/build/firefox-48.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0030', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 13:32:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/MTnAsegCRLKbQhmwYdMOFQ/artifacts/public/build/firefox-48.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0030 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 13:32:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.u0flkajzJ2/Render', 13:32:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:32:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:32:55 INFO - 'HOME': '/Users/cltbld', 13:32:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:32:55 INFO - 'LOGNAME': 'cltbld', 13:32:55 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:32:55 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 13:32:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:32:55 INFO - 'MOZ_NO_REMOTE': '1', 13:32:55 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:32:55 INFO - 'NO_EM_RESTART': '1', 13:32:55 INFO - 'PAGER': '/bin/cat', 13:32:55 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:32:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:32:55 INFO - 'PWD': '/builds/slave/test', 13:32:55 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:32:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:32:55 INFO - 'SHELL': '/bin/bash', 13:32:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FYCdulBKvA/Listeners', 13:32:55 INFO - 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/', 13:32:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:32:55 INFO - 'USER': 'cltbld', 13:32:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:32:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:32:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:32:55 INFO - 'XPC_FLAGS': '0x0', 13:32:55 INFO - 'XPC_SERVICE_NAME': '0', 13:32:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:32:55 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/MTnAsegCRLKbQhmwYdMOFQ/artifacts/public/build/firefox-48.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0030', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 13:32:55 INFO - mozversion application_buildid: 20160425103006 13:32:55 INFO - mozversion application_changeset: 0d6a91c76a9eddf2219caf028dea130f2d683ec2 13:32:55 INFO - mozversion application_display_name: FirefoxDeveloperEdition 13:32:55 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:32:55 INFO - mozversion application_name: Firefox 13:32:55 INFO - mozversion application_remotingname: firefox-dev 13:32:55 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 13:32:55 INFO - mozversion application_vendor: Mozilla 13:32:55 INFO - mozversion application_version: 48.0a2 13:32:55 INFO - mozversion platform_buildid: 20160425103006 13:32:55 INFO - mozversion platform_changeset: 0d6a91c76a9eddf2219caf028dea130f2d683ec2 13:32:55 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 13:32:55 INFO - mozversion platform_version: 48.0a2 13:32:55 INFO - using testdate: 1461616375 13:32:55 INFO - actual date: 1461616375 13:32:55 INFO - starting webserver on 'localhost:49276' 13:32:55 INFO - SUITE-START | Running 2 tests 13:32:55 INFO - TEST-START | dromaeo_css 13:32:55 INFO - operating with platform_type : mac_ 13:32:55 INFO - Initialising browser for dromaeo_css test... 13:32:55 INFO - TEST-INFO | started process 1666 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/tmpnlxIie/profile http://localhost:49276/getInfo.html) 13:32:58 INFO - PROCESS | 1666 | __metrics Screen width/height:1600/1200 13:32:58 INFO - PROCESS | 1666 | colorDepth:24 13:32:58 INFO - PROCESS | 1666 | Browser inner width/height: 1024/689 13:32:58 INFO - PROCESS | 1666 | __metrics 13:32:58 ERROR - PROCESS | 1666 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 13:32:59 INFO - TEST-INFO | 1666: exit 0 13:32:59 INFO - Browser initialized. 13:32:59 INFO - Running cycle 1/1 for dromaeo_css test... 13:32:59 INFO - TEST-INFO | started process 1669 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/tmpnlxIie/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:33:11 INFO - PROCESS | 1669 | RSS: Main: 221671424 13:33:11 INFO - PROCESS | 1669 | 13:34:00 INFO - PROCESS | 1669 | 1461616440975 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 13:36:11 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49276/tests/dromaeo/cssquery-ext.html) 13:36:13 INFO - PROCESS | 1669 | RSS: Main: 232095744 13:36:13 INFO - PROCESS | 1669 | 13:39:15 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-ext.html (next: http://localhost:49276/tests/dromaeo/cssquery-jquery.html) 13:39:15 INFO - PROCESS | 1669 | RSS: Main: 243662848 13:39:15 INFO - PROCESS | 1669 | 13:42:17 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49276/tests/dromaeo/cssquery-mootools.html) 13:42:18 INFO - PROCESS | 1669 | RSS: Main: 245743616 13:42:18 INFO - PROCESS | 1669 | 13:45:20 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49276/tests/dromaeo/cssquery-prototype.html) 13:45:20 INFO - PROCESS | 1669 | RSS: Main: 247955456 13:45:20 INFO - PROCESS | 1669 | 13:48:23 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49276/tests/dromaeo/cssquery-yui.html) 13:48:24 INFO - PROCESS | 1669 | RSS: Main: 250224640 13:48:24 INFO - PROCESS | 1669 | 13:51:26 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-yui.html (next: http://localhost:49276/tests/dromaeo/cssquery-dojo.html) 13:51:26 INFO - PROCESS | 1669 | RSS: Main: 251310080 13:51:26 INFO - PROCESS | 1669 | 13:51:26 INFO - PROCESS | 1669 | __start_tp_report 13:51:26 INFO - PROCESS | 1669 | _x_x_mozilla_page_load 13:51:26 INFO - PROCESS | 1669 | _x_x_mozilla_page_load_details 13:51:26 INFO - PROCESS | 1669 | |i|pagename|runs| 13:51:26 INFO - PROCESS | 1669 | |0;dojo.html;3222.9355412891728;3395.185155562666;3454.2227998700287;3531.576210854696;3538.4869193966865;4875.293082503035;5087.974560127194;5676.318841738992;5692.800751973682;5742.109972954188;5218.564894653972;5424.566034717223;5701.258836351269;5768.077107662775;5823.67969761663;4588.931166032512;5037.1940489521685;5082.567981721568;5147.4080480744815;5238.92141617876;4957.132501812169;5013;5168.121419358699;5208.817691380802;5214.634975551713;5078.746062696869;5157.303763991869;5177;5185.688858668492;5200.947990520103;4335.43639326887;5119.513646203604;5130.3074084998425;5155.046316431435;5155.690658560461;5030.195168773015;5084.56781173597;5130.410002849682;5184.8963020739375;5237.502437268454;5554.694491802949;5556.277683901067;5567.832965011056;5592.692401917893;5608.803691870806;5971.313298970631;6102.6948652567635;6187.504999600022;6212.782552610682;6245.594036387665;6249.125122482856;6311.08489269058;6315.589486683397;6339.714712837887;6340.080688300171;5759.712014399305;5781.862036658673;5788.565857560699;5804.332501762309;5812.534997200214;6176.505879529716;6209.875802484015;6250.4374606285655;6278.811635650938;6279.120923070774;5563.7774489019985;5761.423857614205;6150.538709596798;6158.168647232566;6170.10533472653;6209.782657606962;6316.494680425555;6318.778842740482;6326.335734747785;6329.746810127635;6021.608595441282;6140.324564297924;6191.535634827406;6209.813705588839;6234.625922444668;6228.5951413158;6256.812295631138;6267.4986001119805;6270.404311590391;6286.622802631857;4867.9269810952865;4918.385201849769;4924.507549245047;4930.383702037246;4976.42771081323;4311.741295522279;4361.454818147731;4388.71473354231;4433.334999750064;4472.575105364985;5599.832005039855;5665.150227465913;5673.744681489343;5687.118496633028;5720.742566584514;6117.082437634391;6292.590981586182;6336.20797400325;6345.016522439029;6347.143135676717;5664.235328230719;5713.800016999385;5719.599628025998;5725.2843394575675;5732.7706891723865;5354.170103633943;5376.059189641797;5378.973105134528;5395.865103372447;5398.6220964532895;6243.375662433811;6274.843128921813;6303.3066362700065;6372.139761132281;6384.776532821329;6111.327753947151;6208.658523781235;6249.906251406142;6329.936700632935;6339.651319177489;6294.905576416266;6339.809805705836;6346.460550853045;6352.968235158794;6376.713047912948;5992.760289588367;6120.510359171345;6168.568200225941;6222.439980401786;6230.906536401867;6188.845278868064;6246.968765156145;6258.311585725658;6261.092141639528;6268.905966410599;5645.435456454322;5680.971595141998;6077.604955677867;6137.41694539018;6151.200343955257;5884.852878678067;6060.969695151496;6124.411449640054;6128.295246046583;6135;4506.616937560213;5849.064149736022;5870.853228669317;5891.38140495259;5915.70421478933;6074.119252708244;6076.756929722762;6089.421504957022;6093.482054025458;6100.603460775035;5778.191053252632;5901.409859014236;5935.228420305332;6004.969975150097;6033.336333003278 13:51:26 INFO - PROCESS | 1669 | |1;ext.html;502.12880652068657;510.43596825507814;551.6000899347973;575.3297408519077;581.2501872584367;38488.23023539528;39458.210835783306;39537.802310988474;39560.40659390111;39611.40582891259;40774;40946.59053409465;41581.58418415815;41622;41744.58255417452;9536.046395360478;9676.225901927864;9759.365641233297;9788.265880058989;9807.26445516589;9718.416894986323;9741.659041933533;9844.310898237127;9884.555195016206;9891.357061790997;9826.164775994013;9877.555510002032;9879.506024698772;9882.901170988305;9903.257255705816;9791.06984836443;9811.313208075437;9880.505974701236;9886.307958442912;9943.403395796275;9655.806883862284;9728.41629502225;9736.75658108546;9761.365511241818;9764.170045546138;40054;40507.79746101251;40522.18955620871;40642.59357406418;40670;3461.8615255389755;3492.930141397158;3660;3832.3868181090893;3851.7111216658864;29057.12828615145;29182.416351672848;29474.85262573695;29557.408851823056;29562.556561651592;2751.119641714652;2778.7776977841927;2797.5663772115354;2802.383475635357;2824.209221418006;343001;348630;349326;350252.2487387572;470625;64982.025269620994;66843.33156668372;67553;67801.32198678049;68066;62120.68939655273;63074.0538891917;65183.67408162929;70402.29597703957;70812.64593676999;17510.387136450165;17724.55688607795;17725.822741772416;17728.290868365122;17777.022263775358;13344.933275333562;13383.598492045254;13420.932895335656;13474.19154850712;13490.86509134896;16600.584985375463;19992.800071999092;20246.595068098555;20326.59346813085;20337;6462.773802916875;7160.462965277625;8254.42219044661;8290.875636865452;8304.6678132874;908.6683360573343;1005.1054561440324;1014.5434554450527;1058.1481907064733;1082.8821324448165;28100.875964961582;28967.855160724062;30674;30809.2297692555;30815;1084.3819023156725;1097.3306283167262;1112.9499172537255;1113.2207454781685;1205.7829590673587;15669.373225071098;15807;15853.365865365256;15882.523524294289;16125;619012;620874;621349;628747;630890;61812;62751.6862415685;62801;62873;62912.68543657252;1470.1399681186413;1493.8506149384975;1497.5956491747168;1498.4006397441328;1503.3986405437913;29464.263393415335;29902.850485748302;30019.849900750356;30513.847430762704;30668.926587569327;54381.72809135929;54651.72674136604;54827.451725482235;55064.17403739027;55104.448955511536;558461;565652;576284;579009;579527;26240.08159714401;26504.602430963165;26668.733312666624;26726.59910101389;27196.184114475807;43390;44174;44438.55561444473;46466.583850931675;47351.52648473471;38090.0477488065;38867.222655547295;38895.222095557365;39260.214795704494;40162.598374015884;37864.81067594644;38455;39016.82949511519;39039.6096039036;39154.4126838092;36967.26065478729;38292.61707382891;38299.617003829604;38590.614093858705;38767.6123238764;32799.67200327966;33484.00937983355;34044.31911361808;34087.147821304665;34232.82883585566;21187;25485.23544293674;25652.743472565035;25731.742682572934;25967.74032259653 13:51:26 INFO - PROCESS | 1669 | |2;jquery.html;362.4400301534131;392.8899908025753;393.93893946438305;400.39540294155813;409.8708906694389;17608.91195544024;19441.513962150937;20241.898790506064;21582.892085539588;21589.56820863584;9223.031581683927;12050.21673591216;12101.576444824412;12283.44724487398;12346.691332716686;5364.91952620711;5592.552595792347;5632.26780518532;5639.182318563806;5677.886442271152;3941.7043721720843;5877.52979761618;6109.847253818646;6185.350538193492;6217.968910155466;5954.689968206988;6124.663143527104;6166.136740856284;6179.907301390483;6185.8144255672405;6081.3614570470345;6171.074338849164;6173.074038894157;6174.475169610589;6204.503639708812;5239.397469291042;5707.286589176353;5764.654120752768;5971.343152253248;6052.72762725674;13550.59348219555;13580.660483487893;13679.179249245077;17730.556736081573;24457.633135502983;2126.9787302126933;2134.519733060049;2170.066871245364;2241.5628952354296;2250.2124256510256;9991.650292239809;10065.24510661696;10261.79476410475;13108;14286.64283392913;1711.4523352527196;1742.0766993493341;1759.5073379453772;1760.8239176082418;1772.7252275897256;132284;133821.33089334588;134811;136753.3162334192;139308;11805.17363784544;11946.820797688042;11999.880001199876;12024.278543287432;12085.335306558049;15105;15354.769678454832;15443.845561544465;15471.14908680011;15528.223588820514;8877.955610221907;8881.73354799357;8895.73312800604;8945.987152890548;9033.548322583845;8619.051904290523;8721.956390218134;8730.214280714767;8749.912500875038;8851;4657.86026419208;4676.672632915731;4686.109639168547;4718.079974404958;4721.457032441244;1817.273090763705;1883.2843519462517;1978.3570339639675;1980.2178139634764;2004.9498762530761;886.8935727712716;1009.742515658517;1009.8081364540714;1038.9896101038894;1069.4599227390117;18077.63844723098;19273.614527709648;19799.60400791976;19893;19960.401187964384;946.6592026870321;968.0222974795366;974.5809302000066;987.3335498538457;1002.6440613582073;10569.101626361691;10782.299150555189;10806.837897431546;10814.675559733221;10859.457027148768;582471;584379;585719;585745;611432.8285075728;90538;90616;94129;124086;126663;881.4358810361374;979.5543027922279;984.1929617713406;988.3131223799534;1011.1354791653031;17842.46472605824;18022.729659055385;18155.092245387943;18181.909085454387;18212.908935455238;48084.7595762019;48861.51138488712;49208.50791492182;49224;49296.50703492919;70355.64822176061;72716;73216.63391683008;73864;73923;7723.420743444377;8005.679772809022;8128.715494957648;8128.715494957884;8493.617787199468;10232.744181395525;11657.766844663229;12668.176568523017;12824.807627885775;12916.22502649844;11013.944930275296;11019.449027548751;11313.981741643292;11368.488418021043;11451.828222576502;10424;10507.737306567396;10677.985591368808;10917.344959302467;10950.39772812503;10344.431056291976;10633.096186824207;10922.890771092505;11045;11344.602938897098;7348.971144039946;7910.090339611018;8090.919090809017;8209.64540850753;8453.154684531497;7741.1871753465075;9383.441683735426;9662.661806836726;9717.22262219035;11004.229703920648 13:51:26 INFO - PROCESS | 1669 | |3;mootools.html;1568.435363269223;1617.9352825886965;1794.883332583382;1835.5686413692788;1847.6674198644248;8030.51816890987;8607.13928607139;8661.913380866197;9023.819523609523;9033.096690330973;8633.95683021584;8704.869426958601;8759.693410730626;8789.824203515926;8796.648134074629;2438.7317395086525;2447.3025187821386;2466.8273220874544;2471.4315707387223;2479.82641215115;2431.3556907419547;2466.3957330454064;2482.7641374069435;2484.229888734498;2487.4154573675173;2428.2108314797674;2431.051889762994;2490.3898544856534;2493.376655836041;2503.5118151960373;2457.103157347573;2459.1515927005244;2459.6064629659168;2465.3343597228736;2482.640017197505;2444.8533088014774;2453.8895749691305;2458.606622940321;2466.666999955001;2480.6155045967903;8774.25418839393;8843.115688431106;8964.417312874642;8968.013518512958;8969.789078474389;5191.325127733408;5365.678059316415;5387.1380579107545;5387.838364849061;5405.27028851104;3438.4670376091494;3500.0724807925667;3525.048236976002;3545.840437180333;3692.316921369555;1025.1132770153838;1046.272840375939;1053.3521884041259;1073.6617965340893;1076.7200527862733;11237.943810280896;11331.943340283327;11420.486078126503;11423.086153107732;11445.65663030102;4369.69412141147;4398.978005110018;4461.665375096816;4463;4511.300748384006;9071.81856362869;9136.994930557634;9140.177384035469;9150.86273705895;9161.083891610786;5146.0479811235045;5186.196139598368;5187.481251874782;5215.13950198213;5219.869503262449;4482.731036137842;4833.589144922721;4918.065567542156;4963.156263435225;4967.925481117786;3837.501124853807;3873.341531939577;3924.175923056133;3952.7825969571372;3981.761094334291;1224.2715584227371;1224.8101544260653;1226.7975783995541;1226.9325187114616;1238.3189245914712;847.2459511035183;917.8485549884194;948.0424770981358;948.3503799897093;961.4663861556903;5848.853778655568;5945.316288626776;5985.281766188085;5987.042073268256;6132.8773424532155;440.482433141058;458.2484725050919;460.2061444009124;468.29755366949576;472.0865125981169;3976.926229917906;3983.203359328146;3996.9200615987515;4051;4094.3244364679495;10147.64483243083;10904.61833835812;10923.781524369468;10926.726831829108;11067;10462.843057354146;10692.198085143646;10823.404712740718;10872.18458615607;10892.01971822524;7970;8068.435209535393;8073.959630201812;8149.429539932148;8207.71273005442;4376.387305777257;5035.345405097461;5759.94240057594;5935.584509084495;6100.267967843887;9512.525558538438;9936.105750482491;9976.50117494137;10082.6471073515;10165.695029149138;8317.750467485985;10098.444585547866;10107.69676909694;10266.845997310196;10363.948180259353;6289.276733175743;6771.593704377556;6978.651067446709;7020.964895175492;7084.539504932163;8213.260806527202;8252.968378952632;8312;8353.289970352587;8361.122082181284;7270.600116993616;7473.8878916817375;7511.286427789351;7602.049743782028;7616.657250423855;7199.928000719926;7297.379722723628;7301.452391070798;7371.262873712586;7434.962825186056;5948.434898684618;6962.582245065312;7009.474289428415;7056.329648683367;7090.893636595559;4852.967527425449;4939.703617782944;4982.20284754452;5000.324956131021;5016.949830501794;4879.756012199305;4883.36516252899;4910.386201724785;5031.622628302819;5149.665271757323 13:51:26 INFO - PROCESS | 1669 | |4;prototype.html;304.48086013347245;309.7769605883763;318.03000847415376;318.84536000039975;319.93121478882034;4575.032735923552;4842.4988253641395;4865.978144589636;5148.227765835127;5505.559555235582;5119.2833003379465;5440;5481.409676661793;5538.307711536058;5547;3486.6164721880573;3664.102294937744;3676.7610105343133;3780.8638119462553;4025.476688030552;4213.620774130328;4229.287138708828;4236.682248831335;4238.969137066996;4257.574242575749;3880.8177294618426;4114.8971275718195;4134.421181034658;4152.8131234094535;4161.771102589357;3598.8920332389807;3616.5768934813605;4036;4081.632653061209;4155.522114956789;2983.358577905739;3262.6574209708115;3542.6634469725336;3565.180008598037;3596.9820150899077;4561.384213131251;4882.633802464829;5062.873428164326;5274.472552744734;5296.867578310535;4165.479315085614;4710;4723.645726570521;4728.338032675429;4764.404449443819;5292.655977361459;5753;5776.555861034742;5779.884402311972;5826.446487583673;3692.4276737105793;3893.9610603894166;3913.7456065355946;3915.2169566086895;3946.980265098685;5083.364579427572;5244.134717771563;5543.6119471637;6019.103982245622;6070.392960703938;3742.3450896093077;3940.2316548273384;3951.328274193394;3974.847294284625;4002.939955900664;3360.428727116396;3411.556497655289;4017.2367250222364;4049.9392509112386;4071.7353372030725;4207.936880946788;4374.4094547236355;4715.198416269242;4742.399872124034;4744.620430365562;5058.317127187856;5227.451117632594;5291.126964050888;5641.335805937259;5840.649561026352;1442.451868290064;1459.4162335065846;1469.860363265488;1470.691154857492;1471.4776254429737;863.7451951674271;926.2682480840195;957.9568919398644;958.7363475044418;975.0834215837091;5007.474215207423;5093.439721630618;5725.85482903421;5773.971130144322;5838.941610583925;6459.967700161469;6473.546851720334;6485.687018132889;6487.086309538698;6516.771912983023;5357.892842143213;5553.527950124204;5683.8010669626365;5850.444207800252;5853.970730146322;2803.8738256778493;3386.170388254844;3414.641462646436;3437.2609888874013;3453.430184019659;5890.9410905891245;5929.555283353766;6333.493320534346;6749.662516874137;6764.5603035802515;5326.121190003606;6028.879422411527;6254.498920259105;6273.341299163613;6308.968455157695;4912.508749125059;5050.368703912011;5428.5928555358505;6292.182016337847;6383.904241436382;5731.656100633975;6044.697765111815;6060.78787242462;6076.174578820869;6076.270847498152;4411.977940110279;5960.672163031075;6004.369541198112;6024.849378765566;6062.818115456544;5189.558887494605;5902.61632993854;6016.8796624068145;6171.297221667143;6284.5600807943;3298.868045278162;3920.7059470540394;3925.5681874994298;3941.7832019239218;3947.7631342119566;5266.210068489757;5806.796762113306;5916.822495325147;5932.79235226765;6073.331933487401;5224.425313215467;5468.316460442445;5893.349862038636;5905.232319798399;5917.792877249448;5427.864303392289;5842.896557239305;5859;5894.410558944071;5924.407559244213;4730.716157030589;4801.567858892717;5503.944960550503;5645.81437898046;5646.491815736604;5709.3719690834805;5792.594518383673;5816.243888294494;5818.50542703858;5828.184054232326;5019.924701129559;5629.690367029689;5687.744051517609;5695.857603559944;5740.483356497935 13:51:26 INFO - PROCESS | 1669 | |5;yui.html;659.2188256915555;714.3891972363629;720.1861896057458;753.3445902065204;755.3805879179074;14530.564083077512;14691;15079.773803392958;15112;15153.39386424543;13745.175289482613;13877.959153063535;13892.305384730747;13905.304734763247;13947.721045579083;726.397090414957;896.865470179475;903.2322525853021;922.6217250927122;923.3582660051267;893.2452077994117;914.4924566865387;920.7099763574486;927.1007123090591;928.2713070239863;974.790420059687;975.7755716185281;978.7210644966186;979.8628192053118;981.1267971505366;928.9363678588046;932.9020452852454;942.6323733743777;961.9663311784124;971.1259866120478;692.9688164032631;695.151914664109;712.5154894671621;726.1032624708481;727.1419724724823;14879.776803347959;14883.479078232318;14925.328360223708;14944.40222391103;15000.099994000286;10994.34033957957;12319.260844349368;12450.688732781753;12524.937375313066;12609.00657515743;9590.184834289093;9781.657641982567;9830.852537211877;9894.851577226347;9905.455199963999;3458.360203362386;3463.930721385583;3511.666391692785;3571.8749843755604;3680.871169509054;88699.11300887038;89580;89840.55079724625;89879;91641.54179229127;9278.072192780668;9436.386634868712;9501.857472137923;9623.807523849484;9666.130048295687;21194.682079768507;21763.347099587038;21788.56422871534;22031.889840551015;22668;7280.343470625376;7284.8178795529475;7336;7488.812779680443;7529.962350188214;3971.6624086952356;4046.838126474908;4060.0864805418546;4114.814833332507;4155.501339839178;3537.6285490023693;3563.2160924596546;3578.7494875358475;3625.8549658013912;3631.092226943264;642.5983760149907;642.9164208652845;643.3341491556217;656.7734131724548;667.0261418329294;546.1834557336807;592.7806711516766;593.6141508019736;595.1073389915127;630.1839118341759;8290.792730181673;8322.126176751475;8393.790155246046;8443.493390396596;8466.153384661608;558.1432501110856;559.560744815318;593.0955293177852;624.996875015622;627.799104286633;3785.072657199004;3938.2517321708783;3968.940465893014;4004.65960393364;4015.2170326785995;70355.64822175959;87063;94293;103915.48042259741;106644;69656.56202033006;76193.23806761861;80906.59546702229;81491.5925420381;82366.58816705998;74610.76167714977;74614.5077098455;74678.6266068677;74774.6261268701;75100;8152.877706834283;8292.17078292166;8407.45351552147;8466.195711407407;8482.982042154981;44438.555614443445;45413.63759087233;45978.54021459743;46627;46781.766091169324;56204.71897640649;58217.41782582289;59066.70466647639;61511.15466536011;61720.38279617326;9114.726558203265;11108.88891111111;11161.218714689894;11383.487743051417;11985.580504682293;12019.278843269432;12027.639170824888;12028.939855300667;12206.633800985985;12464.750704985669;11287.548498059985;11361.54553817838;11514.712132196762;11530.423478826193;11612.825807612724;11336.546538138382;11348.54605815758;11376.203665743318;11395.487203076047;11439.14206434504;11090.85293560898;11245.606403775828;11320.26418282809;11324.001949841091;11653.592124275949;9412.294077944318;9480.288978326791;9591.9040809591;9607.903920960702;9779.26655500826;8845.646174153218;9383.249340052917;9460.479673617741;9585.892609471028;9587.185089267212 13:51:26 INFO - PROCESS | 1669 | __end_tp_report 13:51:26 INFO - PROCESS | 1669 | __start_cc_report 13:51:26 INFO - PROCESS | 1669 | _x_x_mozilla_cycle_collect,417 13:51:26 INFO - PROCESS | 1669 | __end_cc_report 13:51:26 INFO - PROCESS | 1669 | __startTimestamp1461617486478__endTimestamp 13:51:26 INFO - PROCESS | 1669 | 13:51:26 INFO - PROCESS | 1669 | ------- Summary: start ------- 13:51:26 INFO - PROCESS | 1669 | Number of tests: 6 13:51:26 INFO - PROCESS | 1669 | 13:51:26 INFO - PROCESS | 1669 | [#0] dojo.html Cycles:165 Average:5693.02 Median:5870.85 stddev:668.12 (11.4%) stddev-sans-first:641.45 13:51:26 INFO - PROCESS | 1669 | Values: 3222.9 3395.2 3454.2 3531.6 3538.5 4875.3 5088.0 5676.3 5692.8 5742.1 5218.6 5424.6 5701.3 5768.1 5823.7 4588.9 5037.2 5082.6 5147.4 5238.9 4957.1 5013.0 5168.1 5208.8 5214.6 5078.7 5157.3 5177.0 5185.7 5200.9 4335.4 5119.5 5130.3 5155.0 5155.7 5030.2 5084.6 5130.4 5184.9 5237.5 5554.7 5556.3 5567.8 5592.7 5608.8 5971.3 6102.7 6187.5 6212.8 6245.6 6249.1 6311.1 6315.6 6339.7 6340.1 5759.7 5781.9 5788.6 5804.3 5812.5 6176.5 6209.9 6250.4 6278.8 6279.1 5563.8 5761.4 6150.5 6158.2 6170.1 6209.8 6316.5 6318.8 6326.3 6329.7 6021.6 6140.3 6191.5 6209.8 6234.6 6228.6 6256.8 6267.5 6270.4 6286.6 4867.9 4918.4 4924.5 4930.4 4976.4 4311.7 4361.5 4388.7 4433.3 4472.6 5599.8 5665.2 5673.7 5687.1 5720.7 6117.1 6292.6 6336.2 6345.0 6347.1 5664.2 5713.8 5719.6 5725.3 5732.8 5354.2 5376.1 5379.0 5395.9 5398.6 6243.4 6274.8 6303.3 6372.1 6384.8 6111.3 6208.7 6249.9 6329.9 6339.7 6294.9 6339.8 6346.5 6353.0 6376.7 5992.8 6120.5 6168.6 6222.4 6230.9 6188.8 6247.0 6258.3 6261.1 6268.9 5645.4 5681.0 6077.6 6137.4 6151.2 5884.9 6061.0 6124.4 6128.3 6135.0 4506.6 5849.1 5870.9 5891.4 5915.7 6074.1 6076.8 6089.4 6093.5 6100.6 5778.2 5901.4 5935.2 6005.0 6033.3 13:51:26 INFO - PROCESS | 1669 | 13:51:26 INFO - PROCESS | 1669 | [#1] ext.html Cycles:180 Average:66937.19 Median:39097.01 stddev:142844.16 (365.4%) stddev-sans-first:143157.78 13:51:26 INFO - PROCESS | 1669 | Values: 502.1 510.4 551.6 575.3 581.3 38488.2 39458.2 39537.8 39560.4 39611.4 40774.0 40946.6 41581.6 41622.0 41744.6 9536.0 9676.2 9759.4 9788.3 9807.3 9718.4 9741.7 9844.3 9884.6 9891.4 9826.2 9877.6 9879.5 9882.9 9903.3 9791.1 9811.3 9880.5 9886.3 9943.4 9655.8 9728.4 9736.8 9761.4 9764.2 40054.0 40507.8 40522.2 40642.6 40670.0 3461.9 3492.9 3660.0 3832.4 3851.7 29057.1 29182.4 29474.9 29557.4 29562.6 2751.1 2778.8 2797.6 2802.4 2824.2 343001.0 348630.0 349326.0 350252.2 470625.0 64982.0 66843.3 67553.0 67801.3 68066.0 62120.7 63074.1 65183.7 70402.3 70812.6 17510.4 17724.6 17725.8 17728.3 17777.0 13344.9 13383.6 13420.9 13474.2 13490.9 16600.6 19992.8 20246.6 20326.6 20337.0 6462.8 7160.5 8254.4 8290.9 8304.7 908.7 1005.1 1014.5 1058.1 1082.9 28100.9 28967.9 30674.0 30809.2 30815.0 1084.4 1097.3 1112.9 1113.2 1205.8 15669.4 15807.0 15853.4 15882.5 16125.0 619012.0 620874.0 621349.0 628747.0 630890.0 61812.0 62751.7 62801.0 62873.0 62912.7 1470.1 1493.9 1497.6 1498.4 1503.4 29464.3 29902.9 30019.8 30513.8 30668.9 54381.7 54651.7 54827.5 55064.2 55104.4 558461.0 565652.0 576284.0 579009.0 579527.0 26240.1 26504.6 26668.7 26726.6 27196.2 43390.0 44174.0 44438.6 46466.6 47351.5 38090.0 38867.2 38895.2 39260.2 40162.6 37864.8 38455.0 39016.8 39039.6 39154.4 36967.3 38292.6 38299.6 38590.6 38767.6 32799.7 33484.0 34044.3 34087.1 34232.8 21187.0 25485.2 25652.7 25731.7 25967.7 13:51:26 INFO - PROCESS | 1669 | 13:51:26 INFO - PROCESS | 1669 | [#2] jquery.html Cycles:180 Average:33861.84 Median:13353.92 stddev:98525.47 (737.8%) stddev-sans-first:98769.76 13:51:26 INFO - PROCESS | 1669 | Values: 362.4 392.9 393.9 400.4 409.9 17608.9 19441.5 20241.9 21582.9 21589.6 9223.0 12050.2 12101.6 12283.4 12346.7 5364.9 5592.6 5632.3 5639.2 5677.9 3941.7 5877.5 6109.8 6185.4 6218.0 5954.7 6124.7 6166.1 6179.9 6185.8 6081.4 6171.1 6173.1 6174.5 6204.5 5239.4 5707.3 5764.7 5971.3 6052.7 13550.6 13580.7 13679.2 17730.6 24457.6 2127.0 2134.5 2170.1 2241.6 2250.2 9991.7 10065.2 10261.8 13108.0 14286.6 1711.5 1742.1 1759.5 1760.8 1772.7 132284.0 133821.3 134811.0 136753.3 139308.0 11805.2 11946.8 11999.9 12024.3 12085.3 15105.0 15354.8 15443.8 15471.1 15528.2 8878.0 8881.7 8895.7 8946.0 9033.5 8619.1 8722.0 8730.2 8749.9 8851.0 4657.9 4676.7 4686.1 4718.1 4721.5 1817.3 1883.3 1978.4 1980.2 2004.9 886.9 1009.7 1009.8 1039.0 1069.5 18077.6 19273.6 19799.6 19893.0 19960.4 946.7 968.0 974.6 987.3 1002.6 10569.1 10782.3 10806.8 10814.7 10859.5 582471.0 584379.0 585719.0 585745.0 611432.8 90538.0 90616.0 94129.0 124086.0 126663.0 881.4 979.6 984.2 988.3 1011.1 17842.5 18022.7 18155.1 18181.9 18212.9 48084.8 48861.5 49208.5 49224.0 49296.5 70355.6 72716.0 73216.6 73864.0 73923.0 7723.4 8005.7 8128.7 8128.7 8493.6 10232.7 11657.8 12668.2 12824.8 12916.2 11013.9 11019.4 11314.0 11368.5 11451.8 10424.0 10507.7 10678.0 10917.3 10950.4 10344.4 10633.1 10922.9 11045.0 11344.6 7349.0 7910.1 8090.9 8209.6 8453.2 7741.2 9383.4 9662.7 9717.2 11004.2 13:51:26 INFO - PROCESS | 1669 | 13:51:26 INFO - PROCESS | 1669 | [#3] mootools.html Cycles:180 Average:5648.33 Median:4881.56 stddev:3152.09 (64.6%) stddev-sans-first:3146.02 13:51:26 INFO - PROCESS | 1669 | Values: 1568.4 1617.9 1794.9 1835.6 1847.7 8030.5 8607.1 8661.9 9023.8 9033.1 8634.0 8704.9 8759.7 8789.8 8796.6 2438.7 2447.3 2466.8 2471.4 2479.8 2431.4 2466.4 2482.8 2484.2 2487.4 2428.2 2431.1 2490.4 2493.4 2503.5 2457.1 2459.2 2459.6 2465.3 2482.6 2444.9 2453.9 2458.6 2466.7 2480.6 8774.3 8843.1 8964.4 8968.0 8969.8 5191.3 5365.7 5387.1 5387.8 5405.3 3438.5 3500.1 3525.0 3545.8 3692.3 1025.1 1046.3 1053.4 1073.7 1076.7 11237.9 11331.9 11420.5 11423.1 11445.7 4369.7 4399.0 4461.7 4463.0 4511.3 9071.8 9137.0 9140.2 9150.9 9161.1 5146.0 5186.2 5187.5 5215.1 5219.9 4482.7 4833.6 4918.1 4963.2 4967.9 3837.5 3873.3 3924.2 3952.8 3981.8 1224.3 1224.8 1226.8 1226.9 1238.3 847.2 917.8 948.0 948.4 961.5 5848.9 5945.3 5985.3 5987.0 6132.9 440.5 458.2 460.2 468.3 472.1 3976.9 3983.2 3996.9 4051.0 4094.3 10147.6 10904.6 10923.8 10926.7 11067.0 10462.8 10692.2 10823.4 10872.2 10892.0 7970.0 8068.4 8074.0 8149.4 8207.7 4376.4 5035.3 5759.9 5935.6 6100.3 9512.5 9936.1 9976.5 10082.6 10165.7 8317.8 10098.4 10107.7 10266.8 10363.9 6289.3 6771.6 6978.7 7021.0 7084.5 8213.3 8253.0 8312.0 8353.3 8361.1 7270.6 7473.9 7511.3 7602.0 7616.7 7199.9 7297.4 7301.5 7371.3 7435.0 5948.4 6962.6 7009.5 7056.3 7090.9 4853.0 4939.7 4982.2 5000.3 5016.9 4879.8 4883.4 4910.4 5031.6 5149.7 13:51:26 INFO - PROCESS | 1669 | 13:51:26 INFO - PROCESS | 1669 | [#4] prototype.html Cycles:180 Average:4698.18 Median:5235.79 stddev:1478.63 (28.2%) stddev-sans-first:1445.53 13:51:26 INFO - PROCESS | 1669 | Values: 304.5 309.8 318.0 318.8 319.9 4575.0 4842.5 4866.0 5148.2 5505.6 5119.3 5440.0 5481.4 5538.3 5547.0 3486.6 3664.1 3676.8 3780.9 4025.5 4213.6 4229.3 4236.7 4239.0 4257.6 3880.8 4114.9 4134.4 4152.8 4161.8 3598.9 3616.6 4036.0 4081.6 4155.5 2983.4 3262.7 3542.7 3565.2 3597.0 4561.4 4882.6 5062.9 5274.5 5296.9 4165.5 4710.0 4723.6 4728.3 4764.4 5292.7 5753.0 5776.6 5779.9 5826.4 3692.4 3894.0 3913.7 3915.2 3947.0 5083.4 5244.1 5543.6 6019.1 6070.4 3742.3 3940.2 3951.3 3974.8 4002.9 3360.4 3411.6 4017.2 4049.9 4071.7 4207.9 4374.4 4715.2 4742.4 4744.6 5058.3 5227.5 5291.1 5641.3 5840.6 1442.5 1459.4 1469.9 1470.7 1471.5 863.7 926.3 958.0 958.7 975.1 5007.5 5093.4 5725.9 5774.0 5838.9 6460.0 6473.5 6485.7 6487.1 6516.8 5357.9 5553.5 5683.8 5850.4 5854.0 2803.9 3386.2 3414.6 3437.3 3453.4 5890.9 5929.6 6333.5 6749.7 6764.6 5326.1 6028.9 6254.5 6273.3 6309.0 4912.5 5050.4 5428.6 6292.2 6383.9 5731.7 6044.7 6060.8 6076.2 6076.3 4412.0 5960.7 6004.4 6024.8 6062.8 5189.6 5902.6 6016.9 6171.3 6284.6 3298.9 3920.7 3925.6 3941.8 3947.8 5266.2 5806.8 5916.8 5932.8 6073.3 5224.4 5468.3 5893.3 5905.2 5917.8 5427.9 5842.9 5859.0 5894.4 5924.4 4730.7 4801.6 5503.9 5645.8 5646.5 5709.4 5792.6 5816.2 5818.5 5828.2 5019.9 5629.7 5687.7 5695.9 5740.5 13:51:26 INFO - PROCESS | 1669 | 13:51:26 INFO - PROCESS | 1669 | [#5] yui.html Cycles:180 Average:18333.31 Median:636.39 stddev:26211.83 (4118.8%) stddev-sans-first:26251.77 13:51:26 INFO - PROCESS | 1669 | Values: 659.2 714.4 720.2 753.3 755.4 14530.6 14691.0 15079.8 15112.0 15153.4 13745.2 13878.0 13892.3 13905.3 13947.7 726.4 896.9 903.2 922.6 923.4 893.2 914.5 920.7 927.1 928.3 974.8 975.8 978.7 979.9 981.1 928.9 932.9 942.6 962.0 971.1 693.0 695.2 712.5 726.1 727.1 14879.8 14883.5 14925.3 14944.4 15000.1 10994.3 12319.3 12450.7 12524.9 12609.0 9590.2 9781.7 9830.9 9894.9 9905.5 3458.4 3463.9 3511.7 3571.9 3680.9 88699.1 89580.0 89840.6 89879.0 91641.5 9278.1 9436.4 9501.9 9623.8 9666.1 21194.7 21763.3 21788.6 22031.9 22668.0 7280.3 7284.8 7336.0 7488.8 7530.0 3971.7 4046.8 4060.1 4114.8 4155.5 3537.6 3563.2 3578.7 3625.9 3631.1 642.6 642.9 643.3 656.8 667.0 546.2 592.8 593.6 595.1 630.2 8290.8 8322.1 8393.8 8443.5 8466.2 558.1 559.6 593.1 625.0 627.8 3785.1 3938.3 3968.9 4004.7 4015.2 70355.6 87063.0 94293.0 103915.5 106644.0 69656.6 76193.2 80906.6 81491.6 82366.6 74610.8 74614.5 74678.6 74774.6 75100.0 8152.9 8292.2 8407.5 8466.2 8483.0 44438.6 45413.6 45978.5 46627.0 46781.8 56204.7 58217.4 59066.7 61511.2 61720.4 9114.7 11108.9 11161.2 11383.5 11985.6 12019.3 12027.6 12028.9 12206.6 12464.8 11287.5 11361.5 11514.7 11530.4 11612.8 11336.5 11348.5 11376.2 11395.5 11439.1 11090.9 11245.6 11320.3 11324.0 11653.6 9412.3 9480.3 9591.9 9607.9 9779.3 8845.6 9383.2 9460.5 9585.9 9587.2 13:51:26 INFO - PROCESS | 1669 | -------- Summary: end -------- 13:51:26 INFO - PROCESS | 1669 | 13:51:26 INFO - TEST-INFO | 1669: exit 0 13:51:27 INFO - TEST-OK | dromaeo_css | took 1111279ms 13:51:27 INFO - TEST-START | kraken 13:51:27 INFO - operating with platform_type : mac_ 13:51:27 INFO - Initialising browser for kraken test... 13:51:27 INFO - TEST-INFO | started process 1678 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/tmpZT857L/profile http://localhost:49276/getInfo.html) 13:51:29 INFO - PROCESS | 1678 | __metrics Screen width/height:1600/1200 13:51:29 INFO - PROCESS | 1678 | colorDepth:24 13:51:29 INFO - PROCESS | 1678 | Browser inner width/height: 1024/689 13:51:29 INFO - PROCESS | 1678 | __metrics 13:51:30 ERROR - PROCESS | 1678 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 13:51:30 INFO - TEST-INFO | 1678: exit 0 13:51:30 INFO - Browser initialized. 13:51:30 INFO - Running cycle 1/1 for kraken test... 13:51:30 INFO - TEST-INFO | started process 1681 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/tmpZT857L/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:51:42 INFO - PROCESS | 1681 | RSS: Main: 221659136 13:51:42 INFO - PROCESS | 1681 | 13:51:45 INFO - PROCESS | 1681 | 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) 13:51:46 INFO - PROCESS | 1681 | RSS: Main: 233533440 13:51:46 INFO - PROCESS | 1681 | 13:51:49 INFO - PROCESS | 1681 | 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) 13:51:49 INFO - PROCESS | 1681 | RSS: Main: 242819072 13:51:49 INFO - PROCESS | 1681 | 13:51:52 INFO - PROCESS | 1681 | 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) 13:51:53 INFO - PROCESS | 1681 | RSS: Main: 246308864 13:51:53 INFO - PROCESS | 1681 | 13:51:55 INFO - PROCESS | 1681 | 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) 13:51:56 INFO - PROCESS | 1681 | RSS: Main: 246689792 13:51:56 INFO - PROCESS | 1681 | 13:51:58 INFO - PROCESS | 1681 | 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) 13:51:58 INFO - PROCESS | 1681 | RSS: Main: 247754752 13:51:58 INFO - PROCESS | 1681 | 13:52:01 INFO - PROCESS | 1681 | 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) 13:52:02 INFO - PROCESS | 1681 | RSS: Main: 248696832 13:52:02 INFO - PROCESS | 1681 | 13:52:05 INFO - PROCESS | 1681 | 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) 13:52:05 INFO - PROCESS | 1681 | RSS: Main: 248442880 13:52:05 INFO - PROCESS | 1681 | 13:52:08 INFO - PROCESS | 1681 | 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) 13:52:09 INFO - PROCESS | 1681 | RSS: Main: 248659968 13:52:09 INFO - PROCESS | 1681 | 13:52:10 INFO - PROCESS | 1681 | 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) 13:52:11 INFO - PROCESS | 1681 | RSS: Main: 248020992 13:52:11 INFO - PROCESS | 1681 | 13:52:13 INFO - PROCESS | 1681 | 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) 13:52:14 INFO - PROCESS | 1681 | RSS: Main: 248188928 13:52:14 INFO - PROCESS | 1681 | 13:52:16 INFO - PROCESS | 1681 | 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) 13:52:16 INFO - PROCESS | 1681 | RSS: Main: 248389632 13:52:16 INFO - PROCESS | 1681 | 13:52:19 INFO - PROCESS | 1681 | 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) 13:52:20 INFO - PROCESS | 1681 | RSS: Main: 248446976 13:52:20 INFO - PROCESS | 1681 | 13:52:23 INFO - PROCESS | 1681 | 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) 13:52:23 INFO - PROCESS | 1681 | RSS: Main: 248434688 13:52:23 INFO - PROCESS | 1681 | 13:52:25 INFO - PROCESS | 1681 | 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) 13:52:25 INFO - PROCESS | 1681 | RSS: Main: 250048512 13:52:25 INFO - PROCESS | 1681 | 13:52:25 INFO - PROCESS | 1681 | __start_tp_report 13:52:25 INFO - PROCESS | 1681 | _x_x_mozilla_page_load 13:52:25 INFO - PROCESS | 1681 | _x_x_mozilla_page_load_details 13:52:25 INFO - PROCESS | 1681 | |i|pagename|runs| 13:52:25 INFO - PROCESS | 1681 | |0;ai-astar;117;118;125;118;116;133;119;122;134;175 13:52:25 INFO - PROCESS | 1681 | |1;audio-beat-detection;149;121;151;153;123;140;137;123;166;120 13:52:25 INFO - PROCESS | 1681 | |2;audio-dft;200;197;200;200;192;194;199;202;198;196 13:52:25 INFO - PROCESS | 1681 | |3;audio-fft;67;83;77;146;58;58;56;65;127;57 13:52:25 INFO - PROCESS | 1681 | |4;audio-oscillator;81;83;125;77;82;93;121;81;80;120 13:52:25 INFO - PROCESS | 1681 | |5;imaging-gaussian-blur;91;88;89;89;91;86;90;88;91;86 13:52:25 INFO - PROCESS | 1681 | |6;imaging-darkroom;95;97;95;94;100;95;102;151;97;95 13:52:25 INFO - PROCESS | 1681 | |7;imaging-desaturate;90;94;97;89;122;116;91;91;89;91 13:52:25 INFO - PROCESS | 1681 | |8;json-parse-financial;61;65;66;62;74;62;66;83;64;59 13:52:25 INFO - PROCESS | 1681 | |9;json-stringify-tinderbox;65;94;64;81;107;62;91;103;100;99 13:52:25 INFO - PROCESS | 1681 | |10;stanford-crypto-aes;84;81;82;83;81;84;80;85;83;86 13:52:25 INFO - PROCESS | 1681 | |11;stanford-crypto-ccm;139;134;178;154;162;137;153;140;170;139 13:52:25 INFO - PROCESS | 1681 | |12;stanford-crypto-pbkdf2;174;171;173;180;173;171;169;171;169;169 13:52:25 INFO - PROCESS | 1681 | |13;stanford-crypto-sha256-iterative;72;68;69;71;71;66;69;69;70;70 13:52:25 INFO - PROCESS | 1681 | __end_tp_report 13:52:25 INFO - PROCESS | 1681 | __start_cc_report 13:52:25 INFO - PROCESS | 1681 | _x_x_mozilla_cycle_collect,1101 13:52:25 INFO - PROCESS | 1681 | __end_cc_report 13:52:25 INFO - PROCESS | 1681 | __startTimestamp1461617545870__endTimestamp 13:52:25 INFO - PROCESS | 1681 | 13:52:25 INFO - PROCESS | 1681 | ------- Summary: start ------- 13:52:25 INFO - PROCESS | 1681 | Number of tests: 14 13:52:25 INFO - PROCESS | 1681 | 13:52:25 INFO - PROCESS | 1681 | [#0] ai-astar Cycles:10 Average:127.70 Median:123.50 stddev:17.83 (14.4%) stddev-sans-first:18.48 13:52:25 INFO - PROCESS | 1681 | Values: 117.0 118.0 125.0 118.0 116.0 133.0 119.0 122.0 134.0 175.0 13:52:25 INFO - PROCESS | 1681 | 13:52:25 INFO - PROCESS | 1681 | [#1] audio-beat-detection Cycles:10 Average:138.30 Median:144.50 stddev:16.21 (11.2%) stddev-sans-first:16.73 13:52:25 INFO - PROCESS | 1681 | Values: 149.0 121.0 151.0 153.0 123.0 140.0 137.0 123.0 166.0 120.0 13:52:25 INFO - PROCESS | 1681 | 13:52:25 INFO - PROCESS | 1681 | [#2] audio-dft Cycles:10 Average:197.80 Median:199.50 stddev:3.08 (1.5%) stddev-sans-first:3.17 13:52:25 INFO - PROCESS | 1681 | Values: 200.0 197.0 200.0 200.0 192.0 194.0 199.0 202.0 198.0 196.0 13:52:25 INFO - PROCESS | 1681 | 13:52:25 INFO - PROCESS | 1681 | [#3] audio-fft Cycles:10 Average:79.40 Median:61.50 stddev:31.70 (51.6%) stddev-sans-first:33.31 13:52:25 INFO - PROCESS | 1681 | Values: 67.0 83.0 77.0 146.0 58.0 58.0 56.0 65.0 127.0 57.0 13:52:25 INFO - PROCESS | 1681 | 13:52:25 INFO - PROCESS | 1681 | [#4] audio-oscillator Cycles:10 Average:94.30 Median:81.00 stddev:19.59 (24.2%) stddev-sans-first:20.18 13:52:25 INFO - PROCESS | 1681 | Values: 81.0 83.0 125.0 77.0 82.0 93.0 121.0 81.0 80.0 120.0 13:52:25 INFO - PROCESS | 1681 | 13:52:25 INFO - PROCESS | 1681 | [#5] imaging-gaussian-blur Cycles:10 Average:88.90 Median:89.50 stddev:1.91 (2.1%) stddev-sans-first:1.87 13:52:25 INFO - PROCESS | 1681 | Values: 91.0 88.0 89.0 89.0 91.0 86.0 90.0 88.0 91.0 86.0 13:52:25 INFO - PROCESS | 1681 | 13:52:25 INFO - PROCESS | 1681 | [#6] imaging-darkroom Cycles:10 Average:102.10 Median:95.00 stddev:17.37 (18.3%) stddev-sans-first:18.23 13:52:25 INFO - PROCESS | 1681 | Values: 95.0 97.0 95.0 94.0 100.0 95.0 102.0 151.0 97.0 95.0 13:52:25 INFO - PROCESS | 1681 | 13:52:25 INFO - PROCESS | 1681 | [#7] imaging-desaturate Cycles:10 Average:97.00 Median:91.00 stddev:11.93 (13.1%) stddev-sans-first:12.38 13:52:25 INFO - PROCESS | 1681 | Values: 90.0 94.0 97.0 89.0 122.0 116.0 91.0 91.0 89.0 91.0 13:52:25 INFO - PROCESS | 1681 | 13:52:25 INFO - PROCESS | 1681 | [#8] json-parse-financial Cycles:10 Average:66.20 Median:65.50 stddev:7.18 (11.0%) stddev-sans-first:7.36 13:52:25 INFO - PROCESS | 1681 | Values: 61.0 65.0 66.0 62.0 74.0 62.0 66.0 83.0 64.0 59.0 13:52:25 INFO - PROCESS | 1681 | 13:52:25 INFO - PROCESS | 1681 | [#9] json-stringify-tinderbox Cycles:10 Average:86.60 Median:73.00 stddev:17.34 (23.8%) stddev-sans-first:16.54 13:52:25 INFO - PROCESS | 1681 | Values: 65.0 94.0 64.0 81.0 107.0 62.0 91.0 103.0 100.0 99.0 13:52:25 INFO - PROCESS | 1681 | 13:52:25 INFO - PROCESS | 1681 | [#10] stanford-crypto-aes Cycles:10 Average:82.90 Median:83.50 stddev:1.91 (2.3%) stddev-sans-first:1.99 13:52:25 INFO - PROCESS | 1681 | Values: 84.0 81.0 82.0 83.0 81.0 84.0 80.0 85.0 83.0 86.0 13:52:25 INFO - PROCESS | 1681 | 13:52:25 INFO - PROCESS | 1681 | [#11] stanford-crypto-ccm Cycles:10 Average:150.60 Median:153.50 stddev:15.33 (10.0%) stddev-sans-first:15.68 13:52:25 INFO - PROCESS | 1681 | Values: 139.0 134.0 178.0 154.0 162.0 137.0 153.0 140.0 170.0 139.0 13:52:25 INFO - PROCESS | 1681 | 13:52:25 INFO - PROCESS | 1681 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.00 Median:172.00 stddev:3.33 (1.9%) stddev-sans-first:3.46 13:52:25 INFO - PROCESS | 1681 | Values: 174.0 171.0 173.0 180.0 173.0 171.0 169.0 171.0 169.0 169.0 13:52:25 INFO - PROCESS | 1681 | 13:52:25 INFO - PROCESS | 1681 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.50 Median:70.00 stddev:1.72 (2.5%) stddev-sans-first:1.56 13:52:25 INFO - PROCESS | 1681 | Values: 72.0 68.0 69.0 71.0 71.0 66.0 69.0 69.0 70.0 70.0 13:52:25 INFO - PROCESS | 1681 | -------- Summary: end -------- 13:52:25 INFO - PROCESS | 1681 | 13:52:26 INFO - TEST-INFO | 1681: exit 0 13:52:26 INFO - TEST-OK | kraken | took 59620ms 13:52:26 INFO - SUITE-END | took 1170s 13:52:27 INFO - Completed test suite (00:19:31) 13:52:27 INFO - javascript benchmark 13:52:27 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3222.9355412891728, 3395.185155562666, 3454.2227998700287, 3531.576210854696, 3538.4869193966865, 4875.293082503035, 5087.974560127194, 5676.318841738992, 5692.800751973682, 5742.109972954188, 5218.564894653972, 5424.566034717223, 5701.258836351269, 5768.077107662775, 5823.67969761663, 4588.931166032512, 5037.1940489521685, 5082.567981721568, 5147.4080480744815, 5238.92141617876, 4957.132501812169, 5013.0, 5168.121419358699, 5208.817691380802, 5214.634975551713, 5078.746062696869, 5157.303763991869, 5177.0, 5185.688858668492, 5200.947990520103, 4335.43639326887, 5119.513646203604, 5130.3074084998425, 5155.046316431435, 5155.690658560461, 5030.195168773015, 5084.56781173597, 5130.410002849682, 5184.8963020739375, 5237.502437268454, 5554.694491802949, 5556.277683901067, 5567.832965011056, 5592.692401917893, 5608.803691870806, 5971.313298970631, 6102.6948652567635, 6187.504999600022, 6212.782552610682, 6245.594036387665, 6249.125122482856, 6311.08489269058, 6315.589486683397, 6339.714712837887, 6340.080688300171, 5759.712014399305, 5781.862036658673, 5788.565857560699, 5804.332501762309, 5812.534997200214, 6176.505879529716, 6209.875802484015, 6250.4374606285655, 6278.811635650938, 6279.120923070774, 5563.7774489019985, 5761.423857614205, 6150.538709596798, 6158.168647232566, 6170.10533472653, 6209.782657606962, 6316.494680425555, 6318.778842740482, 6326.335734747785, 6329.746810127635, 6021.608595441282, 6140.324564297924, 6191.535634827406, 6209.813705588839, 6234.625922444668, 6228.5951413158, 6256.812295631138, 6267.4986001119805, 6270.404311590391, 6286.622802631857, 4867.9269810952865, 4918.385201849769, 4924.507549245047, 4930.383702037246, 4976.42771081323, 4311.741295522279, 4361.454818147731, 4388.71473354231, 4433.334999750064, 4472.575105364985, 5599.832005039855, 5665.150227465913, 5673.744681489343, 5687.118496633028, 5720.742566584514, 6117.082437634391, 6292.590981586182, 6336.20797400325, 6345.016522439029, 6347.143135676717, 5664.235328230719, 5713.800016999385, 5719.599628025998, 5725.2843394575675, 5732.7706891723865, 5354.170103633943, 5376.059189641797, 5378.973105134528, 5395.865103372447, 5398.6220964532895, 6243.375662433811, 6274.843128921813, 6303.3066362700065, 6372.139761132281, 6384.776532821329, 6111.327753947151, 6208.658523781235, 6249.906251406142, 6329.936700632935, 6339.651319177489, 6294.905576416266, 6339.809805705836, 6346.460550853045, 6352.968235158794, 6376.713047912948, 5992.760289588367, 6120.510359171345, 6168.568200225941, 6222.439980401786, 6230.906536401867, 6188.845278868064, 6246.968765156145, 6258.311585725658, 6261.092141639528, 6268.905966410599, 5645.435456454322, 5680.971595141998, 6077.604955677867, 6137.41694539018, 6151.200343955257, 5884.852878678067, 6060.969695151496, 6124.411449640054, 6128.295246046583, 6135.0, 4506.616937560213, 5849.064149736022, 5870.853228669317, 5891.38140495259, 5915.70421478933, 6074.119252708244, 6076.756929722762, 6089.421504957022, 6093.482054025458, 6100.603460775035, 5778.191053252632, 5901.409859014236, 5935.228420305332, 6004.969975150097, 6033.336333003278], "value": 5650.555913220486, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [502.12880652068657, 510.43596825507814, 551.6000899347973, 575.3297408519077, 581.2501872584367, 38488.23023539528, 39458.210835783306, 39537.802310988474, 39560.40659390111, 39611.40582891259, 40774.0, 40946.59053409465, 41581.58418415815, 41622.0, 41744.58255417452, 9536.046395360478, 9676.225901927864, 9759.365641233297, 9788.265880058989, 9807.26445516589, 9718.416894986323, 9741.659041933533, 9844.310898237127, 9884.555195016206, 9891.357061790997, 9826.164775994013, 9877.555510002032, 9879.506024698772, 9882.901170988305, 9903.257255705816, 9791.06984836443, 9811.313208075437, 9880.505974701236, 9886.307958442912, 9943.403395796275, 9655.806883862284, 9728.41629502225, 9736.75658108546, 9761.365511241818, 9764.170045546138, 40054.0, 40507.79746101251, 40522.18955620871, 40642.59357406418, 40670.0, 3461.8615255389755, 3492.930141397158, 3660.0, 3832.3868181090893, 3851.7111216658864, 29057.12828615145, 29182.416351672848, 29474.85262573695, 29557.408851823056, 29562.556561651592, 2751.119641714652, 2778.7776977841927, 2797.5663772115354, 2802.383475635357, 2824.209221418006, 343001.0, 348630.0, 349326.0, 350252.2487387572, 470625.0, 64982.025269620994, 66843.33156668372, 67553.0, 67801.32198678049, 68066.0, 62120.68939655273, 63074.0538891917, 65183.67408162929, 70402.29597703957, 70812.64593676999, 17510.387136450165, 17724.55688607795, 17725.822741772416, 17728.290868365122, 17777.022263775358, 13344.933275333562, 13383.598492045254, 13420.932895335656, 13474.19154850712, 13490.86509134896, 16600.584985375463, 19992.800071999092, 20246.595068098555, 20326.59346813085, 20337.0, 6462.773802916875, 7160.462965277625, 8254.42219044661, 8290.875636865452, 8304.6678132874, 908.6683360573343, 1005.1054561440324, 1014.5434554450527, 1058.1481907064733, 1082.8821324448165, 28100.875964961582, 28967.855160724062, 30674.0, 30809.2297692555, 30815.0, 1084.3819023156725, 1097.3306283167262, 1112.9499172537255, 1113.2207454781685, 1205.7829590673587, 15669.373225071098, 15807.0, 15853.365865365256, 15882.523524294289, 16125.0, 619012.0, 620874.0, 621349.0, 628747.0, 630890.0, 61812.0, 62751.6862415685, 62801.0, 62873.0, 62912.68543657252, 1470.1399681186413, 1493.8506149384975, 1497.5956491747168, 1498.4006397441328, 1503.3986405437913, 29464.263393415335, 29902.850485748302, 30019.849900750356, 30513.847430762704, 30668.926587569327, 54381.72809135929, 54651.72674136604, 54827.451725482235, 55064.17403739027, 55104.448955511536, 558461.0, 565652.0, 576284.0, 579009.0, 579527.0, 26240.08159714401, 26504.602430963165, 26668.733312666624, 26726.59910101389, 27196.184114475807, 43390.0, 44174.0, 44438.55561444473, 46466.583850931675, 47351.52648473471, 38090.0477488065, 38867.222655547295, 38895.222095557365, 39260.214795704494, 40162.598374015884, 37864.81067594644, 38455.0, 39016.82949511519, 39039.6096039036, 39154.4126838092, 36967.26065478729, 38292.61707382891, 38299.617003829604, 38590.614093858705, 38767.6123238764, 32799.67200327966, 33484.00937983355, 34044.31911361808, 34087.147821304665, 34232.82883585566, 21187.0, 25485.23544293674, 25652.743472565035, 25731.742682572934, 25967.74032259653], "value": 20206.097306674583, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [362.4400301534131, 392.8899908025753, 393.93893946438305, 400.39540294155813, 409.8708906694389, 17608.91195544024, 19441.513962150937, 20241.898790506064, 21582.892085539588, 21589.56820863584, 9223.031581683927, 12050.21673591216, 12101.576444824412, 12283.44724487398, 12346.691332716686, 5364.91952620711, 5592.552595792347, 5632.26780518532, 5639.182318563806, 5677.886442271152, 3941.7043721720843, 5877.52979761618, 6109.847253818646, 6185.350538193492, 6217.968910155466, 5954.689968206988, 6124.663143527104, 6166.136740856284, 6179.907301390483, 6185.8144255672405, 6081.3614570470345, 6171.074338849164, 6173.074038894157, 6174.475169610589, 6204.503639708812, 5239.397469291042, 5707.286589176353, 5764.654120752768, 5971.343152253248, 6052.72762725674, 13550.59348219555, 13580.660483487893, 13679.179249245077, 17730.556736081573, 24457.633135502983, 2126.9787302126933, 2134.519733060049, 2170.066871245364, 2241.5628952354296, 2250.2124256510256, 9991.650292239809, 10065.24510661696, 10261.79476410475, 13108.0, 14286.64283392913, 1711.4523352527196, 1742.0766993493341, 1759.5073379453772, 1760.8239176082418, 1772.7252275897256, 132284.0, 133821.33089334588, 134811.0, 136753.3162334192, 139308.0, 11805.17363784544, 11946.820797688042, 11999.880001199876, 12024.278543287432, 12085.335306558049, 15105.0, 15354.769678454832, 15443.845561544465, 15471.14908680011, 15528.223588820514, 8877.955610221907, 8881.73354799357, 8895.73312800604, 8945.987152890548, 9033.548322583845, 8619.051904290523, 8721.956390218134, 8730.214280714767, 8749.912500875038, 8851.0, 4657.86026419208, 4676.672632915731, 4686.109639168547, 4718.079974404958, 4721.457032441244, 1817.273090763705, 1883.2843519462517, 1978.3570339639675, 1980.2178139634764, 2004.9498762530761, 886.8935727712716, 1009.742515658517, 1009.8081364540714, 1038.9896101038894, 1069.4599227390117, 18077.63844723098, 19273.614527709648, 19799.60400791976, 19893.0, 19960.401187964384, 946.6592026870321, 968.0222974795366, 974.5809302000066, 987.3335498538457, 1002.6440613582073, 10569.101626361691, 10782.299150555189, 10806.837897431546, 10814.675559733221, 10859.457027148768, 582471.0, 584379.0, 585719.0, 585745.0, 611432.8285075728, 90538.0, 90616.0, 94129.0, 124086.0, 126663.0, 881.4358810361374, 979.5543027922279, 984.1929617713406, 988.3131223799534, 1011.1354791653031, 17842.46472605824, 18022.729659055385, 18155.092245387943, 18181.909085454387, 18212.908935455238, 48084.7595762019, 48861.51138488712, 49208.50791492182, 49224.0, 49296.50703492919, 70355.64822176061, 72716.0, 73216.63391683008, 73864.0, 73923.0, 7723.420743444377, 8005.679772809022, 8128.715494957648, 8128.715494957884, 8493.617787199468, 10232.744181395525, 11657.766844663229, 12668.176568523017, 12824.807627885775, 12916.22502649844, 11013.944930275296, 11019.449027548751, 11313.981741643292, 11368.488418021043, 11451.828222576502, 10424.0, 10507.737306567396, 10677.985591368808, 10917.344959302467, 10950.39772812503, 10344.431056291976, 10633.096186824207, 10922.890771092505, 11045.0, 11344.602938897098, 7348.971144039946, 7910.090339611018, 8090.919090809017, 8209.64540850753, 8453.154684531497, 7741.1871753465075, 9383.441683735426, 9662.661806836726, 9717.22262219035, 11004.229703920648], "value": 9258.352606233319, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1568.435363269223, 1617.9352825886965, 1794.883332583382, 1835.5686413692788, 1847.6674198644248, 8030.51816890987, 8607.13928607139, 8661.913380866197, 9023.819523609523, 9033.096690330973, 8633.95683021584, 8704.869426958601, 8759.693410730626, 8789.824203515926, 8796.648134074629, 2438.7317395086525, 2447.3025187821386, 2466.8273220874544, 2471.4315707387223, 2479.82641215115, 2431.3556907419547, 2466.3957330454064, 2482.7641374069435, 2484.229888734498, 2487.4154573675173, 2428.2108314797674, 2431.051889762994, 2490.3898544856534, 2493.376655836041, 2503.5118151960373, 2457.103157347573, 2459.1515927005244, 2459.6064629659168, 2465.3343597228736, 2482.640017197505, 2444.8533088014774, 2453.8895749691305, 2458.606622940321, 2466.666999955001, 2480.6155045967903, 8774.25418839393, 8843.115688431106, 8964.417312874642, 8968.013518512958, 8969.789078474389, 5191.325127733408, 5365.678059316415, 5387.1380579107545, 5387.838364849061, 5405.27028851104, 3438.4670376091494, 3500.0724807925667, 3525.048236976002, 3545.840437180333, 3692.316921369555, 1025.1132770153838, 1046.272840375939, 1053.3521884041259, 1073.6617965340893, 1076.7200527862733, 11237.943810280896, 11331.943340283327, 11420.486078126503, 11423.086153107732, 11445.65663030102, 4369.69412141147, 4398.978005110018, 4461.665375096816, 4463.0, 4511.300748384006, 9071.81856362869, 9136.994930557634, 9140.177384035469, 9150.86273705895, 9161.083891610786, 5146.0479811235045, 5186.196139598368, 5187.481251874782, 5215.13950198213, 5219.869503262449, 4482.731036137842, 4833.589144922721, 4918.065567542156, 4963.156263435225, 4967.925481117786, 3837.501124853807, 3873.341531939577, 3924.175923056133, 3952.7825969571372, 3981.761094334291, 1224.2715584227371, 1224.8101544260653, 1226.7975783995541, 1226.9325187114616, 1238.3189245914712, 847.2459511035183, 917.8485549884194, 948.0424770981358, 948.3503799897093, 961.4663861556903, 5848.853778655568, 5945.316288626776, 5985.281766188085, 5987.042073268256, 6132.8773424532155, 440.482433141058, 458.2484725050919, 460.2061444009124, 468.29755366949576, 472.0865125981169, 3976.926229917906, 3983.203359328146, 3996.9200615987515, 4051.0, 4094.3244364679495, 10147.64483243083, 10904.61833835812, 10923.781524369468, 10926.726831829108, 11067.0, 10462.843057354146, 10692.198085143646, 10823.404712740718, 10872.18458615607, 10892.01971822524, 7970.0, 8068.435209535393, 8073.959630201812, 8149.429539932148, 8207.71273005442, 4376.387305777257, 5035.345405097461, 5759.94240057594, 5935.584509084495, 6100.267967843887, 9512.525558538438, 9936.105750482491, 9976.50117494137, 10082.6471073515, 10165.695029149138, 8317.750467485985, 10098.444585547866, 10107.69676909694, 10266.845997310196, 10363.948180259353, 6289.276733175743, 6771.593704377556, 6978.651067446709, 7020.964895175492, 7084.539504932163, 8213.260806527202, 8252.968378952632, 8312.0, 8353.289970352587, 8361.122082181284, 7270.600116993616, 7473.8878916817375, 7511.286427789351, 7602.049743782028, 7616.657250423855, 7199.928000719926, 7297.379722723628, 7301.452391070798, 7371.262873712586, 7434.962825186056, 5948.434898684618, 6962.582245065312, 7009.474289428415, 7056.329648683367, 7090.893636595559, 4852.967527425449, 4939.703617782944, 4982.20284754452, 5000.324956131021, 5016.949830501794, 4879.756012199305, 4883.36516252899, 4910.386201724785, 5031.622628302819, 5149.665271757323], "value": 4495.486704757183, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [304.48086013347245, 309.7769605883763, 318.03000847415376, 318.84536000039975, 319.93121478882034, 4575.032735923552, 4842.4988253641395, 4865.978144589636, 5148.227765835127, 5505.559555235582, 5119.2833003379465, 5440.0, 5481.409676661793, 5538.307711536058, 5547.0, 3486.6164721880573, 3664.102294937744, 3676.7610105343133, 3780.8638119462553, 4025.476688030552, 4213.620774130328, 4229.287138708828, 4236.682248831335, 4238.969137066996, 4257.574242575749, 3880.8177294618426, 4114.8971275718195, 4134.421181034658, 4152.8131234094535, 4161.771102589357, 3598.8920332389807, 3616.5768934813605, 4036.0, 4081.632653061209, 4155.522114956789, 2983.358577905739, 3262.6574209708115, 3542.6634469725336, 3565.180008598037, 3596.9820150899077, 4561.384213131251, 4882.633802464829, 5062.873428164326, 5274.472552744734, 5296.867578310535, 4165.479315085614, 4710.0, 4723.645726570521, 4728.338032675429, 4764.404449443819, 5292.655977361459, 5753.0, 5776.555861034742, 5779.884402311972, 5826.446487583673, 3692.4276737105793, 3893.9610603894166, 3913.7456065355946, 3915.2169566086895, 3946.980265098685, 5083.364579427572, 5244.134717771563, 5543.6119471637, 6019.103982245622, 6070.392960703938, 3742.3450896093077, 3940.2316548273384, 3951.328274193394, 3974.847294284625, 4002.939955900664, 3360.428727116396, 3411.556497655289, 4017.2367250222364, 4049.9392509112386, 4071.7353372030725, 4207.936880946788, 4374.4094547236355, 4715.198416269242, 4742.399872124034, 4744.620430365562, 5058.317127187856, 5227.451117632594, 5291.126964050888, 5641.335805937259, 5840.649561026352, 1442.451868290064, 1459.4162335065846, 1469.860363265488, 1470.691154857492, 1471.4776254429737, 863.7451951674271, 926.2682480840195, 957.9568919398644, 958.7363475044418, 975.0834215837091, 5007.474215207423, 5093.439721630618, 5725.85482903421, 5773.971130144322, 5838.941610583925, 6459.967700161469, 6473.546851720334, 6485.687018132889, 6487.086309538698, 6516.771912983023, 5357.892842143213, 5553.527950124204, 5683.8010669626365, 5850.444207800252, 5853.970730146322, 2803.8738256778493, 3386.170388254844, 3414.641462646436, 3437.2609888874013, 3453.430184019659, 5890.9410905891245, 5929.555283353766, 6333.493320534346, 6749.662516874137, 6764.5603035802515, 5326.121190003606, 6028.879422411527, 6254.498920259105, 6273.341299163613, 6308.968455157695, 4912.508749125059, 5050.368703912011, 5428.5928555358505, 6292.182016337847, 6383.904241436382, 5731.656100633975, 6044.697765111815, 6060.78787242462, 6076.174578820869, 6076.270847498152, 4411.977940110279, 5960.672163031075, 6004.369541198112, 6024.849378765566, 6062.818115456544, 5189.558887494605, 5902.61632993854, 6016.8796624068145, 6171.297221667143, 6284.5600807943, 3298.868045278162, 3920.7059470540394, 3925.5681874994298, 3941.7832019239218, 3947.7631342119566, 5266.210068489757, 5806.796762113306, 5916.822495325147, 5932.79235226765, 6073.331933487401, 5224.425313215467, 5468.316460442445, 5893.349862038636, 5905.232319798399, 5917.792877249448, 5427.864303392289, 5842.896557239305, 5859.0, 5894.410558944071, 5924.407559244213, 4730.716157030589, 4801.567858892717, 5503.944960550503, 5645.81437898046, 5646.491815736604, 5709.3719690834805, 5792.594518383673, 5816.243888294494, 5818.50542703858, 5828.184054232326, 5019.924701129559, 5629.690367029689, 5687.744051517609, 5695.857603559944, 5740.483356497935], "value": 4234.915543024542, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [659.2188256915555, 714.3891972363629, 720.1861896057458, 753.3445902065204, 755.3805879179074, 14530.564083077512, 14691.0, 15079.773803392958, 15112.0, 15153.39386424543, 13745.175289482613, 13877.959153063535, 13892.305384730747, 13905.304734763247, 13947.721045579083, 726.397090414957, 896.865470179475, 903.2322525853021, 922.6217250927122, 923.3582660051267, 893.2452077994117, 914.4924566865387, 920.7099763574486, 927.1007123090591, 928.2713070239863, 974.790420059687, 975.7755716185281, 978.7210644966186, 979.8628192053118, 981.1267971505366, 928.9363678588046, 932.9020452852454, 942.6323733743777, 961.9663311784124, 971.1259866120478, 692.9688164032631, 695.151914664109, 712.5154894671621, 726.1032624708481, 727.1419724724823, 14879.776803347959, 14883.479078232318, 14925.328360223708, 14944.40222391103, 15000.099994000286, 10994.34033957957, 12319.260844349368, 12450.688732781753, 12524.937375313066, 12609.00657515743, 9590.184834289093, 9781.657641982567, 9830.852537211877, 9894.851577226347, 9905.455199963999, 3458.360203362386, 3463.930721385583, 3511.666391692785, 3571.8749843755604, 3680.871169509054, 88699.11300887038, 89580.0, 89840.55079724625, 89879.0, 91641.54179229127, 9278.072192780668, 9436.386634868712, 9501.857472137923, 9623.807523849484, 9666.130048295687, 21194.682079768507, 21763.347099587038, 21788.56422871534, 22031.889840551015, 22668.0, 7280.343470625376, 7284.8178795529475, 7336.0, 7488.812779680443, 7529.962350188214, 3971.6624086952356, 4046.838126474908, 4060.0864805418546, 4114.814833332507, 4155.501339839178, 3537.6285490023693, 3563.2160924596546, 3578.7494875358475, 3625.8549658013912, 3631.092226943264, 642.5983760149907, 642.9164208652845, 643.3341491556217, 656.7734131724548, 667.0261418329294, 546.1834557336807, 592.7806711516766, 593.6141508019736, 595.1073389915127, 630.1839118341759, 8290.792730181673, 8322.126176751475, 8393.790155246046, 8443.493390396596, 8466.153384661608, 558.1432501110856, 559.560744815318, 593.0955293177852, 624.996875015622, 627.799104286633, 3785.072657199004, 3938.2517321708783, 3968.940465893014, 4004.65960393364, 4015.2170326785995, 70355.64822175959, 87063.0, 94293.0, 103915.48042259741, 106644.0, 69656.56202033006, 76193.23806761861, 80906.59546702229, 81491.5925420381, 82366.58816705998, 74610.76167714977, 74614.5077098455, 74678.6266068677, 74774.6261268701, 75100.0, 8152.877706834283, 8292.17078292166, 8407.45351552147, 8466.195711407407, 8482.982042154981, 44438.555614443445, 45413.63759087233, 45978.54021459743, 46627.0, 46781.766091169324, 56204.71897640649, 58217.41782582289, 59066.70466647639, 61511.15466536011, 61720.38279617326, 9114.726558203265, 11108.88891111111, 11161.218714689894, 11383.487743051417, 11985.580504682293, 12019.278843269432, 12027.639170824888, 12028.939855300667, 12206.633800985985, 12464.750704985669, 11287.548498059985, 11361.54553817838, 11514.712132196762, 11530.423478826193, 11612.825807612724, 11336.546538138382, 11348.54605815758, 11376.203665743318, 11395.487203076047, 11439.14206434504, 11090.85293560898, 11245.606403775828, 11320.26418282809, 11324.001949841091, 11653.592124275949, 9412.294077944318, 9480.288978326791, 9591.9040809591, 9607.903920960702, 9779.26655500826, 8845.646174153218, 9383.249340052917, 9460.479673617741, 9585.892609471028, 9587.185089267212], "value": 6908.268711610588, "unit": "score"}], "name": "dromaeo_css", "value": 7197.647022395041, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 125.0, 118.0, 116.0, 133.0, 119.0, 122.0, 134.0, 175.0], "value": 127.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 121.0, 151.0, 153.0, 123.0, 140.0, 137.0, 123.0, 166.0, 120.0], "value": 138.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [200.0, 197.0, 200.0, 200.0, 192.0, 194.0, 199.0, 202.0, 198.0, 196.0], "value": 197.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 83.0, 77.0, 146.0, 58.0, 58.0, 56.0, 65.0, 127.0, 57.0], "value": 79.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 83.0, 125.0, 77.0, 82.0, 93.0, 121.0, 81.0, 80.0, 120.0], "value": 94.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 88.0, 89.0, 89.0, 91.0, 86.0, 90.0, 88.0, 91.0, 86.0], "value": 88.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 97.0, 95.0, 94.0, 100.0, 95.0, 102.0, 151.0, 97.0, 95.0], "value": 102.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 94.0, 97.0, 89.0, 122.0, 116.0, 91.0, 91.0, 89.0, 91.0], "value": 97.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 65.0, 66.0, 62.0, 74.0, 62.0, 66.0, 83.0, 64.0, 59.0], "value": 66.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 94.0, 64.0, 81.0, 107.0, 62.0, 91.0, 103.0, 100.0, 99.0], "value": 86.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 81.0, 82.0, 83.0, 81.0, 84.0, 80.0, 85.0, 83.0, 86.0], "value": 82.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 134.0, 178.0, 154.0, 162.0, 137.0, 153.0, 140.0, 170.0, 139.0], "value": 150.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 171.0, 173.0, 180.0, 173.0, 171.0, 169.0, 171.0, 169.0, 169.0], "value": 172.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 68.0, 69.0, 71.0, 71.0, 66.0, 69.0, 69.0, 70.0, 70.0], "value": 69.5, "unit": "score"}], "name": "kraken", "value": 1553.3, "alertThreshold": 2.0}]} 13:52:27 INFO - Return code: 0 13:52:27 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 13:52:27 ERROR - # TBPL SUCCESS # 13:52:27 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 13:52:27 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 13:52:27 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 13:52:27 INFO - 2016-04-25 13:52:27.173 screenresolution[1686:10353] starting screenresolution argv=screenresolution get 13:52:27 INFO - 2016-04-25 13:52:27.176 screenresolution[1686:10353] Display 0: 1600x1200x32@60 13:52:27 INFO - 2016-04-25 13:52:27.181 screenresolution[1687:10356] starting screenresolution argv=screenresolution list 13:52:27 INFO - Available Modes on Display 0 13:52:27 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 13:52:27 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 13:52:27 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 13:52:27 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 13:52:27 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 13:52:27 INFO - Intel Iris: 13:52:27 INFO - Chipset Model: Intel Iris 13:52:27 INFO - Type: GPU 13:52:27 INFO - Bus: Built-In 13:52:27 INFO - VRAM (Dynamic, Max): 1536 MB 13:52:27 INFO - Vendor: Intel (0x8086) 13:52:27 INFO - Device ID: 0x0a2e 13:52:27 INFO - Revision ID: 0x0009 13:52:27 INFO - Displays: 13:52:27 INFO - Display: 13:52:27 INFO - Resolution: 1600 x 1200 @ 60 Hz 13:52:27 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 13:52:27 INFO - Display Serial Number: 1600x1200 60 13:52:27 INFO - Main Display: Yes 13:52:27 INFO - Mirror: Off 13:52:27 INFO - Online: Yes 13:52:27 INFO - Rotation: Supported 13:52:27 INFO - Return code: 0 13:52:27 INFO - Running post-action listener: _resource_record_post_action 13:52:27 INFO - Running post-run listener: _resource_record_post_run 13:52:28 INFO - Total resource usage - Wall time: 1205s; CPU: 54.0%; Read bytes: 37922304; Write bytes: 655613440; Read time: 397; Write time: 2058 13:52:28 INFO - install - Wall time: 32s; CPU: 55.0%; Read bytes: 359756288; Write bytes: 356476416; Read time: 27886; Write time: 753 13:52:28 INFO - run-tests - Wall time: 1173s; CPU: 54.0%; Read bytes: 30875136; Write bytes: 298129408; Read time: 305; Write time: 1300 13:52:28 INFO - Running post-run listener: _upload_blobber_files 13:52:28 INFO - Blob upload gear active. 13:52:28 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:52:28 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 13:52:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 13:52:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 13:52:28 INFO - (blobuploader) - INFO - Open directory for files ... 13:52:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 13:52:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:52:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:52:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 13:52:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:52:30 INFO - (blobuploader) - INFO - Done attempting. 13:52:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 13:52:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:52:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:52:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 13:52:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:52:31 INFO - (blobuploader) - INFO - Done attempting. 13:52:31 INFO - (blobuploader) - INFO - Iteration through files over. 13:52:31 INFO - Return code: 0 13:52:31 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:52:31 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:52:31 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3514cd2cad49ad2525127ad932f3a521b3d1bd2378ffe0049eb14148015fa603d22283f7402ad6c111a9aa2f7dabb1a81883f30c26cb65156ce8618bf132bc21", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/edff6a3e178cb20c657ed9b11660315c49229289b89ac55da6fa141c2f626a2aa6b9f70de3c2f1bd43174c88d568079acd744d73273e9979a7c2f2746831433a"} 13:52:31 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:52:31 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:52:31 INFO - Contents: 13:52:31 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3514cd2cad49ad2525127ad932f3a521b3d1bd2378ffe0049eb14148015fa603d22283f7402ad6c111a9aa2f7dabb1a81883f30c26cb65156ce8618bf132bc21", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/edff6a3e178cb20c657ed9b11660315c49229289b89ac55da6fa141c2f626a2aa6b9f70de3c2f1bd43174c88d568079acd744d73273e9979a7c2f2746831433a"} 13:52:31 INFO - Running post-run listener: copy_logs_to_upload_dir 13:52:31 INFO - Copying logs to upload dir... 13:52:31 INFO - mkdir: /builds/slave/test/build/upload/logs 13:52:31 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1261.997090 ========= master_lag: 4.62 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2016-04-25 13:52:35.873249) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 3 secs) (at 2016-04-25 13:52:35.874913) ========= 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.u0flkajzJ2/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.FYCdulBKvA/Listeners TMPDIR=/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3514cd2cad49ad2525127ad932f3a521b3d1bd2378ffe0049eb14148015fa603d22283f7402ad6c111a9aa2f7dabb1a81883f30c26cb65156ce8618bf132bc21", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/edff6a3e178cb20c657ed9b11660315c49229289b89ac55da6fa141c2f626a2aa6b9f70de3c2f1bd43174c88d568079acd744d73273e9979a7c2f2746831433a"} build_url:https://queue.taskcluster.net/v1/task/MTnAsegCRLKbQhmwYdMOFQ/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011022 build_url: 'https://queue.taskcluster.net/v1/task/MTnAsegCRLKbQhmwYdMOFQ/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3514cd2cad49ad2525127ad932f3a521b3d1bd2378ffe0049eb14148015fa603d22283f7402ad6c111a9aa2f7dabb1a81883f30c26cb65156ce8618bf132bc21", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/edff6a3e178cb20c657ed9b11660315c49229289b89ac55da6fa141c2f626a2aa6b9f70de3c2f1bd43174c88d568079acd744d73273e9979a7c2f2746831433a"}' ========= master_lag: 3.74 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 3 secs) (at 2016-04-25 13:52:39.625059) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 9 secs) (at 2016-04-25 13:52:39.625445) ========= 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.u0flkajzJ2/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.FYCdulBKvA/Listeners TMPDIR=/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/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.005188 ========= master_lag: 9.16 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 9 secs) (at 2016-04-25 13:52:48.786988) ========= ========= Started reboot skipped (results: 3, elapsed: 4 secs) (at 2016-04-25 13:52:48.787394) ========= ========= Finished reboot skipped (results: 3, elapsed: 4 secs) (at 2016-04-25 13:52:53.202539) ========= ========= Total master_lag: 17.57 =========