builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0053 starttime: 1463045697.61 results: success (0) buildid: 20160512003019 builduid: 6190de9d76c34711888889c62d5ead4b revision: 13f145c74a334e53c13ca67eb5ec09d141a4af67 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-12 02:34:57.608736) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-12 02:34:57.609484) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-12 02:34:57.609809) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-12 02:34:57.631481) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-12 02:34:57.632235) ========= 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.dxlwsU3iJd/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.M2cLfD0gwi/Listeners TMPDIR=/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/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-05-12 02:34:57-- 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% 19.7M=0.001s 2016-05-12 02:34:57 (19.7 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.147957 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-12 02:34:57.799756) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-12 02:34:57.800104) ========= 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.dxlwsU3iJd/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.M2cLfD0gwi/Listeners TMPDIR=/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/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.025997 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-12 02:34:57.851178) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-12 02:34:57.851982) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 13f145c74a334e53c13ca67eb5ec09d141a4af67 --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-beta --rev 13f145c74a334e53c13ca67eb5ec09d141a4af67 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.dxlwsU3iJd/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.M2cLfD0gwi/Listeners TMPDIR=/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/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-05-12 02:34:57,926 truncating revision to first 12 chars 2016-05-12 02:34:57,926 Setting DEBUG logging. 2016-05-12 02:34:57,926 attempt 1/10 2016-05-12 02:34:57,926 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/13f145c74a33?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-12 02:34:58,567 unpacking tar archive at: mozilla-beta-13f145c74a33/testing/mozharness/ program finished with exit code 0 elapsedTime=1.055986 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-12 02:34:58.928480) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-12 02:34:58.929246) ========= script_repo_revision: 13f145c74a334e53c13ca67eb5ec09d141a4af67 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-12 02:34:58.930209) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-12 02:34:58.930873) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-12 02:34:58.947819) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2016-05-12 02:34:58.948644) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.dxlwsU3iJd/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.M2cLfD0gwi/Listeners TMPDIR=/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 02:34:59 INFO - MultiFileLogger online at 20160512 02:34:59 in /builds/slave/test 02:34:59 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 02:34:59 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:34:59 INFO - {'append_to_log': False, 02:34:59 INFO - 'base_work_dir': '/builds/slave/test', 02:34:59 INFO - 'blob_upload_branch': 'Mozilla-Beta', 02:34:59 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:34:59 INFO - 'branch': 'Mozilla-Beta', 02:34:59 INFO - 'buildbot_json_path': 'buildprops.json', 02:34:59 INFO - 'config_files': ('talos/mac_config.py',), 02:34:59 INFO - 'default_actions': ('clobber', 02:34:59 INFO - 'read-buildbot-config', 02:34:59 INFO - 'download-and-extract', 02:34:59 INFO - 'populate-webroot', 02:34:59 INFO - 'create-virtualenv', 02:34:59 INFO - 'install', 02:34:59 INFO - 'run-tests'), 02:34:59 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:34:59 INFO - 'download_minidump_stackwalk': True, 02:34:59 INFO - 'download_symbols': 'ondemand', 02:34:59 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:34:59 INFO - 'tooltool.py': '/tools/tooltool.py', 02:34:59 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:34:59 INFO - '/tools/misc-python/virtualenv.py')}, 02:34:59 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:34:59 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:34:59 INFO - 'installer_path': 'installer.exe', 02:34:59 INFO - 'log_level': 'info', 02:34:59 INFO - 'log_name': 'talos', 02:34:59 INFO - 'log_to_console': True, 02:34:59 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 02:34:59 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 02:34:59 INFO - 'opt_config_files': (), 02:34:59 INFO - 'pip_index': False, 02:34:59 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:34:59 INFO - 'cmd': ('bash', 02:34:59 INFO - '-c', 02:34:59 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:34:59 INFO - 'enabled': True, 02:34:59 INFO - 'halt_on_failure': False, 02:34:59 INFO - 'name': 'check_screen_resolution'},), 02:34:59 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:34:59 INFO - 'cmd': ('bash', 02:34:59 INFO - '-c', 02:34:59 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:34:59 INFO - 'enabled': True, 02:34:59 INFO - 'halt_on_failure': False, 02:34:59 INFO - 'name': 'check_screen_resolution'},), 02:34:59 INFO - 'run_cmd_checks_enabled': True, 02:34:59 INFO - 'sps_profile': False, 02:34:59 INFO - 'sps_profile_interval': 0, 02:34:59 INFO - 'suite': 'dromaeojs', 02:34:59 INFO - 'system_bits': '32', 02:34:59 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:34:59 INFO - 'title': 't-yosemite-r7-0053', 02:34:59 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:34:59 INFO - 'use_talos_json': True, 02:34:59 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:34:59 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:34:59 INFO - 'work_dir': 'build'} 02:34:59 INFO - ##### 02:34:59 INFO - ##### Running clobber step. 02:34:59 INFO - ##### 02:34:59 INFO - Running pre-action listener: _resource_record_pre_action 02:34:59 INFO - Running main action method: clobber 02:34:59 INFO - rmtree: /builds/slave/test/build 02:34:59 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:35:00 INFO - Running post-action listener: _resource_record_post_action 02:35:00 INFO - ##### 02:35:00 INFO - ##### Running read-buildbot-config step. 02:35:00 INFO - ##### 02:35:00 INFO - Running pre-action listener: _resource_record_pre_action 02:35:00 INFO - Running main action method: read_buildbot_config 02:35:00 INFO - Using buildbot properties: 02:35:00 INFO - { 02:35:00 INFO - "project": "", 02:35:00 INFO - "product": "firefox", 02:35:00 INFO - "script_repo_revision": "production", 02:35:00 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 02:35:00 INFO - "repository": "", 02:35:00 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 02:35:00 INFO - "buildid": "20160512003019", 02:35:00 INFO - "pgo_build": "False", 02:35:00 INFO - "basedir": "/builds/slave/test", 02:35:00 INFO - "buildnumber": 9, 02:35:00 INFO - "slavename": "t-yosemite-r7-0053", 02:35:00 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 02:35:00 INFO - "platform": "yosemite_r7", 02:35:00 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 02:35:00 INFO - "branch": "mozilla-beta", 02:35:00 INFO - "repo_path": "releases/mozilla-beta", 02:35:00 INFO - "revision": "13f145c74a334e53c13ca67eb5ec09d141a4af67", 02:35:00 INFO - "stage_platform": "macosx64", 02:35:00 INFO - "builduid": "6190de9d76c34711888889c62d5ead4b", 02:35:00 INFO - "slavebuilddir": "test" 02:35:00 INFO - } 02:35:00 INFO - Found installer url https://queue.taskcluster.net/v1/task/FMxRyLb7RbKJquwN8ScKGw/artifacts/public/build/firefox-47.0.en-US.mac.dmg. 02:35:00 INFO - Running post-action listener: _resource_record_post_action 02:35:00 INFO - ##### 02:35:00 INFO - ##### Running download-and-extract step. 02:35:00 INFO - ##### 02:35:00 INFO - Running pre-action listener: _resource_record_pre_action 02:35:00 INFO - Running main action method: download_and_extract 02:35:00 INFO - mkdir: /builds/slave/test/build/tests 02:35:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:35:00 INFO - https://queue.taskcluster.net/v1/task/FMxRyLb7RbKJquwN8ScKGw/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json matches https://queue.taskcluster.net 02:35:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FMxRyLb7RbKJquwN8ScKGw/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json 02:35:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FMxRyLb7RbKJquwN8ScKGw/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json 02:35:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FMxRyLb7RbKJquwN8ScKGw/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-47.0.en-US.mac.test_packages.json 02:35:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FMxRyLb7RbKJquwN8ScKGw/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-47.0.en-US.mac.test_packages.json'}, attempt #1 02:35:01 INFO - Downloaded 1241 bytes. 02:35:01 INFO - Reading from file /builds/slave/test/build/firefox-47.0.en-US.mac.test_packages.json 02:35:01 INFO - Using the following test package requirements: 02:35:01 INFO - {u'common': [u'firefox-47.0.en-US.mac.common.tests.zip'], 02:35:01 INFO - u'cppunittest': [u'firefox-47.0.en-US.mac.common.tests.zip', 02:35:01 INFO - u'firefox-47.0.en-US.mac.cppunittest.tests.zip'], 02:35:01 INFO - u'gtest': [u'firefox-47.0.en-US.mac.common.tests.zip', 02:35:01 INFO - u'firefox-47.0.en-US.mac.gtest.tests.zip'], 02:35:01 INFO - u'jittest': [u'firefox-47.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 02:35:01 INFO - u'mochitest': [u'firefox-47.0.en-US.mac.common.tests.zip', 02:35:01 INFO - u'firefox-47.0.en-US.mac.mochitest.tests.zip'], 02:35:01 INFO - u'mozbase': [u'firefox-47.0.en-US.mac.common.tests.zip'], 02:35:01 INFO - u'reftest': [u'firefox-47.0.en-US.mac.common.tests.zip', 02:35:01 INFO - u'firefox-47.0.en-US.mac.reftest.tests.zip'], 02:35:01 INFO - u'talos': [u'firefox-47.0.en-US.mac.common.tests.zip', 02:35:01 INFO - u'firefox-47.0.en-US.mac.talos.tests.zip'], 02:35:01 INFO - u'web-platform': [u'firefox-47.0.en-US.mac.common.tests.zip', 02:35:01 INFO - u'firefox-47.0.en-US.mac.web-platform.tests.zip'], 02:35:01 INFO - u'webapprt': [u'firefox-47.0.en-US.mac.common.tests.zip'], 02:35:01 INFO - u'xpcshell': [u'firefox-47.0.en-US.mac.common.tests.zip', 02:35:01 INFO - u'firefox-47.0.en-US.mac.xpcshell.tests.zip']} 02:35:01 INFO - Downloading packages: [u'firefox-47.0.en-US.mac.common.tests.zip'] for test suite category: common 02:35:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:35:01 INFO - https://queue.taskcluster.net/v1/task/FMxRyLb7RbKJquwN8ScKGw/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 02:35:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FMxRyLb7RbKJquwN8ScKGw/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip 02:35:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FMxRyLb7RbKJquwN8ScKGw/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip 02:35:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FMxRyLb7RbKJquwN8ScKGw/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip 02:35:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FMxRyLb7RbKJquwN8ScKGw/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip'}, attempt #1 02:35:03 INFO - Downloaded 17747498 bytes. 02:35:03 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:35:03 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 02:35:06 INFO - Return code: 0 02:35:06 INFO - Downloading packages: [u'firefox-47.0.en-US.mac.common.tests.zip', u'firefox-47.0.en-US.mac.talos.tests.zip'] for test suite category: talos 02:35:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:35:06 INFO - https://queue.taskcluster.net/v1/task/FMxRyLb7RbKJquwN8ScKGw/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 02:35:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FMxRyLb7RbKJquwN8ScKGw/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip 02:35:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FMxRyLb7RbKJquwN8ScKGw/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip 02:35:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FMxRyLb7RbKJquwN8ScKGw/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip 02:35:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FMxRyLb7RbKJquwN8ScKGw/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip'}, attempt #1 02:35:07 INFO - Downloaded 17747498 bytes. 02:35:07 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:35:07 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 02:35:10 INFO - Return code: 0 02:35:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:35:10 INFO - https://queue.taskcluster.net/v1/task/FMxRyLb7RbKJquwN8ScKGw/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 02:35:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FMxRyLb7RbKJquwN8ScKGw/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip 02:35:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FMxRyLb7RbKJquwN8ScKGw/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip 02:35:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FMxRyLb7RbKJquwN8ScKGw/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-47.0.en-US.mac.talos.tests.zip 02:35:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FMxRyLb7RbKJquwN8ScKGw/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.en-US.mac.talos.tests.zip'}, attempt #1 02:35:11 INFO - Downloaded 10845194 bytes. 02:35:11 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:35:11 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 02:35:12 INFO - Return code: 0 02:35:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:35:12 INFO - https://queue.taskcluster.net/v1/task/FMxRyLb7RbKJquwN8ScKGw/artifacts/public/build/firefox-47.0.en-US.mac.dmg matches https://queue.taskcluster.net 02:35:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FMxRyLb7RbKJquwN8ScKGw/artifacts/public/build/firefox-47.0.en-US.mac.dmg 02:35:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FMxRyLb7RbKJquwN8ScKGw/artifacts/public/build/firefox-47.0.en-US.mac.dmg 02:35:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FMxRyLb7RbKJquwN8ScKGw/artifacts/public/build/firefox-47.0.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0.en-US.mac.dmg 02:35:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FMxRyLb7RbKJquwN8ScKGw/artifacts/public/build/firefox-47.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-47.0.en-US.mac.dmg'}, attempt #1 02:35:15 INFO - Downloaded 88266728 bytes. 02:35:15 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/FMxRyLb7RbKJquwN8ScKGw/artifacts/public/build/firefox-47.0.en-US.mac.dmg 02:35:15 INFO - mkdir: /builds/slave/test/properties 02:35:15 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:35:15 INFO - Writing to file /builds/slave/test/properties/build_url 02:35:15 INFO - Contents: 02:35:15 INFO - build_url:https://queue.taskcluster.net/v1/task/FMxRyLb7RbKJquwN8ScKGw/artifacts/public/build/firefox-47.0.en-US.mac.dmg 02:35:17 INFO - Running post-action listener: _resource_record_post_action 02:35:17 INFO - Running post-action listener: set_extra_try_arguments 02:35:17 INFO - ##### 02:35:17 INFO - ##### Running populate-webroot step. 02:35:17 INFO - ##### 02:35:17 INFO - Running pre-action listener: _resource_record_pre_action 02:35:17 INFO - Running main action method: populate_webroot 02:35:17 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:35:17 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:35:17 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:35:17 INFO - '--tppagecycles', 02:35:17 INFO - '7'], 02:35:17 INFO - 'tests': ['tsvgm']}}, 02:35:17 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 02:35:17 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 02:35:17 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:35:17 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 02:35:17 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 02:35:17 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:35:17 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:35:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:35:17 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:35:17 INFO - 'talos_options': ['--e10s'], 02:35:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:35:17 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:35:17 INFO - 'tests': ['damp', 'tps']}, 02:35:17 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:35:17 INFO - 'talos_options': ['--e10s'], 02:35:17 INFO - 'tests': ['damp', 'tps']}, 02:35:17 INFO - 'g3': {'tests': ['dromaeo_dom']}, 02:35:17 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:35:17 INFO - 'other': {'tests': ['a11yr', 02:35:17 INFO - 'ts_paint', 02:35:17 INFO - 'tpaint', 02:35:17 INFO - 'sessionrestore', 02:35:17 INFO - 'sessionrestore_no_auto_restore', 02:35:17 INFO - 'tabpaint']}, 02:35:17 INFO - 'other-e10s': {'talos_options': ['--e10s'], 02:35:17 INFO - 'tests': ['a11yr', 02:35:17 INFO - 'ts_paint', 02:35:17 INFO - 'tpaint', 02:35:17 INFO - 'sessionrestore', 02:35:17 INFO - 'sessionrestore_no_auto_restore', 02:35:17 INFO - 'tabpaint']}, 02:35:17 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 02:35:17 INFO - 'tests': ['a11yr', 02:35:17 INFO - 'ts_paint', 02:35:17 INFO - 'tpaint', 02:35:17 INFO - 'sessionrestore', 02:35:17 INFO - 'sessionrestore_no_auto_restore', 02:35:17 INFO - 'tabpaint']}, 02:35:17 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 02:35:17 INFO - 'tests': ['a11yr', 02:35:17 INFO - 'ts_paint', 02:35:17 INFO - 'tpaint', 02:35:17 INFO - 'sessionrestore', 02:35:17 INFO - 'sessionrestore_no_auto_restore', 02:35:17 INFO - 'tabpaint']}, 02:35:17 INFO - 'other_l64': {'tests': ['a11yr', 02:35:17 INFO - 'ts_paint', 02:35:17 INFO - 'tpaint', 02:35:17 INFO - 'sessionrestore', 02:35:17 INFO - 'sessionrestore_no_auto_restore', 02:35:17 INFO - 'tabpaint']}, 02:35:17 INFO - 'other_nol64': {'tests': ['a11yr', 02:35:17 INFO - 'ts_paint', 02:35:17 INFO - 'tpaint', 02:35:17 INFO - 'sessionrestore', 02:35:17 INFO - 'sessionrestore_no_auto_restore', 02:35:17 INFO - 'tabpaint']}, 02:35:17 INFO - 'svgr': {'tests': ['tsvgx', 02:35:17 INFO - 'tsvgr_opacity', 02:35:17 INFO - 'tart', 02:35:17 INFO - 'tscrollx', 02:35:17 INFO - 'cart']}, 02:35:17 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 02:35:17 INFO - 'tests': ['tsvgx', 02:35:17 INFO - 'tsvgr_opacity', 02:35:17 INFO - 'tart', 02:35:17 INFO - 'tscrollx', 02:35:17 INFO - 'cart']}, 02:35:17 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:35:17 INFO - 'tests': ['tp5o']}, 02:35:17 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:35:17 INFO - 'talos_options': ['--e10s'], 02:35:17 INFO - 'tests': ['tp5o']}, 02:35:17 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:35:17 INFO - 'talos_options': ['--xperf_path', 02:35:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:35:17 INFO - 'tests': ['tp5n']}, 02:35:17 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:35:17 INFO - 'talos_options': ['--e10s', 02:35:17 INFO - '--xperf_path', 02:35:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:35:17 INFO - 'tests': ['tp5n']}}, 02:35:17 INFO - 'talos.zip': {'path': '', 02:35:17 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:35:17 INFO - Running post-action listener: _resource_record_post_action 02:35:17 INFO - ##### 02:35:17 INFO - ##### Running create-virtualenv step. 02:35:17 INFO - ##### 02:35:17 INFO - Running pre-action listener: _resource_record_pre_action 02:35:17 INFO - Running main action method: create_virtualenv 02:35:17 INFO - Creating virtualenv /builds/slave/test/build/venv 02:35:17 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 02:35:17 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:35:17 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:35:17 INFO - Using real prefix '/tools/python27' 02:35:17 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:35:17 INFO - Installing distribute.............................................................................................................................................................................................done. 02:35:20 INFO - Installing pip.................done. 02:35:20 INFO - Return code: 0 02:35:20 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:35:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:35:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:35:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:35:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:35:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:35:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:35:20 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 0x100e7aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100e814c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdfb3dc2970>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100d1ed30>, '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 0x100b82db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100d15b20>, '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.dxlwsU3iJd/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.M2cLfD0gwi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:35:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 02:35:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 02:35:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dxlwsU3iJd/Render', 02:35:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:35:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:35:20 INFO - 'HOME': '/Users/cltbld', 02:35:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:35:20 INFO - 'LOGNAME': 'cltbld', 02:35:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:35:20 INFO - 'MOZ_NO_REMOTE': '1', 02:35:20 INFO - 'NO_EM_RESTART': '1', 02:35:20 INFO - 'PAGER': '/bin/cat', 02:35:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:35:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:35:20 INFO - 'PWD': '/builds/slave/test', 02:35:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:35:20 INFO - 'SHELL': '/bin/bash', 02:35:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.M2cLfD0gwi/Listeners', 02:35:20 INFO - 'TMPDIR': '/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/', 02:35:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:35:20 INFO - 'USER': 'cltbld', 02:35:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:35:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:35:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:35:20 INFO - 'XPC_FLAGS': '0x0', 02:35:20 INFO - 'XPC_SERVICE_NAME': '0', 02:35:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:35:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:35:20 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 02:35:20 INFO - Cleaning up... 02:35:21 INFO - Return code: 0 02:35:21 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 02:35:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:35:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:35:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:35:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:35:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:35:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:35:21 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 0x100e7aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100e814c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdfb3dc2970>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100d1ed30>, '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 0x100b82db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100d15b20>, '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.dxlwsU3iJd/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.M2cLfD0gwi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:35:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 02:35:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 02:35:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dxlwsU3iJd/Render', 02:35:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:35:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:35:21 INFO - 'HOME': '/Users/cltbld', 02:35:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:35:21 INFO - 'LOGNAME': 'cltbld', 02:35:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:35:21 INFO - 'MOZ_NO_REMOTE': '1', 02:35:21 INFO - 'NO_EM_RESTART': '1', 02:35:21 INFO - 'PAGER': '/bin/cat', 02:35:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:35:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:35:21 INFO - 'PWD': '/builds/slave/test', 02:35:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:35:21 INFO - 'SHELL': '/bin/bash', 02:35:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.M2cLfD0gwi/Listeners', 02:35:21 INFO - 'TMPDIR': '/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/', 02:35:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:35:21 INFO - 'USER': 'cltbld', 02:35:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:35:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:35:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:35:21 INFO - 'XPC_FLAGS': '0x0', 02:35:21 INFO - 'XPC_SERVICE_NAME': '0', 02:35:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:35:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:35:21 INFO - Downloading/unpacking psutil>=0.7.1 02:35: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 02:35: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 02:35: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 02:35: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 02:35: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 02:35: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 02:35:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:35:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:35:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:35:24 INFO - Installing collected packages: psutil 02:35:24 INFO - Running setup.py install for psutil 02:35:24 INFO - building 'psutil._psutil_osx' extension 02:35:24 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 02:35:24 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 02:35:25 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 02:35:25 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 02:35:25 INFO - building 'psutil._psutil_posix' extension 02:35:25 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 02:35:25 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 02:35:25 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 02:35:25 INFO - ^ 02:35:25 INFO - 1 warning generated. 02:35:25 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 02:35:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:35:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:35:25 INFO - Successfully installed psutil 02:35:25 INFO - Cleaning up... 02:35:25 INFO - Return code: 0 02:35:25 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 02:35:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:35:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:35:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:35:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:35:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:35:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:35:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x100e7aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100e814c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdfb3dc2970>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100d1ed30>, '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 0x100b82db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100d15b20>, '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.dxlwsU3iJd/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.M2cLfD0gwi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:35:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 02:35:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 02:35:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dxlwsU3iJd/Render', 02:35:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:35:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:35:25 INFO - 'HOME': '/Users/cltbld', 02:35:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:35:25 INFO - 'LOGNAME': 'cltbld', 02:35:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:35:25 INFO - 'MOZ_NO_REMOTE': '1', 02:35:25 INFO - 'NO_EM_RESTART': '1', 02:35:25 INFO - 'PAGER': '/bin/cat', 02:35:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:35:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:35:25 INFO - 'PWD': '/builds/slave/test', 02:35:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:35:25 INFO - 'SHELL': '/bin/bash', 02:35:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.M2cLfD0gwi/Listeners', 02:35:25 INFO - 'TMPDIR': '/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/', 02:35:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:35:25 INFO - 'USER': 'cltbld', 02:35:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:35:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:35:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:35:25 INFO - 'XPC_FLAGS': '0x0', 02:35:25 INFO - 'XPC_SERVICE_NAME': '0', 02:35:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:35:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:35:25 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 02:35:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:35:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:35:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:35:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:35:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:35:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:35:28 INFO - Downloading mozsystemmonitor-0.0.tar.gz 02:35:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:35:28 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 02:35:28 INFO - Installing collected packages: mozsystemmonitor 02:35:28 INFO - Running setup.py install for mozsystemmonitor 02:35:28 INFO - Successfully installed mozsystemmonitor 02:35:28 INFO - Cleaning up... 02:35:28 INFO - Return code: 0 02:35:28 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:35:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:35:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:35:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:35:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:35:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:35:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:35:28 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 0x100e7aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100e814c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdfb3dc2970>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100d1ed30>, '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 0x100b82db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100d15b20>, '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.dxlwsU3iJd/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.M2cLfD0gwi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:35:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 02:35:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 02:35:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dxlwsU3iJd/Render', 02:35:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:35:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:35:28 INFO - 'HOME': '/Users/cltbld', 02:35:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:35:28 INFO - 'LOGNAME': 'cltbld', 02:35:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:35:28 INFO - 'MOZ_NO_REMOTE': '1', 02:35:28 INFO - 'NO_EM_RESTART': '1', 02:35:28 INFO - 'PAGER': '/bin/cat', 02:35:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:35:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:35:28 INFO - 'PWD': '/builds/slave/test', 02:35:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:35:28 INFO - 'SHELL': '/bin/bash', 02:35:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.M2cLfD0gwi/Listeners', 02:35:28 INFO - 'TMPDIR': '/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/', 02:35:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:35:28 INFO - 'USER': 'cltbld', 02:35:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:35:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:35:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:35:28 INFO - 'XPC_FLAGS': '0x0', 02:35:28 INFO - 'XPC_SERVICE_NAME': '0', 02:35:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:35:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:35:28 INFO - Downloading/unpacking blobuploader==1.2.4 02:35:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:35:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:35:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:35:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:35:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:35:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:35:31 INFO - Downloading blobuploader-1.2.4.tar.gz 02:35:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:35:31 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:35:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:35:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:35:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:35:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:35:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:35:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:35:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:35:31 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:35:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:35:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:35:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:35:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:35:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:35:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:35:32 INFO - Downloading docopt-0.6.1.tar.gz 02:35:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:35:32 INFO - Installing collected packages: blobuploader, requests, docopt 02:35:32 INFO - Running setup.py install for blobuploader 02:35:32 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:35:32 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:35:32 INFO - Running setup.py install for requests 02:35:33 INFO - Running setup.py install for docopt 02:35:33 INFO - Successfully installed blobuploader requests docopt 02:35:33 INFO - Cleaning up... 02:35:33 INFO - Return code: 0 02:35:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:35:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:35:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:35:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:35:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:35:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:35:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:35:33 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 0x100e7aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100e814c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdfb3dc2970>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100d1ed30>, '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 0x100b82db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100d15b20>, '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.dxlwsU3iJd/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.M2cLfD0gwi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:35:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 02:35:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:35:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dxlwsU3iJd/Render', 02:35:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:35:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:35:33 INFO - 'HOME': '/Users/cltbld', 02:35:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:35:33 INFO - 'LOGNAME': 'cltbld', 02:35:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:35:33 INFO - 'MOZ_NO_REMOTE': '1', 02:35:33 INFO - 'NO_EM_RESTART': '1', 02:35:33 INFO - 'PAGER': '/bin/cat', 02:35:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:35:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:35:33 INFO - 'PWD': '/builds/slave/test', 02:35:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:35:33 INFO - 'SHELL': '/bin/bash', 02:35:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.M2cLfD0gwi/Listeners', 02:35:33 INFO - 'TMPDIR': '/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/', 02:35:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:35:33 INFO - 'USER': 'cltbld', 02:35:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:35:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:35:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:35:33 INFO - 'XPC_FLAGS': '0x0', 02:35:33 INFO - 'XPC_SERVICE_NAME': '0', 02:35:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:35:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:35:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:35:33 INFO - Running setup.py (path:/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/pip-lAddQF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:35:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:35:33 INFO - Running setup.py (path:/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/pip-X1_a1A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:35:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:35:33 INFO - Running setup.py (path:/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/pip-qnZWJS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:35:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:35:33 INFO - Running setup.py (path:/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/pip-z3_75L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:35:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:35:34 INFO - Running setup.py (path:/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/pip-MTkXfU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:35:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:35:34 INFO - Running setup.py (path:/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/pip-GPbfvL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:35:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:35:34 INFO - Running setup.py (path:/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/pip-pDcr76-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:35:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:35:34 INFO - Running setup.py (path:/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/pip-pPl4X0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:35:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:35:34 INFO - Running setup.py (path:/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/pip-NBErhB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:35:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:35:34 INFO - Running setup.py (path:/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/pip-0TaJM3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:35:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:35:34 INFO - Running setup.py (path:/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/pip-ndcq96-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:35:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:35:34 INFO - Running setup.py (path:/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/pip-z92AYm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:35:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:35:34 INFO - Running setup.py (path:/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/pip-YKvDSD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:35:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:35:35 INFO - Running setup.py (path:/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/pip-OR0174-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:35:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:35:35 INFO - Running setup.py (path:/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/pip-y583D4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:35:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:35:35 INFO - Running setup.py (path:/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/pip-8FZPbG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:35:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:35:35 INFO - Running setup.py (path:/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/pip-o1SMXj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:35:35 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:35:35 INFO - Running setup.py install for manifestparser 02:35:35 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:35:35 INFO - Running setup.py install for mozcrash 02:35:35 INFO - Running setup.py install for mozdebug 02:35:35 INFO - Running setup.py install for mozdevice 02:35:36 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:35:36 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:35:36 INFO - Running setup.py install for mozfile 02:35:36 INFO - Running setup.py install for mozhttpd 02:35:36 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:35:36 INFO - Running setup.py install for mozinfo 02:35:36 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:35:36 INFO - Running setup.py install for mozInstall 02:35:36 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:35:36 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:35:36 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:35:36 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:35:36 INFO - Running setup.py install for mozleak 02:35:36 INFO - Running setup.py install for mozlog 02:35:36 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:35:36 INFO - Running setup.py install for moznetwork 02:35:37 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:35:37 INFO - Running setup.py install for mozprocess 02:35:37 INFO - Running setup.py install for mozprofile 02:35:37 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:35:37 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:35:37 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:35:37 INFO - Running setup.py install for mozrunner 02:35:37 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:35:37 INFO - Running setup.py install for mozscreenshot 02:35:37 INFO - Running setup.py install for moztest 02:35:37 INFO - Running setup.py install for mozversion 02:35:37 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:35:37 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:35:37 INFO - Cleaning up... 02:35:38 INFO - Return code: 0 02:35:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:35:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:35:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:35:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:35:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:35:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:35:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:35:38 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 0x100e7aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100e814c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdfb3dc2970>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100d1ed30>, '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 0x100b82db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100d15b20>, '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.dxlwsU3iJd/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.M2cLfD0gwi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:35:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 02:35:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:35:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dxlwsU3iJd/Render', 02:35:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:35:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:35:38 INFO - 'HOME': '/Users/cltbld', 02:35:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:35:38 INFO - 'LOGNAME': 'cltbld', 02:35:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:35:38 INFO - 'MOZ_NO_REMOTE': '1', 02:35:38 INFO - 'NO_EM_RESTART': '1', 02:35:38 INFO - 'PAGER': '/bin/cat', 02:35:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:35:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:35:38 INFO - 'PWD': '/builds/slave/test', 02:35:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:35:38 INFO - 'SHELL': '/bin/bash', 02:35:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.M2cLfD0gwi/Listeners', 02:35:38 INFO - 'TMPDIR': '/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/', 02:35:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:35:38 INFO - 'USER': 'cltbld', 02:35:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:35:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:35:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:35:38 INFO - 'XPC_FLAGS': '0x0', 02:35:38 INFO - 'XPC_SERVICE_NAME': '0', 02:35:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:35:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:35:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:35:38 INFO - Running setup.py (path:/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/pip-Cmw2tZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:35:38 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 02:35:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:35:38 INFO - Running setup.py (path:/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/pip-DbUCfm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:35:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:35:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:35:38 INFO - Running setup.py (path:/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/pip-KYsCR6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:35:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 02:35:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:35:38 INFO - Running setup.py (path:/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/pip-3a3csi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:35:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:35:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:35:38 INFO - Running setup.py (path:/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/pip-otdkRB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:35:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 02:35:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:35:38 INFO - Running setup.py (path:/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/pip-3u8Jtc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:35:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 02:35:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:35:38 INFO - Running setup.py (path:/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/pip-oKD3ml-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:35:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 02:35:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:35:39 INFO - Running setup.py (path:/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/pip-XhfEUC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:35:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 02:35:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:35:39 INFO - Running setup.py (path:/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/pip-XzCVVV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:35:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 02:35:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:35:39 INFO - Running setup.py (path:/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/pip-Nj3T7X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:35:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:35:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:35:39 INFO - Running setup.py (path:/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/pip-LDEXU3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:35:39 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 02:35:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:35:39 INFO - Running setup.py (path:/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/pip-sE_iQt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:35:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 02:35:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:35:39 INFO - Running setup.py (path:/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/pip-EtdITv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:35:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 02:35:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:35:39 INFO - Running setup.py (path:/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/pip-6nT7wr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:35:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 02:35:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:35:39 INFO - Running setup.py (path:/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/pip-ZYO9dA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:35:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 02:35:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:35:39 INFO - Running setup.py (path:/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/pip-F4f7M1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:35:39 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 02:35:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:35:39 INFO - Running setup.py (path:/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/pip-ZCq81D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:35:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 02:35:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:35:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:35:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 02:35:40 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:35:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:35:40 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:35:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:35:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:35:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:35:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:35:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:35:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:35:42 INFO - Downloading blessings-1.6.tar.gz 02:35:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:35:42 INFO - Installing collected packages: blessings 02:35:42 INFO - Running setup.py install for blessings 02:35:42 INFO - Successfully installed blessings 02:35:42 INFO - Cleaning up... 02:35:42 INFO - Return code: 0 02:35:42 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:35:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:35:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:35:43 INFO - Reading from file tmpfile_stdout 02:35:43 INFO - Current package versions: 02:35:43 INFO - blessings == 1.6 02:35:43 INFO - blobuploader == 1.2.4 02:35:43 INFO - docopt == 0.6.1 02:35:43 INFO - manifestparser == 1.1 02:35:43 INFO - mozInstall == 1.12 02:35:43 INFO - mozcrash == 0.17 02:35:43 INFO - mozdebug == 0.1 02:35:43 INFO - mozdevice == 0.48 02:35:43 INFO - mozfile == 1.2 02:35:43 INFO - mozhttpd == 0.7 02:35:43 INFO - mozinfo == 0.9 02:35:43 INFO - mozleak == 0.1 02:35:43 INFO - mozlog == 3.1 02:35:43 INFO - moznetwork == 0.27 02:35:43 INFO - mozprocess == 0.22 02:35:43 INFO - mozprofile == 0.28 02:35:43 INFO - mozrunner == 6.11 02:35:43 INFO - mozscreenshot == 0.1 02:35:43 INFO - mozsystemmonitor == 0.0 02:35:43 INFO - moztest == 0.7 02:35:43 INFO - mozversion == 1.4 02:35:43 INFO - psutil == 3.1.1 02:35:43 INFO - requests == 1.2.3 02:35:43 INFO - wsgiref == 0.1.2 02:35:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:35: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')]} 02:35:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:35:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:35: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')]} 02:35:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:35:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:35:43 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 0x100e7aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100e814c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdfb3dc2970>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100d1ed30>, '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 0x100b82db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100d15b20>, '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.dxlwsU3iJd/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.M2cLfD0gwi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:35:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 02:35:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:35:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dxlwsU3iJd/Render', 02:35:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:35:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:35:43 INFO - 'HOME': '/Users/cltbld', 02:35:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:35:43 INFO - 'LOGNAME': 'cltbld', 02:35:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:35:43 INFO - 'MOZ_NO_REMOTE': '1', 02:35:43 INFO - 'NO_EM_RESTART': '1', 02:35:43 INFO - 'PAGER': '/bin/cat', 02:35:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:35:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:35:43 INFO - 'PWD': '/builds/slave/test', 02:35:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:35:43 INFO - 'SHELL': '/bin/bash', 02:35:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.M2cLfD0gwi/Listeners', 02:35:43 INFO - 'TMPDIR': '/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/', 02:35:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:35:43 INFO - 'USER': 'cltbld', 02:35:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:35:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:35:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:35:43 INFO - 'XPC_FLAGS': '0x0', 02:35:43 INFO - 'XPC_SERVICE_NAME': '0', 02:35:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:35:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:35:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 02:35:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 02:35:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 02:35:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 02:35:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 02:35:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 02:35:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 02:35:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 02:35:43 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 02:35:43 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 02:35:43 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 02:35:43 INFO - Cleaning up... 02:35:43 INFO - Return code: 0 02:35:43 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:35: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')]} 02:35:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:35:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:35: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')]} 02:35:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:35:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:35:43 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 0x100e7aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100e814c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdfb3dc2970>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100d1ed30>, '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 0x100b82db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100d15b20>, '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.dxlwsU3iJd/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.M2cLfD0gwi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:35:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 02:35:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 02:35:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dxlwsU3iJd/Render', 02:35:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:35:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:35:43 INFO - 'HOME': '/Users/cltbld', 02:35:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:35:43 INFO - 'LOGNAME': 'cltbld', 02:35:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:35:43 INFO - 'MOZ_NO_REMOTE': '1', 02:35:43 INFO - 'NO_EM_RESTART': '1', 02:35:43 INFO - 'PAGER': '/bin/cat', 02:35:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:35:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:35:43 INFO - 'PWD': '/builds/slave/test', 02:35:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:35:43 INFO - 'SHELL': '/bin/bash', 02:35:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.M2cLfD0gwi/Listeners', 02:35:43 INFO - 'TMPDIR': '/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/', 02:35:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:35:43 INFO - 'USER': 'cltbld', 02:35:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:35:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:35:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:35:43 INFO - 'XPC_FLAGS': '0x0', 02:35:43 INFO - 'XPC_SERVICE_NAME': '0', 02:35:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:35:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:35:43 INFO - Downloading/unpacking jsonschema 02:35:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:35:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:35:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:35:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:35:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:35:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:35:46 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:35:46 INFO - Downloading/unpacking functools32 (from jsonschema) 02:35:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:35:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:35:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:35:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:35:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:35:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:35:46 INFO - Downloading functools32-3.2.3-2.tar.gz 02:35:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:35:46 INFO - warning: no files found matching '*.txt' 02:35:46 INFO - no previously-included directories found matching 'build' 02:35:46 INFO - no previously-included directories found matching 'dist' 02:35:46 INFO - no previously-included directories found matching '.git*' 02:35:46 INFO - Installing collected packages: jsonschema, functools32 02:35:46 INFO - Running setup.py install for functools32 02:35:46 INFO - warning: no files found matching '*.txt' 02:35:46 INFO - no previously-included directories found matching 'build' 02:35:46 INFO - no previously-included directories found matching 'dist' 02:35:46 INFO - no previously-included directories found matching '.git*' 02:35:46 INFO - Successfully installed jsonschema functools32 02:35:46 INFO - Cleaning up... 02:35:46 INFO - Return code: 0 02:35:46 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 02:35:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:35:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:35:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:35:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:35:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:35:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:35:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x100e7aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100e814c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdfb3dc2970>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100d1ed30>, '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 0x100b82db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100d15b20>, '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.dxlwsU3iJd/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.M2cLfD0gwi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:35:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 02:35:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 02:35:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dxlwsU3iJd/Render', 02:35:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:35:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:35:46 INFO - 'HOME': '/Users/cltbld', 02:35:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:35:46 INFO - 'LOGNAME': 'cltbld', 02:35:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:35:46 INFO - 'MOZ_NO_REMOTE': '1', 02:35:46 INFO - 'NO_EM_RESTART': '1', 02:35:46 INFO - 'PAGER': '/bin/cat', 02:35:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:35:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:35:46 INFO - 'PWD': '/builds/slave/test', 02:35:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:35:46 INFO - 'SHELL': '/bin/bash', 02:35:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.M2cLfD0gwi/Listeners', 02:35:46 INFO - 'TMPDIR': '/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/', 02:35:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:35:46 INFO - 'USER': 'cltbld', 02:35:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:35:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:35:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:35:46 INFO - 'XPC_FLAGS': '0x0', 02:35:46 INFO - 'XPC_SERVICE_NAME': '0', 02:35:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:35:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:35:47 INFO - Downloading/unpacking flake8 02:35:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:35:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:35:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:35:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:35:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:35:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:35:49 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 02:35:49 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 02:35:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:35:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:35:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:35:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:35:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:35:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:35:50 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 02:35:50 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 02:35:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:35:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:35:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:35:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:35:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:35:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:35:50 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 02:35:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:35:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:35:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:35:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:35:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:35:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:35:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 02:35:50 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:35:50 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:35:50 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:35:50 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:35:50 INFO - no previously-included directories found matching 'docs/_build' 02:35:50 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 02:35:51 INFO - Running setup.py install for pep8 02:35:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:35:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:35:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:35:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:35:51 INFO - no previously-included directories found matching 'docs/_build' 02:35:51 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 02:35:51 INFO - Successfully installed flake8 mccabe pyflakes pep8 02:35:51 INFO - Cleaning up... 02:35:51 INFO - Return code: 0 02:35:51 INFO - Running post-action listener: _resource_record_post_action 02:35:51 INFO - Running post-action listener: _start_resource_monitoring 02:35:51 INFO - Starting resource monitoring. 02:35:51 INFO - ##### 02:35:51 INFO - ##### Running install step. 02:35:51 INFO - ##### 02:35:51 INFO - Running pre-action listener: _resource_record_pre_action 02:35:51 INFO - Running main action method: install 02:35:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:35:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:35:51 INFO - Reading from file tmpfile_stdout 02:35:51 INFO - Detecting whether we're running mozinstall >=1.0... 02:35:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:35:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:35:51 INFO - Reading from file tmpfile_stdout 02:35:51 INFO - Output received: 02:35:51 INFO - Usage: mozinstall [options] installer 02:35:51 INFO - Options: 02:35:51 INFO - -h, --help show this help message and exit 02:35:51 INFO - -d DEST, --destination=DEST 02:35:51 INFO - Directory to install application into. [default: 02:35:51 INFO - "/builds/slave/test"] 02:35:51 INFO - --app=APP Application being installed. [default: firefox] 02:35:51 INFO - mkdir: /builds/slave/test/build/application 02:35:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 02:35:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0.en-US.mac.dmg --destination /builds/slave/test/build/application 02:36:14 INFO - Reading from file tmpfile_stdout 02:36:14 INFO - Output received: 02:36:14 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 02:36:14 INFO - Running post-action listener: _resource_record_post_action 02:36:14 INFO - ##### 02:36:14 INFO - ##### Running run-tests step. 02:36:14 INFO - ##### 02:36:14 INFO - Running pre-action listener: _resource_record_pre_action 02:36:14 INFO - Running main action method: run_tests 02:36:14 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:36:14 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:36:14 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:36:14 INFO - 2016-05-12 02:36:14.785 screenresolution[1645:7364] starting screenresolution argv=screenresolution get 02:36:14 INFO - 2016-05-12 02:36:14.788 screenresolution[1645:7364] Display 0: 1600x1200x32@60 02:36:14 INFO - 2016-05-12 02:36:14.794 screenresolution[1646:7367] starting screenresolution argv=screenresolution list 02:36:14 INFO - Available Modes on Display 0 02:36:14 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:36:14 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:36:14 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:36:14 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:36:15 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:36:15 INFO - Intel Iris: 02:36:15 INFO - Chipset Model: Intel Iris 02:36:15 INFO - Type: GPU 02:36:15 INFO - Bus: Built-In 02:36:15 INFO - VRAM (Dynamic, Max): 1536 MB 02:36:15 INFO - Vendor: Intel (0x8086) 02:36:15 INFO - Device ID: 0x0a2e 02:36:15 INFO - Revision ID: 0x0009 02:36:15 INFO - Displays: 02:36:15 INFO - Display: 02:36:15 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:36:15 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:36:15 INFO - Display Serial Number: 1600x1200 60 02:36:15 INFO - Main Display: Yes 02:36:15 INFO - Mirror: Off 02:36:15 INFO - Online: Yes 02:36:15 INFO - Rotation: Supported 02:36:15 INFO - Return code: 0 02:36:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:36:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:36:15 INFO - Python 2.7.3 02:36:15 INFO - Return code: 0 02:36:15 INFO - grabbing minidump binary from tooltool 02:36:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:36:15 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 0x100d1ed30>, '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 0x100b82db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100d15b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:36:15 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 02:36:15 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 02:36:15 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:36:15 INFO - Return code: 0 02:36:15 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 02:36:15 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:36:15 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:36:15 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 02:36:15 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:36:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 02:36:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 02:36:16 INFO - Return code: 0 02:36:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/FMxRyLb7RbKJquwN8ScKGw/artifacts/public/build/firefox-47.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0053', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 02:36:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/FMxRyLb7RbKJquwN8ScKGw/artifacts/public/build/firefox-47.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0053 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 02:36:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dxlwsU3iJd/Render', 02:36:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:36:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:36:16 INFO - 'HOME': '/Users/cltbld', 02:36:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:36:16 INFO - 'LOGNAME': 'cltbld', 02:36:16 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:36:16 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 02:36:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:36:16 INFO - 'MOZ_NO_REMOTE': '1', 02:36:16 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:36:16 INFO - 'NO_EM_RESTART': '1', 02:36:16 INFO - 'PAGER': '/bin/cat', 02:36:16 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:36:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:36:16 INFO - 'PWD': '/builds/slave/test', 02:36:16 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:36:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:36:16 INFO - 'SHELL': '/bin/bash', 02:36:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.M2cLfD0gwi/Listeners', 02:36:16 INFO - 'TMPDIR': '/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/', 02:36:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:36:16 INFO - 'USER': 'cltbld', 02:36:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:36:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:36:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:36:16 INFO - 'XPC_FLAGS': '0x0', 02:36:16 INFO - 'XPC_SERVICE_NAME': '0', 02:36:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:36:16 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/FMxRyLb7RbKJquwN8ScKGw/artifacts/public/build/firefox-47.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0053', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 02:36:16 INFO - mozversion application_buildid: 20160512003019 02:36:16 INFO - mozversion application_changeset: 13f145c74a334e53c13ca67eb5ec09d141a4af67 02:36:16 INFO - mozversion application_display_name: Firefox 02:36:16 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:36:16 INFO - mozversion application_name: Firefox 02:36:16 INFO - mozversion application_remotingname: firefox 02:36:16 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 02:36:16 INFO - mozversion application_vendor: Mozilla 02:36:16 INFO - mozversion application_version: 47.0 02:36:16 INFO - mozversion platform_buildid: 20160512003019 02:36:16 INFO - mozversion platform_changeset: 13f145c74a334e53c13ca67eb5ec09d141a4af67 02:36:16 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 02:36:16 INFO - mozversion platform_version: 47.0 02:36:16 INFO - using testdate: 1463045776 02:36:16 INFO - actual date: 1463045776 02:36:16 INFO - starting webserver on 'localhost:49273' 02:36:16 INFO - SUITE-START | Running 2 tests 02:36:16 INFO - TEST-START | dromaeo_css 02:36:16 INFO - operating with platform_type : mac_ 02:36:16 INFO - Initialising browser for dromaeo_css test... 02:36:16 INFO - TEST-INFO | started process 1664 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/tmpakgPqT/profile http://localhost:49273/getInfo.html) 02:36:19 INFO - PROCESS | 1664 | __metrics Screen width/height:1600/1200 02:36:19 INFO - PROCESS | 1664 | colorDepth:24 02:36:19 INFO - PROCESS | 1664 | Browser inner width/height: 1024/689 02:36:19 INFO - PROCESS | 1664 | __metrics 02:36:19 INFO - PROCESS | 1664 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 02:36:19 INFO - PROCESS | 1664 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:36:19 INFO - TEST-INFO | 1664: exit 0 02:36:19 INFO - Browser initialized. 02:36:19 INFO - Running cycle 1/1 for dromaeo_css test... 02:36:19 INFO - TEST-INFO | started process 1667 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/tmpakgPqT/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:36:31 INFO - PROCESS | 1667 | RSS: Main: 157097984 02:36:31 INFO - PROCESS | 1667 | 02:37:22 INFO - PROCESS | 1667 | 1463045842207 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 02:39:32 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49273/tests/dromaeo/cssquery-ext.html) 02:39:33 INFO - PROCESS | 1667 | RSS: Main: 266907648 02:39:33 INFO - PROCESS | 1667 | 02:42:35 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-ext.html (next: http://localhost:49273/tests/dromaeo/cssquery-jquery.html) 02:42:36 INFO - PROCESS | 1667 | RSS: Main: 297291776 02:42:36 INFO - PROCESS | 1667 | 02:45:38 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49273/tests/dromaeo/cssquery-mootools.html) 02:45:39 INFO - PROCESS | 1667 | RSS: Main: 300556288 02:45:39 INFO - PROCESS | 1667 | 02:48:40 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49273/tests/dromaeo/cssquery-prototype.html) 02:48:41 INFO - PROCESS | 1667 | RSS: Main: 255352832 02:48:41 INFO - PROCESS | 1667 | 02:51:44 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49273/tests/dromaeo/cssquery-yui.html) 02:51:45 INFO - PROCESS | 1667 | RSS: Main: 255131648 02:51:45 INFO - PROCESS | 1667 | 02:54:47 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-yui.html (next: http://localhost:49273/tests/dromaeo/cssquery-dojo.html) 02:54:48 INFO - PROCESS | 1667 | RSS: Main: 301158400 02:54:48 INFO - PROCESS | 1667 | 02:54:48 INFO - PROCESS | 1667 | __start_tp_report 02:54:48 INFO - PROCESS | 1667 | _x_x_mozilla_page_load 02:54:48 INFO - PROCESS | 1667 | _x_x_mozilla_page_load_details 02:54:48 INFO - PROCESS | 1667 | |i|pagename|runs| 02:54:48 INFO - PROCESS | 1667 | |0;dojo.html;3101.2712012677025;3541.415666415042;3609.2961872434885;3633.7274704397178;3722.776633401996;5835.183074369592;5851.444112809281;5871.970640146804;5876.794312199068;5912.290525136984;5875.941240587593;5937.821865344046;5944;5953.226080609515;5961.403859614036;5285;5287.894242115155;5315.282436871012;5353.3843607985;5374.247605335257;5421.891562168754;5434.510894019538;5435.592330575203;5437.102878025141;5441.5102640762325;5375.489328513785;5418.756155972991;5426.430224826396;5447.992121457523;5448.536874365684;5342.225377320306;5447.618666693333;5455.018096742585;5484.957858006986;5535.889282214373;5248.343957005374;5391.973040134813;5398.595105367113;5399.487048730364;5402.162664786964;5770.913436298417;5791.536677065867;5822.708864556797;5823.388544202882;5890.4698577128265;6267.811965641038;6330.050492426173;6336.904946425807;6337.524685648595;6371.267304259976;6297.370262973712;6331.651759153245;6355.555111142222;6360.681965901686;6405.903911441332;6116.4800991915745;6154.415330543591;6157.4458298753325;6164.938350616526;6168.568200225986;6360.618362898241;6438.130852334969;6538.444232240313;6552.770653027121;6566;6315.684215789192;6316.30520642729;6320.146780184617;6326.019466982625;6337.302896681362;6344.555881088372;6344.8413789654705;6346.619202847844;6348.111264422984;6368.395002474757;6222.595531290452;6263;6322.209723784527;6335.429811317003;6342.953412686855;6213.937860621336;6302.338254483305;6315.5894866833505;6342;6347.333529979285;5053.570446512014;5081.517255860687;5093.414257360377;5106.080905437057;5113.181890897438;4636.235021221528;4649.5815376616265;4667.113248482778;4672.595228982063;4689.695169813951;5995.670238136944;6070.7875224366935;6075.392460753889;6136;6158.538109641795;6345.936540634534;6359.427651511386;6379.489640828722;6379.649119298483;6392.520560957947;6149.3235744068115;6153.784617538365;6154.292256390483;6156.476699480594;6167.982282923357;5430.5927055471;5552.41699621542;5604.915926261109;5614.85962850932;5653.830385088454;6587.341265873374;6592.571482853599;6622.403983641495;6628.933710662832;6630.535862489676;6234.189555357774;6398.360163983564;6403.167588213502;6416.935830641821;6446.548741588232;6577.934220657732;6642.4021838034805;6662.766803161866;6672.733090676513;6689;5155.252488389237;6274.780382686584;6316.399942005502;6324.1146239527425;6333.556651034568;6213.751449941951;6231.594946328474;6309.810705678837;6380.808575742735;6385.361463853577;6101.145839582551;6229.190205273286;6271.090691849565;6286.339934306832;6292.811215663537;6225.190725205694;6261.436470717657;6285.905711414241;6291.6539590321145;6331.873362532631;6110.7106460192745;6141.117811340085;6243.875122497616;6253.96873015632;6261.186045814015;6219.253689557282;6266.937330626818;6307.400796924285;6311.526635502264;6331.651759153291;6262.655553944577;6265.404786545271;6268.091126786681;6270.717817698123;6297.653629050446 02:54:48 INFO - PROCESS | 1667 | |1;ext.html;507.3911306432282;587.0372588954116;601.9187409699692;668.9931652862441;675.9493038022148;31919.68080319196;32904.67095329046;41159.38260926089;41261.58738412615;41392.379114313306;44260.55739442605;44929;44956.775216123955;45028.324575131315;45051.54948450522;9756.902430975688;9981.75045623858;9990.45052522111;10002.299839011272;10004.349717268391;9824.21406287499;9977.201823854111;9979.101880830724;9989.150922171588;9989.400635961865;9960.352577082504;10039.347442416256;10042.497875106252;10051.849222261671;10056.648017319396;9893.802123957517;10006.749831254241;10008.29941904067;10057.497125143713;10101.49492525378;9824;9966.40201587907;9967.850482242773;9973.950130249375;10024.94987525065;43034.13931721348;43275.56724432747;43413.78293108546;43487.130257394674;43491.78254108741;3340.448825943716;3423.760336776427;3500.929981400383;3530.9230684641175;3925.391564307537;23466.64800028001;29105.70894291051;30280.24299392511;30783.692163078307;31284.06147815569;2790.9302267443477;2843.658760948699;2849.50133726597;2868.2399164221288;2927.6779554249015;444046;522629;527911;529119;529133;49336.76658083576;49970.500294996586;49984.75038124076;72674.27325726674;73201;48452.27321590179;48581.271280930814;48831.75584122057;48832;48862.75568622134;17508.649827003643;17659.55851103733;17695.469135925687;17737.024463654623;17784.199711013036;14033.596640336089;14123.78814317786;14127.576172714835;14140.575782726535;14179.503717369842;15576.376944922304;15667.686646267011;15692.293846776922;15692.76460853088;15727.44953926607;6592.703328350236;6625.701843417058;6642.767503137464;6646.368594983469;6667.333266673294;953.3707752883203;984.7291994701371;1052.2897044494935;1094.6278265389647;1169.5789615617066;30634.693653063183;30968.535471967938;31015.224619384695;31328.21679458032;31441;1128.949197286124;1130.7342774447998;1152.844366010578;1192.9224600400946;1196.5393323570488;15796.763048554281;15802.446914357943;15804.762928556082;15966.920165399331;16016.439424620083;547715;552403;553576;555518;555548;62623.06065409022;64340;64477.355226448075;64486.71026579536;64522.67738661277;1425.8217722784652;1450.485077797388;1544.8532389423212;1550.6433520290395;1579.842015798434;29980.62409252818;31364;31474.685253147174;31584;31931.840340798146;39456.6054339453;50572.747136264086;50797.74601126971;51325.48674513357;54218.728906355216;376812;378595;379868;379932;380136;30695.2326191847;31196.844015779774;35034.474482883285;35650;36092.27815443624;44233.557664422944;44354.11291774211;45181.77409112934;45806.85482862955;46469.76765116153;36287;37021.81489092537;37184.81407592945;37903.86288411352;41005.58994410137;37908.05229869275;37917.241655167294;38187.80906095452;38379.808100960436;38655.80672096622;38106;38486.6151338483;38648.42027369535;38980.6101938977;39032;33365.499517506774;33451.83274083614;33761.83119084389;33913.15217119493;34205;22632.207872724375;25817.870910645328;26063.827127778917;26376.4724705501;26601.600975984988 02:54:48 INFO - PROCESS | 1667 | |2;jquery.html;382.72635065927864;384.6557331188586;390.61914633232584;395.4937679769894;396.11270753512105;16880.493585192435;17425.128743562804;20499.975001249953;22335.3299401018;23033.999999999978;21335.039923203454;21462.678059829075;21855.672164917538;21967;22425.439364015907;5943.910841337372;6037.124616930542;6068.33248342682;6072.574919755619;6166.691665416712;4444.844430444935;4656.348111264426;5400.324959380077;5991.55063370249;6630.63531505767;6552;6557.147570815811;6561.704723287439;6565.212174539038;6569.40875321221;6371.203599550056;6472.320406357336;6538.934610653881;6550.574212676184;6567.113439685653;5634.3520495143175;5676.545876329884;5687.431256874321;5689.971550142222;5699.886002279973;26712.332191695168;27116.779744911528;27372.31569210766;27430.862845685642;27641.447171056465;2305.91929282476;2394.305651361103;2959.689232630564;2965.229040449477;2984.492636251842;15161.393544258217;15260.694786104326;15405.537833865003;15417.922910385489;16309.673806523802;1710.298777501231;1794.7577077094556;1842.4933143385542;1864.3008871673123;1867.2437662746609;90827.54586227027;106871.46564267206;112392;112745;112824;10737.476692977145;11050.060744836617;11077.556897724162;11096.445177741081;11132;13733.176009439267;13764.17414955106;13775.586732398044;13801.723965520634;13804;9043.954780226057;9065.637374505079;9091.590878410487;9102.681406150752;9220.631174753069;9474.38416502925;9485.66800161991;9493.623424603395;9532;9603.135717785433;6267.811965640947;6369.235691717024;6380.170577824946;6383.265924418752;6456.063870738717;1537.415782002854;1749.5188823073502;1820.7541981832549;1823.3982785680694;1874.7187921811565;809.5426084262373;968.9903100969041;992.4144754594679;1001.3241062283075;1099.6975831646362;17893.21933285766;20495.795042049685;21773.782262177494;21825.67261491079;21848.126074956825;1039.8180318444242;1088.9292196007234;1090.215045167494;1096.1833434091652;1143.588308209044;11289.379084150287;11391.829122563167;11984.221025633306;12018.338991355384;12207.816882746765;602321;620572;623497;632333;710968;109366;111964.44017779859;112940;113412;116510;938.7183844846519;1126.9042131418921;1164.7495788405533;1178.9448443643064;1182.6511179201984;16464;19418.61162776765;20107.39677809668;20173.2939347128;20280.59438811245;44827.551724483645;49395.75302123466;49698.503014969385;49873.50126498689;51581;63803.36196637974;67070.66464667645;67938.3206167932;68029;70344.94482582663;6943.652817359213;8195.426320157532;8227.341812655093;8348.248657620601;8528.573571321533;13507.324633768469;13760.93119534436;13765.518206862711;13862.306884655929;13940.930295348458;11620.883791162318;11865.703357416134;12004.339761313211;12064.034877209977;12224.266544007389;9103.408278462144;11400.201985861242;11437.59968401102;11447;11917.34454605005;11921.940390297994;11926.642200733992;12011.63965081049;12086.637400877988;12214.206076604993;8171.673133074611;8265;8346.123657015925;8356.373272004746;8478.660853565789;11712.063034957353;11797.76404471923;12019.098567607289;12049.879501204876;12198.939005305272 02:54:48 INFO - PROCESS | 1667 | |3;mootools.html;1445.5518789175355;1521.8325984141736;1696.7285234362505;1975.5357490989616;2137.9786202137984;8322.793194986723;8887.333449991253;9090.136437038487;9094.45433274004;9102.772430689236;8804.559772011406;9056.864147037799;9069.455832650046;9078.182963533298;9079.18287354138;2575.7037940636833;2602.336404216922;2603.2060221632396;2604.960925586118;2605.804564657649;2339.649052642109;2543.694756629198;2608.5174242765056;2608.647832542611;2613.098481024044;2603.1409634820557;2609.386794103384;2621.7640412362884;2628.7239839816734;2638.854862982535;2584.844909305448;2601.700804407489;2609.008576740836;2621.8689065546646;2624.4619852930105;2166.8049875511124;2605.557055300603;2614.5293847107514;2639.0895141176265;2644.7487488688544;9098.408603440756;9162.404443711137;9163.450192988443;9185.219256363218;9195.356325057248;5720.71396430181;5822.7088645567555;5861.443162899518;5868.706564671749;5879.412058794129;3222.871085156591;3625;3641.6176301488226;3716.535433070866;3794;1077.3643550305278;1092.819684752015;1095.2825899036145;1130.2822707580663;1133.4389477208751;12572.182808117443;12574.43415046316;12584.74830503394;12594.81107783384;12605;5083.847484575469;5099.770510327045;5170.896582068338;5174.663646862942;5198.584113270929;10605.522751476203;10629.4153821539;10640.68077957647;10660.093892019266;10660.840087398696;5750.626209296466;5819.970900145472;5841.269841269841;5842.211301474332;5866.560007999417;4348.825817029385;4388.846390376321;4701.905961880743;4751.144793937125;5270.736463176902;3936.7047471439755;4078.57174996627;4095.7542547447247;4163.000879788829;4223.831046758157;1331.483774095227;1357.7623915814693;1367.9261779503042;1370.9451621935011;1376.1880490510646;1228.152574723438;1253.486070711004;1270.6632742323293;1465.5383554180612;1474.1744623011148;8429.789255268668;8548.273396761346;8568.10034946334;8601.483910965362;8618.224359807647;1241.596481143632;1244.197492617275;1254.6988722706485;1256.296473974577;1282.2691066092239;6540.8364790880605;6565.67171641416;6656.034874943203;6660.600363978177;6671.032700258435;10913.399763012952;11312.095032397388;11438.142139339416;11455.885441145649;11492.942535287437;10947.343159410302;11014.39420831862;11198.496067676973;11203.271787333797;11281.041111505614;7472.738454154079;8712.0416754157;8761.430507017023;8818.426802257833;8838.823223535494;8272.503649781032;8291.253787159185;8295.087540370676;8389.993200815941;8399.328053755808;9915.65295214664;10016.348937319051;10048.497575121068;10156.898431015596;10187.694369168938;10196.949015254877;10373;10373.377597344184;10397.272190946562;10584.8941510587;5933.673647949404;7700.460967732205;7977.202279772208;7985.72049978248;7990.121086680577;7953.403494737802;8376.58117094155;8557.48655080697;8571.742847714579;8600.354973376896;7479.439042071976;7554.811129721801;7558.093028836574;7673.654685539276;7706.267904549059;7420.814479638052;7479.102507699111;7547.396208303213;7584.582847943416;7614.8096297593;8035.718749843727;8119.512829230265;8136.593170341341;8136.959315203386;8145.266925976691;7200.135983681992;7285.7085716572865;7350.448716346188;7362.042934418491;7362.7054917804835;7420.109586849612;7481.812954676177;7490.887636685563;7500.774976750707;7502.587357695161 02:54:48 INFO - PROCESS | 1667 | |4;prototype.html;340.45357201691286;343.21232770791033;349.1358886755281;349.3432347187291;354.5390991710777;6782.050512928194;6795;6821.65891705414;6834.487413443987;6845.931540684592;6820.590764554117;6831.965840170805;6833.726650933969;6836.589804611727;6836.9402742574985;4861.343718597997;5012.649114561982;5023.874403139933;5035.949640503603;5100.107481190805;4177.874663760077;4922.138625740499;4945.901081978358;5048.040872234282;5085.440601533847;4990.3762029746285;4990.476000019982;4997.550220480156;4998.375203099613;5014.899702005958;4090.3250963591267;4519.661025423106;4560.6351491880905;5001.374828146481;5028.798848046092;4160.729552579072;4206.053637931441;4320.697551171419;4324.783760811978;4337.7180483268485;6451.83870403239;6467.902981455282;6513.381228783258;6521.869562608768;6529.34706529348;5932.851678708067;5941.316748573926;5948.613340132878;5950.1372301016545;5953.077273022688;5810.273715785527;7207.864578908139;7220.097487814023;7233.819154521127;7243.529170603894;4700.059988002413;4824.107540105057;4832.710037397767;4839.032193561302;4844.20070688336;7429.739959101459;7520.6991720331125;7526.02161718973;7535.811604709871;7569.3566046886635;4934.358533390637;4957.479464656231;4971.1797553404;4972.751362431936;4978.551930326288;4439.533848945879;5072.087024335655;5076.847694569169;5084.771185296597;5086.4659210783075;5921.881562368814;5933.376995415506;5935.6735379553675;5935.82192534216;5962.522998160137;6946.097007389007;7196.352328290479;7212.242714515005;7226.566406015656;7274.781756547312;1741.2947756158776;1752.9824701752818;1766.6996610576232;1769.7699299091294;1773.2463702926464;1128.8476055732372;1129.2603344809163;1152.662911023209;1156.6125348008343;1161.814109742437;6729;6892.655367231619;6895.448364130857;6959.164900212007;6974.093367862146;7408.369898749574;7427.702891884373;7434.73978410753;7606.353459955855;7612.8477430452185;7021.754238601625;7043.190033146151;7044.964775176194;7052.224255331909;7075.716971321192;3974.324364857981;4008.899777505586;4010.598940106024;4017.2568074906235;4019.1760689058674;7529.435292353095;7846.646900889474;7901.644426000844;7914.129445760962;7936.206379362017;7222;7752.26353496417;7761.301482866456;7770.883436748453;7782.64978075988;6371.74513019474;7870.331021863206;7879.448438609243;7886.132525422199;7887.605619718991;6047.667378294236;7475.775726728207;7481.064866891638;7488.400927925862;7494.325510704063;6671.566348187353;6777.712234675396;7027.964860175666;7395.630218488946;7400;7773.73503128676;7842.960785196037;7844.646990885538;7849.01887264092;7887.369010479262;4149.25313443583;4932.63005274613;4954.603631709382;4961.90838015636;4977.4524802271;6325.905111423424;7191.712331506681;7453.627318633939;7461.141968673455;7480.625968701652;5793.812268485035;7202.96398518004;7340.96329518349;7388.815279618053;7414;6586.736530538725;6810.523263371715;7316.9634151828905;7362.116546014512;7363.190049094488;7190.352868241884;7190.4607154464675;7201.495895287279;7204.53170543913;7213.278672132745;7061.293870612898;7327.0841144856895;7334.486585938933;7337.853242935218;7348;6958.7216511341;7158.570485770871;7181.928180718126;7185.030020947105;7224 02:54:48 INFO - PROCESS | 1667 | |5;yui.html;726.378946001169;781.6873250699723;793.761871438569;797.9202079792018;820.3683163963747;15342.38630454782;15497.92251038746;15648.139352335616;15650.982686125393;15652.608684782886;15029.62425939352;15102.093874367545;15124;15127.697446051072;15133.54599362021;847.7075408983922;858.4248553469159;860.8278344331128;960.0783248081832;1007.3502590828911;857.6269322844552;994.9452780097092;1020.9132223760989;1023.7082431506984;1024.5287167902773;1055.435342091981;1058.095328494138;1060.204846365226;1062.3731998121107;1065.211743309953;866.2766589897443;1051.6582110813977;1052.168786658539;1056.2922841696081;1056.5192837259067;770.6647608290356;785.4698078796789;787.0398114300601;787.9881801772977;788.2590365056828;15729.449469268635;15907.681846363124;15909.840901590951;15921.761173582405;15943.760843587355;13171.209727416386;13447.125936814173;13468.730625387536;13509.932450337783;13639.659008524766;8888.244499217575;10372.688819335432;10575.418351990638;10917.344959302467;10918.399488028155;3172.2703778130926;3209.1977005748563;3239.951400728991;3263.3473305339026;3274.197821533716;79769;81285.3742925144;86447;89990.10009899882;92287.53856230743;9659.951700241454;9736.805263894825;9842.852357214648;10005.44970026641;10027.247956403298;19817.702734458995;20878.478038049172;22339;22401.327960161223;22432.551348972927;7404.629768511553;7589.468737188454;7591.3926885849;7665.731699390494;7719.961400193076;3986.8405263789123;4010.859619913289;4044.988752811797;4061.5532291447917;4116.464859568297;3645.4167333227088;3695.1870588470492;3713.220223752988;3714.9969508232625;3717.052151701299;658.3646780856401;662.3508961217937;665.0954701605813;671.9798406047729;674.8279188806921;625.2621906150695;629.5404354820914;637.8947473666885;640.7084776426715;668.3683918696785;8176.591170441573;8596.011458682331;8610.397272190887;8684.696035638848;8696.086910874394;570.611983850977;586.8151532267323;592.1325258496323;596.3499785234116;603.7947097986705;3740.532433445819;3797.810109494514;3912.7073794374583;4053.756774593534;4206.936895946563;90919.1203876258;91076;91506.39182885834;92003.53998229966;92704.60943085859;80364;80456.5977170122;80852.59573702094;80886.19113808904;82359.5882020586;66947;71558.64220678863;71831;71974;73458.63270683719;6230.813075607739;6651.534392592472;7502.36229920441;8189.262966333059;8480.703175388831;39193.41209881911;49780.00439991253;50343;50436.747816260686;51623.741881290356;66768.6661566689;67456.66271668806;67749;68567.65716171387;69803;10409.9479502602;11351.886481135083;11423.714407139889;11828.52685892589;12143.33211673331;10345;12030.09774266951;12054.276743395425;12161.270323780602;12529.749405012031;10452.947735261276;10975.560977560808;12006.39968001579;12096.883045467184;12288.262704237774;11754.647360579196;11836.70408239801;11891.28652280866;12295.262284262973;12347.62957111288;11832.46753896094;11923.940380298043;12033.63899083029;12033.63899083029;12034.217775844541;10242.436665983145;10255.230857685852;10312.432816194882;10388.324758890649;10458.47707614601;10177.18582513412;10347.689569312932;10352.689419317432;10353.9482302588;10371.740706482398 02:54:48 INFO - PROCESS | 1667 | __end_tp_report 02:54:48 INFO - PROCESS | 1667 | __start_cc_report 02:54:48 INFO - PROCESS | 1667 | _x_x_mozilla_cycle_collect,986 02:54:48 INFO - PROCESS | 1667 | __end_cc_report 02:54:48 INFO - PROCESS | 1667 | __startTimestamp1463046888127__endTimestamp 02:54:48 INFO - PROCESS | 1667 | 02:54:48 INFO - PROCESS | 1667 | ------- Summary: start ------- 02:54:48 INFO - PROCESS | 1667 | Number of tests: 6 02:54:48 INFO - PROCESS | 1667 | 02:54:48 INFO - PROCESS | 1667 | [#0] dojo.html Cycles:165 Average:5939.03 Median:6222.60 stddev:640.37 (10.3%) stddev-sans-first:602.40 02:54:48 INFO - PROCESS | 1667 | Values: 3101.3 3541.4 3609.3 3633.7 3722.8 5835.2 5851.4 5872.0 5876.8 5912.3 5875.9 5937.8 5944.0 5953.2 5961.4 5285.0 5287.9 5315.3 5353.4 5374.2 5421.9 5434.5 5435.6 5437.1 5441.5 5375.5 5418.8 5426.4 5448.0 5448.5 5342.2 5447.6 5455.0 5485.0 5535.9 5248.3 5392.0 5398.6 5399.5 5402.2 5770.9 5791.5 5822.7 5823.4 5890.5 6267.8 6330.1 6336.9 6337.5 6371.3 6297.4 6331.7 6355.6 6360.7 6405.9 6116.5 6154.4 6157.4 6164.9 6168.6 6360.6 6438.1 6538.4 6552.8 6566.0 6315.7 6316.3 6320.1 6326.0 6337.3 6344.6 6344.8 6346.6 6348.1 6368.4 6222.6 6263.0 6322.2 6335.4 6343.0 6213.9 6302.3 6315.6 6342.0 6347.3 5053.6 5081.5 5093.4 5106.1 5113.2 4636.2 4649.6 4667.1 4672.6 4689.7 5995.7 6070.8 6075.4 6136.0 6158.5 6345.9 6359.4 6379.5 6379.6 6392.5 6149.3 6153.8 6154.3 6156.5 6168.0 5430.6 5552.4 5604.9 5614.9 5653.8 6587.3 6592.6 6622.4 6628.9 6630.5 6234.2 6398.4 6403.2 6416.9 6446.5 6577.9 6642.4 6662.8 6672.7 6689.0 5155.3 6274.8 6316.4 6324.1 6333.6 6213.8 6231.6 6309.8 6380.8 6385.4 6101.1 6229.2 6271.1 6286.3 6292.8 6225.2 6261.4 6285.9 6291.7 6331.9 6110.7 6141.1 6243.9 6254.0 6261.2 6219.3 6266.9 6307.4 6311.5 6331.7 6262.7 6265.4 6268.1 6270.7 6297.7 02:54:48 INFO - PROCESS | 1667 | 02:54:48 INFO - PROCESS | 1667 | [#1] ext.html Cycles:180 Average:62901.88 Median:37905.96 stddev:129506.07 (341.7%) stddev-sans-first:129784.64 02:54:48 INFO - PROCESS | 1667 | Values: 507.4 587.0 601.9 669.0 675.9 31919.7 32904.7 41159.4 41261.6 41392.4 44260.6 44929.0 44956.8 45028.3 45051.5 9756.9 9981.8 9990.5 10002.3 10004.3 9824.2 9977.2 9979.1 9989.2 9989.4 9960.4 10039.3 10042.5 10051.8 10056.6 9893.8 10006.7 10008.3 10057.5 10101.5 9824.0 9966.4 9967.9 9974.0 10024.9 43034.1 43275.6 43413.8 43487.1 43491.8 3340.4 3423.8 3500.9 3530.9 3925.4 23466.6 29105.7 30280.2 30783.7 31284.1 2790.9 2843.7 2849.5 2868.2 2927.7 444046.0 522629.0 527911.0 529119.0 529133.0 49336.8 49970.5 49984.8 72674.3 73201.0 48452.3 48581.3 48831.8 48832.0 48862.8 17508.6 17659.6 17695.5 17737.0 17784.2 14033.6 14123.8 14127.6 14140.6 14179.5 15576.4 15667.7 15692.3 15692.8 15727.4 6592.7 6625.7 6642.8 6646.4 6667.3 953.4 984.7 1052.3 1094.6 1169.6 30634.7 30968.5 31015.2 31328.2 31441.0 1128.9 1130.7 1152.8 1192.9 1196.5 15796.8 15802.4 15804.8 15966.9 16016.4 547715.0 552403.0 553576.0 555518.0 555548.0 62623.1 64340.0 64477.4 64486.7 64522.7 1425.8 1450.5 1544.9 1550.6 1579.8 29980.6 31364.0 31474.7 31584.0 31931.8 39456.6 50572.7 50797.7 51325.5 54218.7 376812.0 378595.0 379868.0 379932.0 380136.0 30695.2 31196.8 35034.5 35650.0 36092.3 44233.6 44354.1 45181.8 45806.9 46469.8 36287.0 37021.8 37184.8 37903.9 41005.6 37908.1 37917.2 38187.8 38379.8 38655.8 38106.0 38486.6 38648.4 38980.6 39032.0 33365.5 33451.8 33761.8 33913.2 34205.0 22632.2 25817.9 26063.8 26376.5 26601.6 02:54:48 INFO - PROCESS | 1667 | 02:54:48 INFO - PROCESS | 1667 | [#2] jquery.html Cycles:180 Average:35497.03 Median:22151.16 stddev:105531.86 (476.4%) stddev-sans-first:105794.97 02:54:48 INFO - PROCESS | 1667 | Values: 382.7 384.7 390.6 395.5 396.1 16880.5 17425.1 20500.0 22335.3 23034.0 21335.0 21462.7 21855.7 21967.0 22425.4 5943.9 6037.1 6068.3 6072.6 6166.7 4444.8 4656.3 5400.3 5991.6 6630.6 6552.0 6557.1 6561.7 6565.2 6569.4 6371.2 6472.3 6538.9 6550.6 6567.1 5634.4 5676.5 5687.4 5690.0 5699.9 26712.3 27116.8 27372.3 27430.9 27641.4 2305.9 2394.3 2959.7 2965.2 2984.5 15161.4 15260.7 15405.5 15417.9 16309.7 1710.3 1794.8 1842.5 1864.3 1867.2 90827.5 106871.5 112392.0 112745.0 112824.0 10737.5 11050.1 11077.6 11096.4 11132.0 13733.2 13764.2 13775.6 13801.7 13804.0 9044.0 9065.6 9091.6 9102.7 9220.6 9474.4 9485.7 9493.6 9532.0 9603.1 6267.8 6369.2 6380.2 6383.3 6456.1 1537.4 1749.5 1820.8 1823.4 1874.7 809.5 969.0 992.4 1001.3 1099.7 17893.2 20495.8 21773.8 21825.7 21848.1 1039.8 1088.9 1090.2 1096.2 1143.6 11289.4 11391.8 11984.2 12018.3 12207.8 602321.0 620572.0 623497.0 632333.0 710968.0 109366.0 111964.4 112940.0 113412.0 116510.0 938.7 1126.9 1164.7 1178.9 1182.7 16464.0 19418.6 20107.4 20173.3 20280.6 44827.6 49395.8 49698.5 49873.5 51581.0 63803.4 67070.7 67938.3 68029.0 70344.9 6943.7 8195.4 8227.3 8348.2 8528.6 13507.3 13760.9 13765.5 13862.3 13940.9 11620.9 11865.7 12004.3 12064.0 12224.3 9103.4 11400.2 11437.6 11447.0 11917.3 11921.9 11926.6 12011.6 12086.6 12214.2 8171.7 8265.0 8346.1 8356.4 8478.7 11712.1 11797.8 12019.1 12049.9 12198.9 02:54:48 INFO - PROCESS | 1667 | 02:54:48 INFO - PROCESS | 1667 | [#3] mootools.html Cycles:180 Average:6336.10 Median:4545.38 stddev:3335.69 (73.4%) stddev-sans-first:3324.79 02:54:48 INFO - PROCESS | 1667 | Values: 1445.6 1521.8 1696.7 1975.5 2138.0 8322.8 8887.3 9090.1 9094.5 9102.8 8804.6 9056.9 9069.5 9078.2 9079.2 2575.7 2602.3 2603.2 2605.0 2605.8 2339.6 2543.7 2608.5 2608.6 2613.1 2603.1 2609.4 2621.8 2628.7 2638.9 2584.8 2601.7 2609.0 2621.9 2624.5 2166.8 2605.6 2614.5 2639.1 2644.7 9098.4 9162.4 9163.5 9185.2 9195.4 5720.7 5822.7 5861.4 5868.7 5879.4 3222.9 3625.0 3641.6 3716.5 3794.0 1077.4 1092.8 1095.3 1130.3 1133.4 12572.2 12574.4 12584.7 12594.8 12605.0 5083.8 5099.8 5170.9 5174.7 5198.6 10605.5 10629.4 10640.7 10660.1 10660.8 5750.6 5820.0 5841.3 5842.2 5866.6 4348.8 4388.8 4701.9 4751.1 5270.7 3936.7 4078.6 4095.8 4163.0 4223.8 1331.5 1357.8 1367.9 1370.9 1376.2 1228.2 1253.5 1270.7 1465.5 1474.2 8429.8 8548.3 8568.1 8601.5 8618.2 1241.6 1244.2 1254.7 1256.3 1282.3 6540.8 6565.7 6656.0 6660.6 6671.0 10913.4 11312.1 11438.1 11455.9 11492.9 10947.3 11014.4 11198.5 11203.3 11281.0 7472.7 8712.0 8761.4 8818.4 8838.8 8272.5 8291.3 8295.1 8390.0 8399.3 9915.7 10016.3 10048.5 10156.9 10187.7 10196.9 10373.0 10373.4 10397.3 10584.9 5933.7 7700.5 7977.2 7985.7 7990.1 7953.4 8376.6 8557.5 8571.7 8600.4 7479.4 7554.8 7558.1 7673.7 7706.3 7420.8 7479.1 7547.4 7584.6 7614.8 8035.7 8119.5 8136.6 8137.0 8145.3 7200.1 7285.7 7350.4 7362.0 7362.7 7420.1 7481.8 7490.9 7500.8 7502.6 02:54:48 INFO - PROCESS | 1667 | 02:54:48 INFO - PROCESS | 1667 | [#4] prototype.html Cycles:180 Average:5936.09 Median:6802.76 stddev:1873.99 (27.5%) stddev-sans-first:1831.58 02:54:48 INFO - PROCESS | 1667 | Values: 340.5 343.2 349.1 349.3 354.5 6782.1 6795.0 6821.7 6834.5 6845.9 6820.6 6832.0 6833.7 6836.6 6836.9 4861.3 5012.6 5023.9 5035.9 5100.1 4177.9 4922.1 4945.9 5048.0 5085.4 4990.4 4990.5 4997.6 4998.4 5014.9 4090.3 4519.7 4560.6 5001.4 5028.8 4160.7 4206.1 4320.7 4324.8 4337.7 6451.8 6467.9 6513.4 6521.9 6529.3 5932.9 5941.3 5948.6 5950.1 5953.1 5810.3 7207.9 7220.1 7233.8 7243.5 4700.1 4824.1 4832.7 4839.0 4844.2 7429.7 7520.7 7526.0 7535.8 7569.4 4934.4 4957.5 4971.2 4972.8 4978.6 4439.5 5072.1 5076.8 5084.8 5086.5 5921.9 5933.4 5935.7 5935.8 5962.5 6946.1 7196.4 7212.2 7226.6 7274.8 1741.3 1753.0 1766.7 1769.8 1773.2 1128.8 1129.3 1152.7 1156.6 1161.8 6729.0 6892.7 6895.4 6959.2 6974.1 7408.4 7427.7 7434.7 7606.4 7612.8 7021.8 7043.2 7045.0 7052.2 7075.7 3974.3 4008.9 4010.6 4017.3 4019.2 7529.4 7846.6 7901.6 7914.1 7936.2 7222.0 7752.3 7761.3 7770.9 7782.6 6371.7 7870.3 7879.4 7886.1 7887.6 6047.7 7475.8 7481.1 7488.4 7494.3 6671.6 6777.7 7028.0 7395.6 7400.0 7773.7 7843.0 7844.6 7849.0 7887.4 4149.3 4932.6 4954.6 4961.9 4977.5 6325.9 7191.7 7453.6 7461.1 7480.6 5793.8 7203.0 7341.0 7388.8 7414.0 6586.7 6810.5 7317.0 7362.1 7363.2 7190.4 7190.5 7201.5 7204.5 7213.3 7061.3 7327.1 7334.5 7337.9 7348.0 6958.7 7158.6 7181.9 7185.0 7224.0 02:54:48 INFO - PROCESS | 1667 | 02:54:48 INFO - PROCESS | 1667 | [#5] yui.html Cycles:180 Average:18700.24 Median:3855.26 stddev:26194.41 (679.4%) stddev-sans-first:26233.13 02:54:48 INFO - PROCESS | 1667 | Values: 726.4 781.7 793.8 797.9 820.4 15342.4 15497.9 15648.1 15651.0 15652.6 15029.6 15102.1 15124.0 15127.7 15133.5 847.7 858.4 860.8 960.1 1007.4 857.6 994.9 1020.9 1023.7 1024.5 1055.4 1058.1 1060.2 1062.4 1065.2 866.3 1051.7 1052.2 1056.3 1056.5 770.7 785.5 787.0 788.0 788.3 15729.4 15907.7 15909.8 15921.8 15943.8 13171.2 13447.1 13468.7 13509.9 13639.7 8888.2 10372.7 10575.4 10917.3 10918.4 3172.3 3209.2 3240.0 3263.3 3274.2 79769.0 81285.4 86447.0 89990.1 92287.5 9660.0 9736.8 9842.9 10005.4 10027.2 19817.7 20878.5 22339.0 22401.3 22432.6 7404.6 7589.5 7591.4 7665.7 7720.0 3986.8 4010.9 4045.0 4061.6 4116.5 3645.4 3695.2 3713.2 3715.0 3717.1 658.4 662.4 665.1 672.0 674.8 625.3 629.5 637.9 640.7 668.4 8176.6 8596.0 8610.4 8684.7 8696.1 570.6 586.8 592.1 596.3 603.8 3740.5 3797.8 3912.7 4053.8 4206.9 90919.1 91076.0 91506.4 92003.5 92704.6 80364.0 80456.6 80852.6 80886.2 82359.6 66947.0 71558.6 71831.0 71974.0 73458.6 6230.8 6651.5 7502.4 8189.3 8480.7 39193.4 49780.0 50343.0 50436.7 51623.7 66768.7 67456.7 67749.0 68567.7 69803.0 10409.9 11351.9 11423.7 11828.5 12143.3 10345.0 12030.1 12054.3 12161.3 12529.7 10452.9 10975.6 12006.4 12096.9 12288.3 11754.6 11836.7 11891.3 12295.3 12347.6 11832.5 11923.9 12033.6 12033.6 12034.2 10242.4 10255.2 10312.4 10388.3 10458.5 10177.2 10347.7 10352.7 10353.9 10371.7 02:54:48 INFO - PROCESS | 1667 | -------- Summary: end -------- 02:54:48 INFO - PROCESS | 1667 | 02:54:48 INFO - TEST-INFO | 1667: exit 0 02:54:48 INFO - TEST-OK | dromaeo_css | took 1112217ms 02:54:48 INFO - TEST-START | kraken 02:54:48 INFO - operating with platform_type : mac_ 02:54:48 INFO - Initialising browser for kraken test... 02:54:48 INFO - TEST-INFO | started process 1677 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/tmptJzqFs/profile http://localhost:49273/getInfo.html) 02:54:50 INFO - PROCESS | 1677 | __metrics Screen width/height:1600/1200 02:54:50 INFO - PROCESS | 1677 | colorDepth:24 02:54:50 INFO - PROCESS | 1677 | Browser inner width/height: 1024/689 02:54:50 INFO - PROCESS | 1677 | __metrics 02:54:51 INFO - PROCESS | 1677 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 02:54:51 INFO - PROCESS | 1677 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:54:51 INFO - TEST-INFO | 1677: exit 0 02:54:51 INFO - Browser initialized. 02:54:51 INFO - Running cycle 1/1 for kraken test... 02:54:51 INFO - TEST-INFO | started process 1680 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/tmptJzqFs/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:55:03 INFO - PROCESS | 1680 | RSS: Main: 156803072 02:55:03 INFO - PROCESS | 1680 | 02:55:06 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-beat-detection) 02:55:06 INFO - PROCESS | 1680 | RSS: Main: 213504000 02:55:06 INFO - PROCESS | 1680 | 02:55:09 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-dft) 02:55:10 INFO - PROCESS | 1680 | RSS: Main: 223506432 02:55:10 INFO - PROCESS | 1680 | 02:55:13 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-fft) 02:55:13 INFO - PROCESS | 1680 | RSS: Main: 214732800 02:55:13 INFO - PROCESS | 1680 | 02:55:15 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-oscillator) 02:55:16 INFO - PROCESS | 1680 | RSS: Main: 214999040 02:55:16 INFO - PROCESS | 1680 | 02:55:18 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49273/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:55:19 INFO - PROCESS | 1680 | RSS: Main: 215273472 02:55:19 INFO - PROCESS | 1680 | 02:55:22 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49273/tests/kraken/driver.html?testName=imaging-darkroom) 02:55:22 INFO - PROCESS | 1680 | RSS: Main: 215236608 02:55:22 INFO - PROCESS | 1680 | 02:55:25 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49273/tests/kraken/driver.html?testName=imaging-desaturate) 02:55:26 INFO - PROCESS | 1680 | RSS: Main: 215293952 02:55:26 INFO - PROCESS | 1680 | 02:55:28 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49273/tests/kraken/driver.html?testName=json-parse-financial) 02:55:29 INFO - PROCESS | 1680 | RSS: Main: 215420928 02:55:29 INFO - PROCESS | 1680 | 02:55:30 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49273/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:55:31 INFO - PROCESS | 1680 | RSS: Main: 247230464 02:55:31 INFO - PROCESS | 1680 | 02:55:33 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:55:34 INFO - PROCESS | 1680 | RSS: Main: 248127488 02:55:34 INFO - PROCESS | 1680 | 02:55:36 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:55:36 INFO - PROCESS | 1680 | RSS: Main: 254476288 02:55:36 INFO - PROCESS | 1680 | 02:55:39 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:55:39 INFO - PROCESS | 1680 | RSS: Main: 255655936 02:55:39 INFO - PROCESS | 1680 | 02:55:42 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:55:42 INFO - PROCESS | 1680 | RSS: Main: 255762432 02:55:42 INFO - PROCESS | 1680 | 02:55:44 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49273/tests/kraken/driver.html?testName=ai-astar) 02:55:44 INFO - PROCESS | 1680 | RSS: Main: 318242816 02:55:44 INFO - PROCESS | 1680 | 02:55:44 INFO - PROCESS | 1680 | __start_tp_report 02:55:44 INFO - PROCESS | 1680 | _x_x_mozilla_page_load 02:55:44 INFO - PROCESS | 1680 | _x_x_mozilla_page_load_details 02:55:44 INFO - PROCESS | 1680 | |i|pagename|runs| 02:55:44 INFO - PROCESS | 1680 | |0;ai-astar;153;158;141;111;112;120;174;152;110;111 02:55:44 INFO - PROCESS | 1680 | |1;audio-beat-detection;155;120;137;158;118;138;140;118;159;121 02:55:44 INFO - PROCESS | 1680 | |2;audio-dft;183;184;185;184;184;181;183;182;184;183 02:55:44 INFO - PROCESS | 1680 | |3;audio-fft;73;71;75;112;58;68;84;84;144;56 02:55:44 INFO - PROCESS | 1680 | |4;audio-oscillator;88;87;132;78;82;112;161;114;79;121 02:55:44 INFO - PROCESS | 1680 | |5;imaging-gaussian-blur;89;87;89;88;134;130;90;88;135;131 02:55:44 INFO - PROCESS | 1680 | |6;imaging-darkroom;94;93;95;106;150;128;94;94;93;93 02:55:44 INFO - PROCESS | 1680 | |7;imaging-desaturate;84;85;86;87;86;84;86;84;92;85 02:55:44 INFO - PROCESS | 1680 | |8;json-parse-financial;56;58;58;56;57;56;57;67;51;51 02:55:44 INFO - PROCESS | 1680 | |9;json-stringify-tinderbox;63;62;65;96;111;106;87;66;68;65 02:55:44 INFO - PROCESS | 1680 | |10;stanford-crypto-aes;80;81;81;80;81;97;81;80;83;85 02:55:44 INFO - PROCESS | 1680 | |11;stanford-crypto-ccm;129;124;106;140;144;128;125;118;118;119 02:55:44 INFO - PROCESS | 1680 | |12;stanford-crypto-pbkdf2;134;123;133;131;131;123;133;131;133;130 02:55:44 INFO - PROCESS | 1680 | |13;stanford-crypto-sha256-iterative;66;66;65;65;65;65;65;65;65;65 02:55:44 INFO - PROCESS | 1680 | __end_tp_report 02:55:44 INFO - PROCESS | 1680 | __start_cc_report 02:55:44 INFO - PROCESS | 1680 | _x_x_mozilla_cycle_collect,1207 02:55:44 INFO - PROCESS | 1680 | __end_cc_report 02:55:44 INFO - PROCESS | 1680 | __startTimestamp1463046944869__endTimestamp 02:55:44 INFO - PROCESS | 1680 | 02:55:44 INFO - PROCESS | 1680 | ------- Summary: start ------- 02:55:44 INFO - PROCESS | 1680 | Number of tests: 14 02:55:44 INFO - PROCESS | 1680 | 02:55:44 INFO - PROCESS | 1680 | [#0] ai-astar Cycles:10 Average:134.20 Median:146.50 stddev:24.09 (16.4%) stddev-sans-first:24.57 02:55:44 INFO - PROCESS | 1680 | Values: 153.0 158.0 141.0 111.0 112.0 120.0 174.0 152.0 110.0 111.0 02:55:44 INFO - PROCESS | 1680 | 02:55:44 INFO - PROCESS | 1680 | [#1] audio-beat-detection Cycles:10 Average:136.40 Median:139.00 stddev:16.74 (12.0%) stddev-sans-first:16.35 02:55:44 INFO - PROCESS | 1680 | Values: 155.0 120.0 137.0 158.0 118.0 138.0 140.0 118.0 159.0 121.0 02:55:44 INFO - PROCESS | 1680 | 02:55:44 INFO - PROCESS | 1680 | [#2] audio-dft Cycles:10 Average:183.30 Median:184.00 stddev:1.16 (0.6%) stddev-sans-first:1.22 02:55:44 INFO - PROCESS | 1680 | Values: 183.0 184.0 185.0 184.0 184.0 181.0 183.0 182.0 184.0 183.0 02:55:44 INFO - PROCESS | 1680 | 02:55:44 INFO - PROCESS | 1680 | [#3] audio-fft Cycles:10 Average:82.50 Median:72.00 stddev:26.77 (37.2%) stddev-sans-first:28.17 02:55:44 INFO - PROCESS | 1680 | Values: 73.0 71.0 75.0 112.0 58.0 68.0 84.0 84.0 144.0 56.0 02:55:44 INFO - PROCESS | 1680 | 02:55:44 INFO - PROCESS | 1680 | [#4] audio-oscillator Cycles:10 Average:105.40 Median:78.50 stddev:27.48 (35.0%) stddev-sans-first:28.42 02:55:44 INFO - PROCESS | 1680 | Values: 88.0 87.0 132.0 78.0 82.0 112.0 161.0 114.0 79.0 121.0 02:55:44 INFO - PROCESS | 1680 | 02:55:44 INFO - PROCESS | 1680 | [#5] imaging-gaussian-blur Cycles:10 Average:106.10 Median:88.00 stddev:22.78 (25.9%) stddev-sans-first:23.30 02:55:44 INFO - PROCESS | 1680 | Values: 89.0 87.0 89.0 88.0 134.0 130.0 90.0 88.0 135.0 131.0 02:55:44 INFO - PROCESS | 1680 | 02:55:44 INFO - PROCESS | 1680 | [#6] imaging-darkroom Cycles:10 Average:104.00 Median:93.50 stddev:19.55 (20.9%) stddev-sans-first:20.40 02:55:44 INFO - PROCESS | 1680 | Values: 94.0 93.0 95.0 106.0 150.0 128.0 94.0 94.0 93.0 93.0 02:55:44 INFO - PROCESS | 1680 | 02:55:44 INFO - PROCESS | 1680 | [#7] imaging-desaturate Cycles:10 Average:85.90 Median:86.00 stddev:2.38 (2.8%) stddev-sans-first:2.42 02:55:44 INFO - PROCESS | 1680 | Values: 84.0 85.0 86.0 87.0 86.0 84.0 86.0 84.0 92.0 85.0 02:55:44 INFO - PROCESS | 1680 | 02:55:44 INFO - PROCESS | 1680 | [#8] json-parse-financial Cycles:10 Average:56.70 Median:57.00 stddev:4.42 (7.8%) stddev-sans-first:4.68 02:55:44 INFO - PROCESS | 1680 | Values: 56.0 58.0 58.0 56.0 57.0 56.0 57.0 67.0 51.0 51.0 02:55:44 INFO - PROCESS | 1680 | 02:55:44 INFO - PROCESS | 1680 | [#9] json-stringify-tinderbox Cycles:10 Average:78.90 Median:65.50 stddev:19.24 (29.4%) stddev-sans-first:19.53 02:55:44 INFO - PROCESS | 1680 | Values: 63.0 62.0 65.0 96.0 111.0 106.0 87.0 66.0 68.0 65.0 02:55:44 INFO - PROCESS | 1680 | 02:55:44 INFO - PROCESS | 1680 | [#10] stanford-crypto-aes Cycles:10 Average:82.90 Median:81.00 stddev:5.20 (6.4%) stddev-sans-first:5.40 02:55:44 INFO - PROCESS | 1680 | Values: 80.0 81.0 81.0 80.0 81.0 97.0 81.0 80.0 83.0 85.0 02:55:44 INFO - PROCESS | 1680 | 02:55:44 INFO - PROCESS | 1680 | [#11] stanford-crypto-ccm Cycles:10 Average:125.10 Median:126.50 stddev:11.09 (8.8%) stddev-sans-first:11.67 02:55:44 INFO - PROCESS | 1680 | Values: 129.0 124.0 106.0 140.0 144.0 128.0 125.0 118.0 118.0 119.0 02:55:44 INFO - PROCESS | 1680 | 02:55:44 INFO - PROCESS | 1680 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:130.20 Median:132.00 stddev:3.99 (3.0%) stddev-sans-first:3.99 02:55:44 INFO - PROCESS | 1680 | Values: 134.0 123.0 133.0 131.0 131.0 123.0 133.0 131.0 133.0 130.0 02:55:44 INFO - PROCESS | 1680 | 02:55:44 INFO - PROCESS | 1680 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.20 Median:65.00 stddev:0.42 (0.6%) stddev-sans-first:0.33 02:55:44 INFO - PROCESS | 1680 | Values: 66.0 66.0 65.0 65.0 65.0 65.0 65.0 65.0 65.0 65.0 02:55:44 INFO - PROCESS | 1680 | -------- Summary: end -------- 02:55:44 INFO - PROCESS | 1680 | 02:55:45 INFO - TEST-INFO | 1680: exit 0 02:55:45 INFO - TEST-OK | kraken | took 56820ms 02:55:45 INFO - SUITE-END | took 1169s 02:55:46 INFO - Completed test suite (00:19:29) 02:55:46 INFO - javascript benchmark 02:55:46 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3101.2712012677025, 3541.415666415042, 3609.2961872434885, 3633.7274704397178, 3722.776633401996, 5835.183074369592, 5851.444112809281, 5871.970640146804, 5876.794312199068, 5912.290525136984, 5875.941240587593, 5937.821865344046, 5944.0, 5953.226080609515, 5961.403859614036, 5285.0, 5287.894242115155, 5315.282436871012, 5353.3843607985, 5374.247605335257, 5421.891562168754, 5434.510894019538, 5435.592330575203, 5437.102878025141, 5441.5102640762325, 5375.489328513785, 5418.756155972991, 5426.430224826396, 5447.992121457523, 5448.536874365684, 5342.225377320306, 5447.618666693333, 5455.018096742585, 5484.957858006986, 5535.889282214373, 5248.343957005374, 5391.973040134813, 5398.595105367113, 5399.487048730364, 5402.162664786964, 5770.913436298417, 5791.536677065867, 5822.708864556797, 5823.388544202882, 5890.4698577128265, 6267.811965641038, 6330.050492426173, 6336.904946425807, 6337.524685648595, 6371.267304259976, 6297.370262973712, 6331.651759153245, 6355.555111142222, 6360.681965901686, 6405.903911441332, 6116.4800991915745, 6154.415330543591, 6157.4458298753325, 6164.938350616526, 6168.568200225986, 6360.618362898241, 6438.130852334969, 6538.444232240313, 6552.770653027121, 6566.0, 6315.684215789192, 6316.30520642729, 6320.146780184617, 6326.019466982625, 6337.302896681362, 6344.555881088372, 6344.8413789654705, 6346.619202847844, 6348.111264422984, 6368.395002474757, 6222.595531290452, 6263.0, 6322.209723784527, 6335.429811317003, 6342.953412686855, 6213.937860621336, 6302.338254483305, 6315.5894866833505, 6342.0, 6347.333529979285, 5053.570446512014, 5081.517255860687, 5093.414257360377, 5106.080905437057, 5113.181890897438, 4636.235021221528, 4649.5815376616265, 4667.113248482778, 4672.595228982063, 4689.695169813951, 5995.670238136944, 6070.7875224366935, 6075.392460753889, 6136.0, 6158.538109641795, 6345.936540634534, 6359.427651511386, 6379.489640828722, 6379.649119298483, 6392.520560957947, 6149.3235744068115, 6153.784617538365, 6154.292256390483, 6156.476699480594, 6167.982282923357, 5430.5927055471, 5552.41699621542, 5604.915926261109, 5614.85962850932, 5653.830385088454, 6587.341265873374, 6592.571482853599, 6622.403983641495, 6628.933710662832, 6630.535862489676, 6234.189555357774, 6398.360163983564, 6403.167588213502, 6416.935830641821, 6446.548741588232, 6577.934220657732, 6642.4021838034805, 6662.766803161866, 6672.733090676513, 6689.0, 5155.252488389237, 6274.780382686584, 6316.399942005502, 6324.1146239527425, 6333.556651034568, 6213.751449941951, 6231.594946328474, 6309.810705678837, 6380.808575742735, 6385.361463853577, 6101.145839582551, 6229.190205273286, 6271.090691849565, 6286.339934306832, 6292.811215663537, 6225.190725205694, 6261.436470717657, 6285.905711414241, 6291.6539590321145, 6331.873362532631, 6110.7106460192745, 6141.117811340085, 6243.875122497616, 6253.96873015632, 6261.186045814015, 6219.253689557282, 6266.937330626818, 6307.400796924285, 6311.526635502264, 6331.651759153291, 6262.655553944577, 6265.404786545271, 6268.091126786681, 6270.717817698123, 6297.653629050446], "unit": "score", "name": "dojo.html", "value": 5899.05017649526}, {"lowerIsBetter": false, "replicates": [507.3911306432282, 587.0372588954116, 601.9187409699692, 668.9931652862441, 675.9493038022148, 31919.68080319196, 32904.67095329046, 41159.38260926089, 41261.58738412615, 41392.379114313306, 44260.55739442605, 44929.0, 44956.775216123955, 45028.324575131315, 45051.54948450522, 9756.902430975688, 9981.75045623858, 9990.45052522111, 10002.299839011272, 10004.349717268391, 9824.21406287499, 9977.201823854111, 9979.101880830724, 9989.150922171588, 9989.400635961865, 9960.352577082504, 10039.347442416256, 10042.497875106252, 10051.849222261671, 10056.648017319396, 9893.802123957517, 10006.749831254241, 10008.29941904067, 10057.497125143713, 10101.49492525378, 9824.0, 9966.40201587907, 9967.850482242773, 9973.950130249375, 10024.94987525065, 43034.13931721348, 43275.56724432747, 43413.78293108546, 43487.130257394674, 43491.78254108741, 3340.448825943716, 3423.760336776427, 3500.929981400383, 3530.9230684641175, 3925.391564307537, 23466.64800028001, 29105.70894291051, 30280.24299392511, 30783.692163078307, 31284.06147815569, 2790.9302267443477, 2843.658760948699, 2849.50133726597, 2868.2399164221288, 2927.6779554249015, 444046.0, 522629.0, 527911.0, 529119.0, 529133.0, 49336.76658083576, 49970.500294996586, 49984.75038124076, 72674.27325726674, 73201.0, 48452.27321590179, 48581.271280930814, 48831.75584122057, 48832.0, 48862.75568622134, 17508.649827003643, 17659.55851103733, 17695.469135925687, 17737.024463654623, 17784.199711013036, 14033.596640336089, 14123.78814317786, 14127.576172714835, 14140.575782726535, 14179.503717369842, 15576.376944922304, 15667.686646267011, 15692.293846776922, 15692.76460853088, 15727.44953926607, 6592.703328350236, 6625.701843417058, 6642.767503137464, 6646.368594983469, 6667.333266673294, 953.3707752883203, 984.7291994701371, 1052.2897044494935, 1094.6278265389647, 1169.5789615617066, 30634.693653063183, 30968.535471967938, 31015.224619384695, 31328.21679458032, 31441.0, 1128.949197286124, 1130.7342774447998, 1152.844366010578, 1192.9224600400946, 1196.5393323570488, 15796.763048554281, 15802.446914357943, 15804.762928556082, 15966.920165399331, 16016.439424620083, 547715.0, 552403.0, 553576.0, 555518.0, 555548.0, 62623.06065409022, 64340.0, 64477.355226448075, 64486.71026579536, 64522.67738661277, 1425.8217722784652, 1450.485077797388, 1544.8532389423212, 1550.6433520290395, 1579.842015798434, 29980.62409252818, 31364.0, 31474.685253147174, 31584.0, 31931.840340798146, 39456.6054339453, 50572.747136264086, 50797.74601126971, 51325.48674513357, 54218.728906355216, 376812.0, 378595.0, 379868.0, 379932.0, 380136.0, 30695.2326191847, 31196.844015779774, 35034.474482883285, 35650.0, 36092.27815443624, 44233.557664422944, 44354.11291774211, 45181.77409112934, 45806.85482862955, 46469.76765116153, 36287.0, 37021.81489092537, 37184.81407592945, 37903.86288411352, 41005.58994410137, 37908.05229869275, 37917.241655167294, 38187.80906095452, 38379.808100960436, 38655.80672096622, 38106.0, 38486.6151338483, 38648.42027369535, 38980.6101938977, 39032.0, 33365.499517506774, 33451.83274083614, 33761.83119084389, 33913.15217119493, 34205.0, 22632.207872724375, 25817.870910645328, 26063.827127778917, 26376.4724705501, 26601.600975984988], "unit": "score", "name": "ext.html", "value": 19997.50655357316}, {"lowerIsBetter": false, "replicates": [382.72635065927864, 384.6557331188586, 390.61914633232584, 395.4937679769894, 396.11270753512105, 16880.493585192435, 17425.128743562804, 20499.975001249953, 22335.3299401018, 23033.999999999978, 21335.039923203454, 21462.678059829075, 21855.672164917538, 21967.0, 22425.439364015907, 5943.910841337372, 6037.124616930542, 6068.33248342682, 6072.574919755619, 6166.691665416712, 4444.844430444935, 4656.348111264426, 5400.324959380077, 5991.55063370249, 6630.63531505767, 6552.0, 6557.147570815811, 6561.704723287439, 6565.212174539038, 6569.40875321221, 6371.203599550056, 6472.320406357336, 6538.934610653881, 6550.574212676184, 6567.113439685653, 5634.3520495143175, 5676.545876329884, 5687.431256874321, 5689.971550142222, 5699.886002279973, 26712.332191695168, 27116.779744911528, 27372.31569210766, 27430.862845685642, 27641.447171056465, 2305.91929282476, 2394.305651361103, 2959.689232630564, 2965.229040449477, 2984.492636251842, 15161.393544258217, 15260.694786104326, 15405.537833865003, 15417.922910385489, 16309.673806523802, 1710.298777501231, 1794.7577077094556, 1842.4933143385542, 1864.3008871673123, 1867.2437662746609, 90827.54586227027, 106871.46564267206, 112392.0, 112745.0, 112824.0, 10737.476692977145, 11050.060744836617, 11077.556897724162, 11096.445177741081, 11132.0, 13733.176009439267, 13764.17414955106, 13775.586732398044, 13801.723965520634, 13804.0, 9043.954780226057, 9065.637374505079, 9091.590878410487, 9102.681406150752, 9220.631174753069, 9474.38416502925, 9485.66800161991, 9493.623424603395, 9532.0, 9603.135717785433, 6267.811965640947, 6369.235691717024, 6380.170577824946, 6383.265924418752, 6456.063870738717, 1537.415782002854, 1749.5188823073502, 1820.7541981832549, 1823.3982785680694, 1874.7187921811565, 809.5426084262373, 968.9903100969041, 992.4144754594679, 1001.3241062283075, 1099.6975831646362, 17893.21933285766, 20495.795042049685, 21773.782262177494, 21825.67261491079, 21848.126074956825, 1039.8180318444242, 1088.9292196007234, 1090.215045167494, 1096.1833434091652, 1143.588308209044, 11289.379084150287, 11391.829122563167, 11984.221025633306, 12018.338991355384, 12207.816882746765, 602321.0, 620572.0, 623497.0, 632333.0, 710968.0, 109366.0, 111964.44017779859, 112940.0, 113412.0, 116510.0, 938.7183844846519, 1126.9042131418921, 1164.7495788405533, 1178.9448443643064, 1182.6511179201984, 16464.0, 19418.61162776765, 20107.39677809668, 20173.2939347128, 20280.59438811245, 44827.551724483645, 49395.75302123466, 49698.503014969385, 49873.50126498689, 51581.0, 63803.36196637974, 67070.66464667645, 67938.3206167932, 68029.0, 70344.94482582663, 6943.652817359213, 8195.426320157532, 8227.341812655093, 8348.248657620601, 8528.573571321533, 13507.324633768469, 13760.93119534436, 13765.518206862711, 13862.306884655929, 13940.930295348458, 11620.883791162318, 11865.703357416134, 12004.339761313211, 12064.034877209977, 12224.266544007389, 9103.408278462144, 11400.201985861242, 11437.59968401102, 11447.0, 11917.34454605005, 11921.940390297994, 11926.642200733992, 12011.63965081049, 12086.637400877988, 12214.206076604993, 8171.673133074611, 8265.0, 8346.123657015925, 8356.373272004746, 8478.660853565789, 11712.063034957353, 11797.76404471923, 12019.098567607289, 12049.879501204876, 12198.939005305272], "unit": "score", "name": "jquery.html", "value": 10015.414317978606}, {"lowerIsBetter": false, "replicates": [1445.5518789175355, 1521.8325984141736, 1696.7285234362505, 1975.5357490989616, 2137.9786202137984, 8322.793194986723, 8887.333449991253, 9090.136437038487, 9094.45433274004, 9102.772430689236, 8804.559772011406, 9056.864147037799, 9069.455832650046, 9078.182963533298, 9079.18287354138, 2575.7037940636833, 2602.336404216922, 2603.2060221632396, 2604.960925586118, 2605.804564657649, 2339.649052642109, 2543.694756629198, 2608.5174242765056, 2608.647832542611, 2613.098481024044, 2603.1409634820557, 2609.386794103384, 2621.7640412362884, 2628.7239839816734, 2638.854862982535, 2584.844909305448, 2601.700804407489, 2609.008576740836, 2621.8689065546646, 2624.4619852930105, 2166.8049875511124, 2605.557055300603, 2614.5293847107514, 2639.0895141176265, 2644.7487488688544, 9098.408603440756, 9162.404443711137, 9163.450192988443, 9185.219256363218, 9195.356325057248, 5720.71396430181, 5822.7088645567555, 5861.443162899518, 5868.706564671749, 5879.412058794129, 3222.871085156591, 3625.0, 3641.6176301488226, 3716.535433070866, 3794.0, 1077.3643550305278, 1092.819684752015, 1095.2825899036145, 1130.2822707580663, 1133.4389477208751, 12572.182808117443, 12574.43415046316, 12584.74830503394, 12594.81107783384, 12605.0, 5083.847484575469, 5099.770510327045, 5170.896582068338, 5174.663646862942, 5198.584113270929, 10605.522751476203, 10629.4153821539, 10640.68077957647, 10660.093892019266, 10660.840087398696, 5750.626209296466, 5819.970900145472, 5841.269841269841, 5842.211301474332, 5866.560007999417, 4348.825817029385, 4388.846390376321, 4701.905961880743, 4751.144793937125, 5270.736463176902, 3936.7047471439755, 4078.57174996627, 4095.7542547447247, 4163.000879788829, 4223.831046758157, 1331.483774095227, 1357.7623915814693, 1367.9261779503042, 1370.9451621935011, 1376.1880490510646, 1228.152574723438, 1253.486070711004, 1270.6632742323293, 1465.5383554180612, 1474.1744623011148, 8429.789255268668, 8548.273396761346, 8568.10034946334, 8601.483910965362, 8618.224359807647, 1241.596481143632, 1244.197492617275, 1254.6988722706485, 1256.296473974577, 1282.2691066092239, 6540.8364790880605, 6565.67171641416, 6656.034874943203, 6660.600363978177, 6671.032700258435, 10913.399763012952, 11312.095032397388, 11438.142139339416, 11455.885441145649, 11492.942535287437, 10947.343159410302, 11014.39420831862, 11198.496067676973, 11203.271787333797, 11281.041111505614, 7472.738454154079, 8712.0416754157, 8761.430507017023, 8818.426802257833, 8838.823223535494, 8272.503649781032, 8291.253787159185, 8295.087540370676, 8389.993200815941, 8399.328053755808, 9915.65295214664, 10016.348937319051, 10048.497575121068, 10156.898431015596, 10187.694369168938, 10196.949015254877, 10373.0, 10373.377597344184, 10397.272190946562, 10584.8941510587, 5933.673647949404, 7700.460967732205, 7977.202279772208, 7985.72049978248, 7990.121086680577, 7953.403494737802, 8376.58117094155, 8557.48655080697, 8571.742847714579, 8600.354973376896, 7479.439042071976, 7554.811129721801, 7558.093028836574, 7673.654685539276, 7706.267904549059, 7420.814479638052, 7479.102507699111, 7547.396208303213, 7584.582847943416, 7614.8096297593, 8035.718749843727, 8119.512829230265, 8136.593170341341, 8136.959315203386, 8145.266925976691, 7200.135983681992, 7285.7085716572865, 7350.448716346188, 7362.042934418491, 7362.7054917804835, 7420.109586849612, 7481.812954676177, 7490.887636685563, 7500.774976750707, 7502.587357695161], "unit": "score", "name": "mootools.html", "value": 5178.730354474084}, {"lowerIsBetter": false, "replicates": [340.45357201691286, 343.21232770791033, 349.1358886755281, 349.3432347187291, 354.5390991710777, 6782.050512928194, 6795.0, 6821.65891705414, 6834.487413443987, 6845.931540684592, 6820.590764554117, 6831.965840170805, 6833.726650933969, 6836.589804611727, 6836.9402742574985, 4861.343718597997, 5012.649114561982, 5023.874403139933, 5035.949640503603, 5100.107481190805, 4177.874663760077, 4922.138625740499, 4945.901081978358, 5048.040872234282, 5085.440601533847, 4990.3762029746285, 4990.476000019982, 4997.550220480156, 4998.375203099613, 5014.899702005958, 4090.3250963591267, 4519.661025423106, 4560.6351491880905, 5001.374828146481, 5028.798848046092, 4160.729552579072, 4206.053637931441, 4320.697551171419, 4324.783760811978, 4337.7180483268485, 6451.83870403239, 6467.902981455282, 6513.381228783258, 6521.869562608768, 6529.34706529348, 5932.851678708067, 5941.316748573926, 5948.613340132878, 5950.1372301016545, 5953.077273022688, 5810.273715785527, 7207.864578908139, 7220.097487814023, 7233.819154521127, 7243.529170603894, 4700.059988002413, 4824.107540105057, 4832.710037397767, 4839.032193561302, 4844.20070688336, 7429.739959101459, 7520.6991720331125, 7526.02161718973, 7535.811604709871, 7569.3566046886635, 4934.358533390637, 4957.479464656231, 4971.1797553404, 4972.751362431936, 4978.551930326288, 4439.533848945879, 5072.087024335655, 5076.847694569169, 5084.771185296597, 5086.4659210783075, 5921.881562368814, 5933.376995415506, 5935.6735379553675, 5935.82192534216, 5962.522998160137, 6946.097007389007, 7196.352328290479, 7212.242714515005, 7226.566406015656, 7274.781756547312, 1741.2947756158776, 1752.9824701752818, 1766.6996610576232, 1769.7699299091294, 1773.2463702926464, 1128.8476055732372, 1129.2603344809163, 1152.662911023209, 1156.6125348008343, 1161.814109742437, 6729.0, 6892.655367231619, 6895.448364130857, 6959.164900212007, 6974.093367862146, 7408.369898749574, 7427.702891884373, 7434.73978410753, 7606.353459955855, 7612.8477430452185, 7021.754238601625, 7043.190033146151, 7044.964775176194, 7052.224255331909, 7075.716971321192, 3974.324364857981, 4008.899777505586, 4010.598940106024, 4017.2568074906235, 4019.1760689058674, 7529.435292353095, 7846.646900889474, 7901.644426000844, 7914.129445760962, 7936.206379362017, 7222.0, 7752.26353496417, 7761.301482866456, 7770.883436748453, 7782.64978075988, 6371.74513019474, 7870.331021863206, 7879.448438609243, 7886.132525422199, 7887.605619718991, 6047.667378294236, 7475.775726728207, 7481.064866891638, 7488.400927925862, 7494.325510704063, 6671.566348187353, 6777.712234675396, 7027.964860175666, 7395.630218488946, 7400.0, 7773.73503128676, 7842.960785196037, 7844.646990885538, 7849.01887264092, 7887.369010479262, 4149.25313443583, 4932.63005274613, 4954.603631709382, 4961.90838015636, 4977.4524802271, 6325.905111423424, 7191.712331506681, 7453.627318633939, 7461.141968673455, 7480.625968701652, 5793.812268485035, 7202.96398518004, 7340.96329518349, 7388.815279618053, 7414.0, 6586.736530538725, 6810.523263371715, 7316.9634151828905, 7362.116546014512, 7363.190049094488, 7190.352868241884, 7190.4607154464675, 7201.495895287279, 7204.53170543913, 7213.278672132745, 7061.293870612898, 7327.0841144856895, 7334.486585938933, 7337.853242935218, 7348.0, 6958.7216511341, 7158.570485770871, 7181.928180718126, 7185.030020947105, 7224.0], "unit": "score", "name": "prototype.html", "value": 5318.966835878519}, {"lowerIsBetter": false, "replicates": [726.378946001169, 781.6873250699723, 793.761871438569, 797.9202079792018, 820.3683163963747, 15342.38630454782, 15497.92251038746, 15648.139352335616, 15650.982686125393, 15652.608684782886, 15029.62425939352, 15102.093874367545, 15124.0, 15127.697446051072, 15133.54599362021, 847.7075408983922, 858.4248553469159, 860.8278344331128, 960.0783248081832, 1007.3502590828911, 857.6269322844552, 994.9452780097092, 1020.9132223760989, 1023.7082431506984, 1024.5287167902773, 1055.435342091981, 1058.095328494138, 1060.204846365226, 1062.3731998121107, 1065.211743309953, 866.2766589897443, 1051.6582110813977, 1052.168786658539, 1056.2922841696081, 1056.5192837259067, 770.6647608290356, 785.4698078796789, 787.0398114300601, 787.9881801772977, 788.2590365056828, 15729.449469268635, 15907.681846363124, 15909.840901590951, 15921.761173582405, 15943.760843587355, 13171.209727416386, 13447.125936814173, 13468.730625387536, 13509.932450337783, 13639.659008524766, 8888.244499217575, 10372.688819335432, 10575.418351990638, 10917.344959302467, 10918.399488028155, 3172.2703778130926, 3209.1977005748563, 3239.951400728991, 3263.3473305339026, 3274.197821533716, 79769.0, 81285.3742925144, 86447.0, 89990.10009899882, 92287.53856230743, 9659.951700241454, 9736.805263894825, 9842.852357214648, 10005.44970026641, 10027.247956403298, 19817.702734458995, 20878.478038049172, 22339.0, 22401.327960161223, 22432.551348972927, 7404.629768511553, 7589.468737188454, 7591.3926885849, 7665.731699390494, 7719.961400193076, 3986.8405263789123, 4010.859619913289, 4044.988752811797, 4061.5532291447917, 4116.464859568297, 3645.4167333227088, 3695.1870588470492, 3713.220223752988, 3714.9969508232625, 3717.052151701299, 658.3646780856401, 662.3508961217937, 665.0954701605813, 671.9798406047729, 674.8279188806921, 625.2621906150695, 629.5404354820914, 637.8947473666885, 640.7084776426715, 668.3683918696785, 8176.591170441573, 8596.011458682331, 8610.397272190887, 8684.696035638848, 8696.086910874394, 570.611983850977, 586.8151532267323, 592.1325258496323, 596.3499785234116, 603.7947097986705, 3740.532433445819, 3797.810109494514, 3912.7073794374583, 4053.756774593534, 4206.936895946563, 90919.1203876258, 91076.0, 91506.39182885834, 92003.53998229966, 92704.60943085859, 80364.0, 80456.5977170122, 80852.59573702094, 80886.19113808904, 82359.5882020586, 66947.0, 71558.64220678863, 71831.0, 71974.0, 73458.63270683719, 6230.813075607739, 6651.534392592472, 7502.36229920441, 8189.262966333059, 8480.703175388831, 39193.41209881911, 49780.00439991253, 50343.0, 50436.747816260686, 51623.741881290356, 66768.6661566689, 67456.66271668806, 67749.0, 68567.65716171387, 69803.0, 10409.9479502602, 11351.886481135083, 11423.714407139889, 11828.52685892589, 12143.33211673331, 10345.0, 12030.09774266951, 12054.276743395425, 12161.270323780602, 12529.749405012031, 10452.947735261276, 10975.560977560808, 12006.39968001579, 12096.883045467184, 12288.262704237774, 11754.647360579196, 11836.70408239801, 11891.28652280866, 12295.262284262973, 12347.62957111288, 11832.46753896094, 11923.940380298043, 12033.63899083029, 12033.63899083029, 12034.217775844541, 10242.436665983145, 10255.230857685852, 10312.432816194882, 10388.324758890649, 10458.47707614601, 10177.18582513412, 10347.689569312932, 10352.689419317432, 10353.9482302588, 10371.740706482398], "unit": "score", "name": "yui.html", "value": 7140.990564400463}], "name": "dromaeo_css", "value": 7841.119992675193}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [153.0, 158.0, 141.0, 111.0, 112.0, 120.0, 174.0, 152.0, 110.0, 111.0], "unit": "score", "name": "ai-astar", "value": 134.2}, {"lowerIsBetter": true, "replicates": [155.0, 120.0, 137.0, 158.0, 118.0, 138.0, 140.0, 118.0, 159.0, 121.0], "unit": "score", "name": "audio-beat-detection", "value": 136.4}, {"lowerIsBetter": true, "replicates": [183.0, 184.0, 185.0, 184.0, 184.0, 181.0, 183.0, 182.0, 184.0, 183.0], "unit": "score", "name": "audio-dft", "value": 183.3}, {"lowerIsBetter": true, "replicates": [73.0, 71.0, 75.0, 112.0, 58.0, 68.0, 84.0, 84.0, 144.0, 56.0], "unit": "score", "name": "audio-fft", "value": 82.5}, {"lowerIsBetter": true, "replicates": [88.0, 87.0, 132.0, 78.0, 82.0, 112.0, 161.0, 114.0, 79.0, 121.0], "unit": "score", "name": "audio-oscillator", "value": 105.4}, {"lowerIsBetter": true, "replicates": [89.0, 87.0, 89.0, 88.0, 134.0, 130.0, 90.0, 88.0, 135.0, 131.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 106.1}, {"lowerIsBetter": true, "replicates": [94.0, 93.0, 95.0, 106.0, 150.0, 128.0, 94.0, 94.0, 93.0, 93.0], "unit": "score", "name": "imaging-darkroom", "value": 104.0}, {"lowerIsBetter": true, "replicates": [84.0, 85.0, 86.0, 87.0, 86.0, 84.0, 86.0, 84.0, 92.0, 85.0], "unit": "score", "name": "imaging-desaturate", "value": 85.9}, {"lowerIsBetter": true, "replicates": [56.0, 58.0, 58.0, 56.0, 57.0, 56.0, 57.0, 67.0, 51.0, 51.0], "unit": "score", "name": "json-parse-financial", "value": 56.7}, {"lowerIsBetter": true, "replicates": [63.0, 62.0, 65.0, 96.0, 111.0, 106.0, 87.0, 66.0, 68.0, 65.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 78.9}, {"lowerIsBetter": true, "replicates": [80.0, 81.0, 81.0, 80.0, 81.0, 97.0, 81.0, 80.0, 83.0, 85.0], "unit": "score", "name": "stanford-crypto-aes", "value": 82.9}, {"lowerIsBetter": true, "replicates": [129.0, 124.0, 106.0, 140.0, 144.0, 128.0, 125.0, 118.0, 118.0, 119.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 125.1}, {"lowerIsBetter": true, "replicates": [134.0, 123.0, 133.0, 131.0, 131.0, 123.0, 133.0, 131.0, 133.0, 130.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 130.2}, {"lowerIsBetter": true, "replicates": [66.0, 66.0, 65.0, 65.0, 65.0, 65.0, 65.0, 65.0, 65.0, 65.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 65.2}], "name": "kraken", "value": 1476.8000000000002}]} 02:55:46 INFO - Return code: 0 02:55:46 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 02:55:46 INFO - # TBPL SUCCESS # 02:55:46 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:55:46 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:55:46 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:55:46 INFO - 2016-05-12 02:55:46.168 screenresolution[1684:9676] starting screenresolution argv=screenresolution get 02:55:46 INFO - 2016-05-12 02:55:46.171 screenresolution[1684:9676] Display 0: 1600x1200x32@60 02:55:46 INFO - 2016-05-12 02:55:46.177 screenresolution[1685:9679] starting screenresolution argv=screenresolution list 02:55:46 INFO - Available Modes on Display 0 02:55:46 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:55:46 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:55:46 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:55:46 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:55:46 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:55:46 INFO - Intel Iris: 02:55:46 INFO - Chipset Model: Intel Iris 02:55:46 INFO - Type: GPU 02:55:46 INFO - Bus: Built-In 02:55:46 INFO - VRAM (Dynamic, Max): 1536 MB 02:55:46 INFO - Vendor: Intel (0x8086) 02:55:46 INFO - Device ID: 0x0a2e 02:55:46 INFO - Revision ID: 0x0009 02:55:46 INFO - Displays: 02:55:46 INFO - Display: 02:55:46 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:55:46 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:55:46 INFO - Display Serial Number: 1600x1200 60 02:55:46 INFO - Main Display: Yes 02:55:46 INFO - Mirror: Off 02:55:46 INFO - Online: Yes 02:55:46 INFO - Rotation: Supported 02:55:46 INFO - Return code: 0 02:55:46 INFO - Running post-action listener: _resource_record_post_action 02:55:46 INFO - Running post-run listener: _resource_record_post_run 02:55:47 INFO - Total resource usage - Wall time: 1194s; CPU: 52.0%; Read bytes: 37709312; Write bytes: 509229568; Read time: 390; Write time: 1799 02:55:47 INFO - install - Wall time: 23s; CPU: 55.0%; Read bytes: 200628736; Write bytes: 198120960; Read time: 18367; Write time: 407 02:55:47 INFO - run-tests - Wall time: 1172s; CPU: 52.0%; Read bytes: 35890688; Write bytes: 300315648; Read time: 368; Write time: 1359 02:55:47 INFO - Running post-run listener: _upload_blobber_files 02:55:47 INFO - Blob upload gear active. 02:55:47 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:55:47 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 02:55:47 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-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 02:55:47 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-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 02:55:47 INFO - (blobuploader) - INFO - Open directory for files ... 02:55:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 02:55:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:55:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:55:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 02:55:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:55:49 INFO - (blobuploader) - INFO - Done attempting. 02:55:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 02:55:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:55:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:55:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 02:55:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:55:50 INFO - (blobuploader) - INFO - Done attempting. 02:55:50 INFO - (blobuploader) - INFO - Iteration through files over. 02:55:50 INFO - Return code: 0 02:55:50 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:55:50 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:55:50 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/920b5c21e05073e30b9e5d2a78e19e40c807049b25f6da5355a8b4017083d283afa21f2f6a57e165bbb2fb72cd0b3bf0d7acc6601efb2319d261bf9354ace3c3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/387b18ae0614005bbe1734cfc91043f450f9970265075c10676cf832d296f5e4e5e1a34049325d55bcec3300d6a9c1df6f6c7e91907c60ba819df5e69d4878ae"} 02:55:50 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:55:50 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:55:50 INFO - Contents: 02:55:50 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/920b5c21e05073e30b9e5d2a78e19e40c807049b25f6da5355a8b4017083d283afa21f2f6a57e165bbb2fb72cd0b3bf0d7acc6601efb2319d261bf9354ace3c3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/387b18ae0614005bbe1734cfc91043f450f9970265075c10676cf832d296f5e4e5e1a34049325d55bcec3300d6a9c1df6f6c7e91907c60ba819df5e69d4878ae"} 02:55:50 INFO - Running post-run listener: copy_logs_to_upload_dir 02:55:50 INFO - Copying logs to upload dir... 02:55:50 INFO - mkdir: /builds/slave/test/build/upload/logs 02:55:50 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1251.218689 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2016-05-12 02:55:50.206476) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-12 02:55:50.210030) ========= 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.dxlwsU3iJd/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.M2cLfD0gwi/Listeners TMPDIR=/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/920b5c21e05073e30b9e5d2a78e19e40c807049b25f6da5355a8b4017083d283afa21f2f6a57e165bbb2fb72cd0b3bf0d7acc6601efb2319d261bf9354ace3c3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/387b18ae0614005bbe1734cfc91043f450f9970265075c10676cf832d296f5e4e5e1a34049325d55bcec3300d6a9c1df6f6c7e91907c60ba819df5e69d4878ae"} build_url:https://queue.taskcluster.net/v1/task/FMxRyLb7RbKJquwN8ScKGw/artifacts/public/build/firefox-47.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010777 build_url: 'https://queue.taskcluster.net/v1/task/FMxRyLb7RbKJquwN8ScKGw/artifacts/public/build/firefox-47.0.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/920b5c21e05073e30b9e5d2a78e19e40c807049b25f6da5355a8b4017083d283afa21f2f6a57e165bbb2fb72cd0b3bf0d7acc6601efb2319d261bf9354ace3c3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/387b18ae0614005bbe1734cfc91043f450f9970265075c10676cf832d296f5e4e5e1a34049325d55bcec3300d6a9c1df6f6c7e91907c60ba819df5e69d4878ae"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-12 02:55:50.237377) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-12 02:55:50.237712) ========= 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.dxlwsU3iJd/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.M2cLfD0gwi/Listeners TMPDIR=/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/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.005106 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-12 02:55:50.289404) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-12 02:55:50.290234) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-12 02:55:50.290976) ========= ========= Total master_lag: 0.17 =========