builder: mozilla-beta_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0055 starttime: 1469028928.25 results: success (0) buildid: 20160720071819 builduid: 58da0a028d44484fa926789a8ae521c3 revision: 9e887ad7d5ebd5369782230a86c3a51f84e9ab0e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-20 08:35:28.250092) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-20 08:35:28.250600) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-20 08:35:28.250916) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-20 08:35:28.275830) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-20 08:35:28.276274) ========= 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.wLzSYtGRUT/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.SxoBWlWQgp/Listeners TMPDIR=/var/folders/2f/bd59dv5s1jjgys2lwzvcz7vm00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-07-20 08:35:28-- 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% 184M=0s 2016-07-20 08:35:28 (184 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.135514 ========= master_lag: 0.09 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-20 08:35:28.505352) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-20 08:35:28.505729) ========= 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.wLzSYtGRUT/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.SxoBWlWQgp/Listeners TMPDIR=/var/folders/2f/bd59dv5s1jjgys2lwzvcz7vm00000w/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.029286 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-20 08:35:28.555514) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-20 08:35:28.555916) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 9e887ad7d5ebd5369782230a86c3a51f84e9ab0e --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 9e887ad7d5ebd5369782230a86c3a51f84e9ab0e --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.wLzSYtGRUT/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.SxoBWlWQgp/Listeners TMPDIR=/var/folders/2f/bd59dv5s1jjgys2lwzvcz7vm00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-07-20 08:35:28,662 truncating revision to first 12 chars 2016-07-20 08:35:28,662 Setting DEBUG logging. 2016-07-20 08:35:28,662 attempt 1/10 2016-07-20 08:35:28,662 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/9e887ad7d5eb?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-20 08:35:30,019 unpacking tar archive at: mozilla-beta-9e887ad7d5eb/testing/mozharness/ program finished with exit code 0 elapsedTime=1.615848 ========= master_lag: 0.05 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-20 08:35:30.223307) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-20 08:35:30.223677) ========= script_repo_revision: 9e887ad7d5ebd5369782230a86c3a51f84e9ab0e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-20 08:35:30.224118) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-20 08:35:30.224396) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-20 08:35:30.243529) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2016-07-20 08:35:30.243886) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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.wLzSYtGRUT/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.SxoBWlWQgp/Listeners TMPDIR=/var/folders/2f/bd59dv5s1jjgys2lwzvcz7vm00000w/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 08:35:30 INFO - MultiFileLogger online at 20160720 08:35:30 in /builds/slave/test 08:35:30 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 08:35:30 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:35:30 INFO - {'append_to_log': False, 08:35:30 INFO - 'base_work_dir': '/builds/slave/test', 08:35:30 INFO - 'blob_upload_branch': 'Mozilla-Beta', 08:35:30 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:35:30 INFO - 'branch': 'Mozilla-Beta', 08:35:30 INFO - 'buildbot_json_path': 'buildprops.json', 08:35:30 INFO - 'config_files': ('talos/mac_config.py',), 08:35:30 INFO - 'default_actions': ('clobber', 08:35:30 INFO - 'read-buildbot-config', 08:35:30 INFO - 'download-and-extract', 08:35:30 INFO - 'populate-webroot', 08:35:30 INFO - 'create-virtualenv', 08:35:30 INFO - 'install', 08:35:30 INFO - 'run-tests'), 08:35:30 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:35:30 INFO - 'download_minidump_stackwalk': True, 08:35:30 INFO - 'download_symbols': 'ondemand', 08:35:30 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:35:30 INFO - 'tooltool.py': '/tools/tooltool.py', 08:35:30 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:35:30 INFO - '/tools/misc-python/virtualenv.py')}, 08:35:30 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:35:30 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:35:30 INFO - 'installer_path': 'installer.exe', 08:35:30 INFO - 'log_level': 'info', 08:35:30 INFO - 'log_name': 'talos', 08:35:30 INFO - 'log_to_console': True, 08:35:30 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 08:35:30 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 08:35:30 INFO - 'opt_config_files': (), 08:35:30 INFO - 'pip_index': False, 08:35:30 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:35:30 INFO - 'cmd': ('bash', 08:35:30 INFO - '-c', 08:35:30 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:35:30 INFO - 'enabled': True, 08:35:30 INFO - 'halt_on_failure': False, 08:35:30 INFO - 'name': 'check_screen_resolution'},), 08:35:30 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:35:30 INFO - 'cmd': ('bash', 08:35:30 INFO - '-c', 08:35:30 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:35:30 INFO - 'enabled': True, 08:35:30 INFO - 'halt_on_failure': False, 08:35:30 INFO - 'name': 'check_screen_resolution'},), 08:35:30 INFO - 'run_cmd_checks_enabled': True, 08:35:30 INFO - 'sps_profile': False, 08:35:30 INFO - 'sps_profile_interval': 0, 08:35:30 INFO - 'suite': 'dromaeojs-e10s', 08:35:30 INFO - 'system_bits': '32', 08:35:30 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:35:30 INFO - 'title': 't-yosemite-r7-0055', 08:35:30 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:35:30 INFO - 'use_talos_json': True, 08:35:30 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:35:30 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:35:30 INFO - 'work_dir': 'build'} 08:35:30 INFO - ##### 08:35:30 INFO - ##### Running clobber step. 08:35:30 INFO - ##### 08:35:30 INFO - Running pre-action listener: _resource_record_pre_action 08:35:30 INFO - Running main action method: clobber 08:35:30 INFO - rmtree: /builds/slave/test/build 08:35:30 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:35:32 INFO - Running post-action listener: _resource_record_post_action 08:35:32 INFO - ##### 08:35:32 INFO - ##### Running read-buildbot-config step. 08:35:32 INFO - ##### 08:35:32 INFO - Running pre-action listener: _resource_record_pre_action 08:35:32 INFO - Running main action method: read_buildbot_config 08:35:32 INFO - Using buildbot properties: 08:35:32 INFO - { 08:35:32 INFO - "project": "", 08:35:32 INFO - "product": "firefox", 08:35:32 INFO - "script_repo_revision": "production", 08:35:32 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs-e10s", 08:35:32 INFO - "repository": "", 08:35:32 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs-e10s", 08:35:32 INFO - "buildid": "20160720071819", 08:35:32 INFO - "pgo_build": "False", 08:35:32 INFO - "basedir": "/builds/slave/test", 08:35:32 INFO - "buildnumber": 35, 08:35:32 INFO - "slavename": "t-yosemite-r7-0055", 08:35:32 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 08:35:32 INFO - "platform": "yosemite_r7", 08:35:32 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 08:35:32 INFO - "branch": "mozilla-beta", 08:35:32 INFO - "repo_path": "releases/mozilla-beta", 08:35:32 INFO - "revision": "9e887ad7d5ebd5369782230a86c3a51f84e9ab0e", 08:35:32 INFO - "stage_platform": "macosx64", 08:35:32 INFO - "builduid": "58da0a028d44484fa926789a8ae521c3", 08:35:32 INFO - "slavebuilddir": "test" 08:35:32 INFO - } 08:35:32 INFO - Found installer url https://queue.taskcluster.net/v1/task/W_FQVZAfS4eUOCn6MeHuhw/artifacts/public/build/firefox-48.0.en-US.mac.dmg. 08:35:32 INFO - Running post-action listener: _resource_record_post_action 08:35:32 INFO - ##### 08:35:32 INFO - ##### Running download-and-extract step. 08:35:32 INFO - ##### 08:35:32 INFO - Running pre-action listener: _resource_record_pre_action 08:35:32 INFO - Running main action method: download_and_extract 08:35:32 INFO - mkdir: /builds/slave/test/build/tests 08:35:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:35:32 INFO - https://queue.taskcluster.net/v1/task/W_FQVZAfS4eUOCn6MeHuhw/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json matches https://queue.taskcluster.net 08:35:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W_FQVZAfS4eUOCn6MeHuhw/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json 08:35:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W_FQVZAfS4eUOCn6MeHuhw/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json 08:35:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W_FQVZAfS4eUOCn6MeHuhw/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json 08:35:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W_FQVZAfS4eUOCn6MeHuhw/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json'}, attempt #1 08:35:33 INFO - Downloaded 1165 bytes. 08:35:33 INFO - Reading from file /builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json 08:35:33 INFO - Using the following test package requirements: 08:35:33 INFO - {u'common': [u'firefox-48.0.en-US.mac.common.tests.zip'], 08:35:33 INFO - u'cppunittest': [u'firefox-48.0.en-US.mac.common.tests.zip', 08:35:33 INFO - u'firefox-48.0.en-US.mac.cppunittest.tests.zip'], 08:35:33 INFO - u'gtest': [u'firefox-48.0.en-US.mac.common.tests.zip', 08:35:33 INFO - u'firefox-48.0.en-US.mac.gtest.tests.zip'], 08:35:33 INFO - u'jittest': [u'firefox-48.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 08:35:33 INFO - u'mochitest': [u'firefox-48.0.en-US.mac.common.tests.zip', 08:35:33 INFO - u'firefox-48.0.en-US.mac.mochitest.tests.zip'], 08:35:33 INFO - u'mozbase': [u'firefox-48.0.en-US.mac.common.tests.zip'], 08:35:33 INFO - u'reftest': [u'firefox-48.0.en-US.mac.common.tests.zip', 08:35:33 INFO - u'firefox-48.0.en-US.mac.reftest.tests.zip'], 08:35:33 INFO - u'talos': [u'firefox-48.0.en-US.mac.common.tests.zip', 08:35:33 INFO - u'firefox-48.0.en-US.mac.talos.tests.zip'], 08:35:33 INFO - u'web-platform': [u'firefox-48.0.en-US.mac.common.tests.zip', 08:35:33 INFO - u'firefox-48.0.en-US.mac.web-platform.tests.zip'], 08:35:33 INFO - u'xpcshell': [u'firefox-48.0.en-US.mac.common.tests.zip', 08:35:33 INFO - u'firefox-48.0.en-US.mac.xpcshell.tests.zip']} 08:35:33 INFO - Downloading packages: [u'firefox-48.0.en-US.mac.common.tests.zip'] for test suite category: common 08: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')]} 08:35:33 INFO - https://queue.taskcluster.net/v1/task/W_FQVZAfS4eUOCn6MeHuhw/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 08:35:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W_FQVZAfS4eUOCn6MeHuhw/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 08:35:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W_FQVZAfS4eUOCn6MeHuhw/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 08:35:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W_FQVZAfS4eUOCn6MeHuhw/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip 08:35:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W_FQVZAfS4eUOCn6MeHuhw/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip'}, attempt #1 08:35:38 INFO - Downloaded 18314738 bytes. 08:35:38 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:35:38 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 08:35:41 INFO - Return code: 0 08:35:41 INFO - Downloading packages: [u'firefox-48.0.en-US.mac.common.tests.zip', u'firefox-48.0.en-US.mac.talos.tests.zip'] for test suite category: talos 08:35:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:35:41 INFO - https://queue.taskcluster.net/v1/task/W_FQVZAfS4eUOCn6MeHuhw/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 08:35:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W_FQVZAfS4eUOCn6MeHuhw/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 08:35:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W_FQVZAfS4eUOCn6MeHuhw/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 08:35:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W_FQVZAfS4eUOCn6MeHuhw/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip 08:35:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W_FQVZAfS4eUOCn6MeHuhw/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip'}, attempt #1 08:35:42 INFO - Downloaded 18314738 bytes. 08:35:42 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:35:42 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 08:35:46 INFO - Return code: 0 08: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')]} 08:35:46 INFO - https://queue.taskcluster.net/v1/task/W_FQVZAfS4eUOCn6MeHuhw/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 08:35:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W_FQVZAfS4eUOCn6MeHuhw/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip 08:35:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W_FQVZAfS4eUOCn6MeHuhw/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip 08:35:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W_FQVZAfS4eUOCn6MeHuhw/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip 08:35:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W_FQVZAfS4eUOCn6MeHuhw/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip'}, attempt #1 08:35:47 INFO - Downloaded 10840145 bytes. 08:35:47 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:35:47 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 08:35:48 INFO - Return code: 0 08:35:48 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')]} 08:35:48 INFO - https://queue.taskcluster.net/v1/task/W_FQVZAfS4eUOCn6MeHuhw/artifacts/public/build/firefox-48.0.en-US.mac.dmg matches https://queue.taskcluster.net 08:35:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W_FQVZAfS4eUOCn6MeHuhw/artifacts/public/build/firefox-48.0.en-US.mac.dmg 08:35:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W_FQVZAfS4eUOCn6MeHuhw/artifacts/public/build/firefox-48.0.en-US.mac.dmg 08:35:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W_FQVZAfS4eUOCn6MeHuhw/artifacts/public/build/firefox-48.0.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0.en-US.mac.dmg 08:35:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W_FQVZAfS4eUOCn6MeHuhw/artifacts/public/build/firefox-48.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.mac.dmg'}, attempt #1 08:35:51 INFO - Downloaded 86191408 bytes. 08:35:51 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/W_FQVZAfS4eUOCn6MeHuhw/artifacts/public/build/firefox-48.0.en-US.mac.dmg 08:35:51 INFO - mkdir: /builds/slave/test/properties 08:35:51 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:35:51 INFO - Writing to file /builds/slave/test/properties/build_url 08:35:51 INFO - Contents: 08:35:51 INFO - build_url:https://queue.taskcluster.net/v1/task/W_FQVZAfS4eUOCn6MeHuhw/artifacts/public/build/firefox-48.0.en-US.mac.dmg 08:35:52 INFO - Running post-action listener: _resource_record_post_action 08:35:52 INFO - Running post-action listener: set_extra_try_arguments 08:35:52 INFO - ##### 08:35:52 INFO - ##### Running populate-webroot step. 08:35:52 INFO - ##### 08:35:52 INFO - Running pre-action listener: _resource_record_pre_action 08:35:52 INFO - Running main action method: populate_webroot 08:35:52 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:35:52 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:35:52 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:35:52 INFO - '--tppagecycles', 08:35:52 INFO - '7'], 08:35:52 INFO - 'tests': ['tsvgm']}}, 08:35:52 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:35:52 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:35:52 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:35:52 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:35:52 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:35:52 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:35:52 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:35:52 INFO - 'talos_options': ['--disable-e10s'], 08:35:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:35:52 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:35:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:35:52 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:35:52 INFO - 'talos_options': ['--disable-e10s'], 08:35:52 INFO - 'tests': ['damp', 'tps']}, 08:35:52 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:35:52 INFO - 'tests': ['damp', 'tps']}, 08:35:52 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:35:52 INFO - 'tests': ['dromaeo_dom']}, 08:35:52 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:35:52 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:35:52 INFO - 'tests': ['a11yr', 08:35:52 INFO - 'ts_paint', 08:35:52 INFO - 'tpaint', 08:35:52 INFO - 'sessionrestore', 08:35:52 INFO - 'sessionrestore_no_auto_restore', 08:35:52 INFO - 'tabpaint']}, 08:35:52 INFO - 'other-e10s': {'tests': ['a11yr', 08:35:52 INFO - 'ts_paint', 08:35:52 INFO - 'tpaint', 08:35:52 INFO - 'sessionrestore', 08:35:52 INFO - 'sessionrestore_no_auto_restore', 08:35:52 INFO - 'tabpaint']}, 08:35:52 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:35:52 INFO - 'ts_paint', 08:35:52 INFO - 'tpaint', 08:35:52 INFO - 'sessionrestore', 08:35:52 INFO - 'sessionrestore_no_auto_restore', 08:35:52 INFO - 'tabpaint']}, 08:35:52 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:35:52 INFO - 'ts_paint', 08:35:52 INFO - 'tpaint', 08:35:52 INFO - 'sessionrestore', 08:35:52 INFO - 'sessionrestore_no_auto_restore', 08:35:52 INFO - 'tabpaint']}, 08:35:52 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:35:52 INFO - 'tests': ['a11yr', 08:35:52 INFO - 'ts_paint', 08:35:52 INFO - 'tpaint', 08:35:52 INFO - 'sessionrestore', 08:35:52 INFO - 'sessionrestore_no_auto_restore', 08:35:52 INFO - 'tabpaint']}, 08:35:52 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:35:52 INFO - 'tests': ['a11yr', 08:35:52 INFO - 'ts_paint', 08:35:52 INFO - 'tpaint', 08:35:52 INFO - 'sessionrestore', 08:35:52 INFO - 'sessionrestore_no_auto_restore', 08:35:52 INFO - 'tabpaint']}, 08:35:52 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:35:52 INFO - 'tests': ['tsvgx', 08:35:52 INFO - 'tsvgr_opacity', 08:35:52 INFO - 'tart', 08:35:52 INFO - 'tscrollx', 08:35:52 INFO - 'cart']}, 08:35:52 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:35:52 INFO - 'tsvgr_opacity', 08:35:52 INFO - 'tart', 08:35:52 INFO - 'tscrollx', 08:35:52 INFO - 'cart']}, 08:35:52 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:35:52 INFO - 'talos_options': ['--disable-e10s'], 08:35:52 INFO - 'tests': ['tp5o']}, 08:35:52 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:35:52 INFO - 'tests': ['tp5o']}, 08:35:52 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:35:52 INFO - 'talos_options': ['--disable-e10s', 08:35:52 INFO - '--xperf_path', 08:35:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:35:52 INFO - 'tests': ['tp5n']}, 08:35:52 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:35:52 INFO - 'talos_options': ['--xperf_path', 08:35:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:35:52 INFO - 'tests': ['tp5n']}}, 08:35:52 INFO - 'talos.zip': {'path': '', 08:35:52 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:35:52 INFO - Running post-action listener: _resource_record_post_action 08:35:52 INFO - ##### 08:35:52 INFO - ##### Running create-virtualenv step. 08:35:52 INFO - ##### 08:35:52 INFO - Running pre-action listener: _resource_record_pre_action 08:35:52 INFO - Running main action method: create_virtualenv 08:35:52 INFO - Creating virtualenv /builds/slave/test/build/venv 08:35:52 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 08:35:52 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:35:52 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:35:52 INFO - Using real prefix '/tools/python27' 08:35:52 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:35:53 INFO - Installing distribute.............................................................................................................................................................................................done. 08:35:56 INFO - Installing pip.................done. 08:35:56 INFO - Return code: 0 08:35:56 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:35:56 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')]} 08:35:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:35:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:35:56 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')]} 08:35:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:35:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:35:56 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 0x108528a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108538420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbc0bc84e40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1083c7e00>, '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 0x108230db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1083c2b20>, '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.wLzSYtGRUT/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.SxoBWlWQgp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2f/bd59dv5s1jjgys2lwzvcz7vm00000w/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 08:35:56 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 08:35:56 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 08:35:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wLzSYtGRUT/Render', 08:35:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:35:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:35:56 INFO - 'HOME': '/Users/cltbld', 08:35:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:35:56 INFO - 'LOGNAME': 'cltbld', 08:35:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:35:56 INFO - 'MOZ_NO_REMOTE': '1', 08:35:56 INFO - 'NO_EM_RESTART': '1', 08:35:56 INFO - 'PAGER': '/bin/cat', 08:35:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:35:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:35:56 INFO - 'PWD': '/builds/slave/test', 08:35:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:35:56 INFO - 'SHELL': '/bin/bash', 08:35:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SxoBWlWQgp/Listeners', 08:35:56 INFO - 'TMPDIR': '/var/folders/2f/bd59dv5s1jjgys2lwzvcz7vm00000w/T/', 08:35:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:35:56 INFO - 'USER': 'cltbld', 08:35:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:35:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:35:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:35:56 INFO - 'XPC_FLAGS': '0x0', 08:35:56 INFO - 'XPC_SERVICE_NAME': '0', 08:35:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:35:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:35:56 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 08:35:56 INFO - Cleaning up... 08:35:56 INFO - Return code: 0 08:35:56 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 08:35:56 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')]} 08:35:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:35:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:35:56 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')]} 08:35:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:35:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:35:56 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 0x108528a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108538420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbc0bc84e40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1083c7e00>, '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 0x108230db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1083c2b20>, '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.wLzSYtGRUT/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.SxoBWlWQgp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2f/bd59dv5s1jjgys2lwzvcz7vm00000w/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 08:35:56 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 08:35:56 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 08:35:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wLzSYtGRUT/Render', 08:35:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:35:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:35:56 INFO - 'HOME': '/Users/cltbld', 08:35:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:35:56 INFO - 'LOGNAME': 'cltbld', 08:35:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:35:56 INFO - 'MOZ_NO_REMOTE': '1', 08:35:56 INFO - 'NO_EM_RESTART': '1', 08:35:56 INFO - 'PAGER': '/bin/cat', 08:35:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:35:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:35:56 INFO - 'PWD': '/builds/slave/test', 08:35:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:35:56 INFO - 'SHELL': '/bin/bash', 08:35:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SxoBWlWQgp/Listeners', 08:35:56 INFO - 'TMPDIR': '/var/folders/2f/bd59dv5s1jjgys2lwzvcz7vm00000w/T/', 08:35:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:35:56 INFO - 'USER': 'cltbld', 08:35:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:35:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:35:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:35:56 INFO - 'XPC_FLAGS': '0x0', 08:35:56 INFO - 'XPC_SERVICE_NAME': '0', 08:35:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:35:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:35:56 INFO - Downloading/unpacking psutil>=0.7.1 08:35:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:35:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:35:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:35:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:35:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:35:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:35:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:35:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:35:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:35:59 INFO - Installing collected packages: psutil 08:35:59 INFO - Running setup.py install for psutil 08:35:59 INFO - building 'psutil._psutil_osx' extension 08:35:59 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 08:36:00 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 08:36:00 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 08:36:00 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 08:36:00 INFO - building 'psutil._psutil_posix' extension 08:36:00 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 08:36:00 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 08:36:00 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 08:36:00 INFO - ^ 08:36:00 INFO - 1 warning generated. 08:36:00 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 08:36:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:36:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:36:00 INFO - Successfully installed psutil 08:36:00 INFO - Cleaning up... 08:36:00 INFO - Return code: 0 08:36:00 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 08:36: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')]} 08:36:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:36:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:36: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')]} 08:36:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:36:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:36:00 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 0x108528a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108538420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbc0bc84e40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1083c7e00>, '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 0x108230db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1083c2b20>, '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.wLzSYtGRUT/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.SxoBWlWQgp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2f/bd59dv5s1jjgys2lwzvcz7vm00000w/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 08:36:00 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 08:36:00 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 08:36:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wLzSYtGRUT/Render', 08:36:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:36:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:36:00 INFO - 'HOME': '/Users/cltbld', 08:36:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:36:00 INFO - 'LOGNAME': 'cltbld', 08:36:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:36:00 INFO - 'MOZ_NO_REMOTE': '1', 08:36:00 INFO - 'NO_EM_RESTART': '1', 08:36:00 INFO - 'PAGER': '/bin/cat', 08:36:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:36:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:36:00 INFO - 'PWD': '/builds/slave/test', 08:36:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:36:00 INFO - 'SHELL': '/bin/bash', 08:36:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SxoBWlWQgp/Listeners', 08:36:00 INFO - 'TMPDIR': '/var/folders/2f/bd59dv5s1jjgys2lwzvcz7vm00000w/T/', 08:36:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:36:00 INFO - 'USER': 'cltbld', 08:36:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:36:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:36:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:36:00 INFO - 'XPC_FLAGS': '0x0', 08:36:00 INFO - 'XPC_SERVICE_NAME': '0', 08:36:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:36:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:36:00 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 08:36:00 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 08:36:00 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 08:36:00 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 08:36:00 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 08:36:00 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 08:36:00 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 08:36:03 INFO - Downloading mozsystemmonitor-0.0.tar.gz 08:36:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:36:03 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 08:36:03 INFO - Installing collected packages: mozsystemmonitor 08:36:03 INFO - Running setup.py install for mozsystemmonitor 08:36:03 INFO - Successfully installed mozsystemmonitor 08:36:03 INFO - Cleaning up... 08:36:03 INFO - Return code: 0 08:36:03 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:36:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:36:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:36:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:36:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:36:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:36:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:36:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x108528a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108538420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbc0bc84e40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1083c7e00>, '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 0x108230db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1083c2b20>, '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.wLzSYtGRUT/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.SxoBWlWQgp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2f/bd59dv5s1jjgys2lwzvcz7vm00000w/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 08:36:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:36:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:36:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wLzSYtGRUT/Render', 08:36:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:36:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:36:03 INFO - 'HOME': '/Users/cltbld', 08:36:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:36:03 INFO - 'LOGNAME': 'cltbld', 08:36:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:36:03 INFO - 'MOZ_NO_REMOTE': '1', 08:36:03 INFO - 'NO_EM_RESTART': '1', 08:36:03 INFO - 'PAGER': '/bin/cat', 08:36:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:36:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:36:03 INFO - 'PWD': '/builds/slave/test', 08:36:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:36:03 INFO - 'SHELL': '/bin/bash', 08:36:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SxoBWlWQgp/Listeners', 08:36:03 INFO - 'TMPDIR': '/var/folders/2f/bd59dv5s1jjgys2lwzvcz7vm00000w/T/', 08:36:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:36:03 INFO - 'USER': 'cltbld', 08:36:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:36:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:36:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:36:03 INFO - 'XPC_FLAGS': '0x0', 08:36:03 INFO - 'XPC_SERVICE_NAME': '0', 08:36:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:36:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:36:03 INFO - Downloading/unpacking blobuploader==1.2.4 08:36:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:36:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:36:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:36:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:36:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:36:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:36:06 INFO - Downloading blobuploader-1.2.4.tar.gz 08:36:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:36:06 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:36:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:36:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:36:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:36:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:36:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:36:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:36:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:36:07 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:36:07 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 08:36:07 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 08:36:07 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 08:36:07 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 08:36:07 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 08:36:07 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 08:36:07 INFO - Downloading docopt-0.6.1.tar.gz 08:36:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:36:07 INFO - Installing collected packages: blobuploader, requests, docopt 08:36:07 INFO - Running setup.py install for blobuploader 08:36:07 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:36:07 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:36:07 INFO - Running setup.py install for requests 08:36:08 INFO - Running setup.py install for docopt 08:36:08 INFO - Successfully installed blobuploader requests docopt 08:36:08 INFO - Cleaning up... 08:36:08 INFO - Return code: 0 08:36:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:36:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:36:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:36:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:36:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:36:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:36:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:36:08 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 0x108528a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108538420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbc0bc84e40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1083c7e00>, '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 0x108230db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1083c2b20>, '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.wLzSYtGRUT/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.SxoBWlWQgp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2f/bd59dv5s1jjgys2lwzvcz7vm00000w/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 08:36:08 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 08:36:08 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 08:36:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wLzSYtGRUT/Render', 08:36:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:36:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:36:08 INFO - 'HOME': '/Users/cltbld', 08:36:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:36:08 INFO - 'LOGNAME': 'cltbld', 08:36:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:36:08 INFO - 'MOZ_NO_REMOTE': '1', 08:36:08 INFO - 'NO_EM_RESTART': '1', 08:36:08 INFO - 'PAGER': '/bin/cat', 08:36:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:36:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:36:08 INFO - 'PWD': '/builds/slave/test', 08:36:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:36:08 INFO - 'SHELL': '/bin/bash', 08:36:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SxoBWlWQgp/Listeners', 08:36:08 INFO - 'TMPDIR': '/var/folders/2f/bd59dv5s1jjgys2lwzvcz7vm00000w/T/', 08:36:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:36:08 INFO - 'USER': 'cltbld', 08:36:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:36:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:36:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:36:08 INFO - 'XPC_FLAGS': '0x0', 08:36:08 INFO - 'XPC_SERVICE_NAME': '0', 08:36:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:36:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:36:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:36:08 INFO - Running setup.py (path:/var/folders/2f/bd59dv5s1jjgys2lwzvcz7vm00000w/T/pip-Cgn1Dv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:36:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:36:08 INFO - Running setup.py (path:/var/folders/2f/bd59dv5s1jjgys2lwzvcz7vm00000w/T/pip-eE3lyA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:36:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:36:08 INFO - Running setup.py (path:/var/folders/2f/bd59dv5s1jjgys2lwzvcz7vm00000w/T/pip-RDUw1q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:36:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:36:09 INFO - Running setup.py (path:/var/folders/2f/bd59dv5s1jjgys2lwzvcz7vm00000w/T/pip-26K1TF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:36:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:36:09 INFO - Running setup.py (path:/var/folders/2f/bd59dv5s1jjgys2lwzvcz7vm00000w/T/pip-EDAB8S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:36:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:36:09 INFO - Running setup.py (path:/var/folders/2f/bd59dv5s1jjgys2lwzvcz7vm00000w/T/pip-OlQkm7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:36:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:36:09 INFO - Running setup.py (path:/var/folders/2f/bd59dv5s1jjgys2lwzvcz7vm00000w/T/pip-uIgjGd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:36:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:36:09 INFO - Running setup.py (path:/var/folders/2f/bd59dv5s1jjgys2lwzvcz7vm00000w/T/pip-QJPB3X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:36:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:36:09 INFO - Running setup.py (path:/var/folders/2f/bd59dv5s1jjgys2lwzvcz7vm00000w/T/pip-Rn7pGC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:36:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:36:09 INFO - Running setup.py (path:/var/folders/2f/bd59dv5s1jjgys2lwzvcz7vm00000w/T/pip-1Jxb4d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:36:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:36:09 INFO - Running setup.py (path:/var/folders/2f/bd59dv5s1jjgys2lwzvcz7vm00000w/T/pip-oDjEz4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:36:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:36:09 INFO - Running setup.py (path:/var/folders/2f/bd59dv5s1jjgys2lwzvcz7vm00000w/T/pip-Js7hMj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:36:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:36:10 INFO - Running setup.py (path:/var/folders/2f/bd59dv5s1jjgys2lwzvcz7vm00000w/T/pip-xaGNOD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:36:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:36:10 INFO - Running setup.py (path:/var/folders/2f/bd59dv5s1jjgys2lwzvcz7vm00000w/T/pip-BZG71T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:36:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:36:10 INFO - Running setup.py (path:/var/folders/2f/bd59dv5s1jjgys2lwzvcz7vm00000w/T/pip-Ns7wcK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:36:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:36:10 INFO - Running setup.py (path:/var/folders/2f/bd59dv5s1jjgys2lwzvcz7vm00000w/T/pip-RpYo12-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:36:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:36:10 INFO - Running setup.py (path:/var/folders/2f/bd59dv5s1jjgys2lwzvcz7vm00000w/T/pip-zLK32V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:36:10 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:36:10 INFO - Running setup.py install for manifestparser 08:36:10 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:36:10 INFO - Running setup.py install for mozcrash 08:36:10 INFO - Running setup.py install for mozdebug 08:36:10 INFO - Running setup.py install for mozdevice 08:36:11 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:36:11 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:36:11 INFO - Running setup.py install for mozfile 08:36:11 INFO - Running setup.py install for mozhttpd 08:36:11 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:36:11 INFO - Running setup.py install for mozinfo 08:36:11 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:36:11 INFO - Running setup.py install for mozInstall 08:36:11 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:36:11 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:36:11 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:36:11 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:36:11 INFO - Running setup.py install for mozleak 08:36:11 INFO - Running setup.py install for mozlog 08:36:12 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:36:12 INFO - Running setup.py install for moznetwork 08:36:12 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:36:12 INFO - Running setup.py install for mozprocess 08:36:12 INFO - Running setup.py install for mozprofile 08:36:12 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:36:12 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:36:12 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:36:12 INFO - Running setup.py install for mozrunner 08:36:12 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:36:12 INFO - Running setup.py install for mozscreenshot 08:36:12 INFO - Running setup.py install for moztest 08:36:12 INFO - Running setup.py install for mozversion 08:36:13 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:36:13 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:36:13 INFO - Cleaning up... 08:36:13 INFO - Return code: 0 08:36:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:36:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:36:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:36:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:36:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:36:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:36:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:36:13 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 0x108528a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108538420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbc0bc84e40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1083c7e00>, '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 0x108230db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1083c2b20>, '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.wLzSYtGRUT/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.SxoBWlWQgp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2f/bd59dv5s1jjgys2lwzvcz7vm00000w/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 08:36:13 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 08:36:13 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 08:36:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wLzSYtGRUT/Render', 08:36:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:36:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:36:13 INFO - 'HOME': '/Users/cltbld', 08:36:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:36:13 INFO - 'LOGNAME': 'cltbld', 08:36:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:36:13 INFO - 'MOZ_NO_REMOTE': '1', 08:36:13 INFO - 'NO_EM_RESTART': '1', 08:36:13 INFO - 'PAGER': '/bin/cat', 08:36:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:36:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:36:13 INFO - 'PWD': '/builds/slave/test', 08:36:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:36:13 INFO - 'SHELL': '/bin/bash', 08:36:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SxoBWlWQgp/Listeners', 08:36:13 INFO - 'TMPDIR': '/var/folders/2f/bd59dv5s1jjgys2lwzvcz7vm00000w/T/', 08:36:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:36:13 INFO - 'USER': 'cltbld', 08:36:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:36:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:36:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:36:13 INFO - 'XPC_FLAGS': '0x0', 08:36:13 INFO - 'XPC_SERVICE_NAME': '0', 08:36:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:36:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:36:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:36:13 INFO - Running setup.py (path:/var/folders/2f/bd59dv5s1jjgys2lwzvcz7vm00000w/T/pip-3BMr_N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:36:13 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)) 08:36:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:36:13 INFO - Running setup.py (path:/var/folders/2f/bd59dv5s1jjgys2lwzvcz7vm00000w/T/pip-52g9mV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:36:13 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)) 08:36:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:36:13 INFO - Running setup.py (path:/var/folders/2f/bd59dv5s1jjgys2lwzvcz7vm00000w/T/pip-qlhfdf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:36:13 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)) 08:36:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:36:13 INFO - Running setup.py (path:/var/folders/2f/bd59dv5s1jjgys2lwzvcz7vm00000w/T/pip-_z7ddC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:36:13 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)) 08:36:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:36:13 INFO - Running setup.py (path:/var/folders/2f/bd59dv5s1jjgys2lwzvcz7vm00000w/T/pip-NIp_Rh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:36:13 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)) 08:36:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:36:13 INFO - Running setup.py (path:/var/folders/2f/bd59dv5s1jjgys2lwzvcz7vm00000w/T/pip-YDqCS8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:36:14 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)) 08:36:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:36:14 INFO - Running setup.py (path:/var/folders/2f/bd59dv5s1jjgys2lwzvcz7vm00000w/T/pip-IKmwYZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:36:14 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)) 08:36:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:36:14 INFO - Running setup.py (path:/var/folders/2f/bd59dv5s1jjgys2lwzvcz7vm00000w/T/pip-lFtuSA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:36:14 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)) 08:36:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:36:14 INFO - Running setup.py (path:/var/folders/2f/bd59dv5s1jjgys2lwzvcz7vm00000w/T/pip-Px4CpG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:36:14 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)) 08:36:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:36:14 INFO - Running setup.py (path:/var/folders/2f/bd59dv5s1jjgys2lwzvcz7vm00000w/T/pip-mlAfxW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:36:14 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)) 08:36:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:36:14 INFO - Running setup.py (path:/var/folders/2f/bd59dv5s1jjgys2lwzvcz7vm00000w/T/pip-XzfQ7O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:36:14 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)) 08:36:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:36:14 INFO - Running setup.py (path:/var/folders/2f/bd59dv5s1jjgys2lwzvcz7vm00000w/T/pip-t_ZYNE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:36:14 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)) 08:36:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:36:14 INFO - Running setup.py (path:/var/folders/2f/bd59dv5s1jjgys2lwzvcz7vm00000w/T/pip-FzuBNB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:36:14 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)) 08:36:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:36:14 INFO - Running setup.py (path:/var/folders/2f/bd59dv5s1jjgys2lwzvcz7vm00000w/T/pip-3gLKKO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:36:14 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)) 08:36:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:36:14 INFO - Running setup.py (path:/var/folders/2f/bd59dv5s1jjgys2lwzvcz7vm00000w/T/pip-rX8BJp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:36:14 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)) 08:36:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:36:14 INFO - Running setup.py (path:/var/folders/2f/bd59dv5s1jjgys2lwzvcz7vm00000w/T/pip-A_LjAV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:36:15 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)) 08:36:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:36:15 INFO - Running setup.py (path:/var/folders/2f/bd59dv5s1jjgys2lwzvcz7vm00000w/T/pip-7d4qal-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:36:15 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)) 08:36:15 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)) 08:36:15 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)) 08:36:15 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)) 08:36:15 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)) 08:36:15 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)) 08:36:15 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:36:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:36:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:36:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:36:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:36:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:36:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:36:17 INFO - Downloading blessings-1.6.tar.gz 08:36:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:36:17 INFO - Installing collected packages: blessings 08:36:17 INFO - Running setup.py install for blessings 08:36:17 INFO - Successfully installed blessings 08:36:17 INFO - Cleaning up... 08:36:17 INFO - Return code: 0 08:36:17 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:36:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:36:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:36:18 INFO - Reading from file tmpfile_stdout 08:36:18 INFO - Current package versions: 08:36:18 INFO - blessings == 1.6 08:36:18 INFO - blobuploader == 1.2.4 08:36:18 INFO - docopt == 0.6.1 08:36:18 INFO - manifestparser == 1.1 08:36:18 INFO - mozInstall == 1.12 08:36:18 INFO - mozcrash == 0.17 08:36:18 INFO - mozdebug == 0.1 08:36:18 INFO - mozdevice == 0.48 08:36:18 INFO - mozfile == 1.2 08:36:18 INFO - mozhttpd == 0.7 08:36:18 INFO - mozinfo == 0.9 08:36:18 INFO - mozleak == 0.1 08:36:18 INFO - mozlog == 3.1 08:36:18 INFO - moznetwork == 0.27 08:36:18 INFO - mozprocess == 0.22 08:36:18 INFO - mozprofile == 0.28 08:36:18 INFO - mozrunner == 6.11 08:36:18 INFO - mozscreenshot == 0.1 08:36:18 INFO - mozsystemmonitor == 0.0 08:36:18 INFO - moztest == 0.7 08:36:18 INFO - mozversion == 1.4 08:36:18 INFO - psutil == 3.1.1 08:36:18 INFO - requests == 1.2.3 08:36:18 INFO - wsgiref == 0.1.2 08:36:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:36:18 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')]} 08:36:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:36:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:36:18 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')]} 08:36:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:36:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:36:18 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 0x108528a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108538420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbc0bc84e40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1083c7e00>, '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 0x108230db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1083c2b20>, '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.wLzSYtGRUT/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.SxoBWlWQgp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2f/bd59dv5s1jjgys2lwzvcz7vm00000w/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 08:36:18 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 08:36:18 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 08:36:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wLzSYtGRUT/Render', 08:36:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:36:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:36:18 INFO - 'HOME': '/Users/cltbld', 08:36:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:36:18 INFO - 'LOGNAME': 'cltbld', 08:36:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:36:18 INFO - 'MOZ_NO_REMOTE': '1', 08:36:18 INFO - 'NO_EM_RESTART': '1', 08:36:18 INFO - 'PAGER': '/bin/cat', 08:36:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:36:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:36:18 INFO - 'PWD': '/builds/slave/test', 08:36:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:36:18 INFO - 'SHELL': '/bin/bash', 08:36:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SxoBWlWQgp/Listeners', 08:36:18 INFO - 'TMPDIR': '/var/folders/2f/bd59dv5s1jjgys2lwzvcz7vm00000w/T/', 08:36:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:36:18 INFO - 'USER': 'cltbld', 08:36:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:36:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:36:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:36:18 INFO - 'XPC_FLAGS': '0x0', 08:36:18 INFO - 'XPC_SERVICE_NAME': '0', 08:36:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:36:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:36:18 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)) 08:36:18 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)) 08:36:18 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)) 08:36:18 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)) 08:36:18 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)) 08:36:18 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)) 08:36:18 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)) 08:36:18 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)) 08:36:18 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)) 08:36:18 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)) 08:36:18 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)) 08:36:18 INFO - Cleaning up... 08:36:18 INFO - Return code: 0 08:36:18 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:36:18 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')]} 08:36:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:36:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:36:18 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')]} 08:36:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:36:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:36:18 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 0x108528a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108538420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbc0bc84e40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1083c7e00>, '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 0x108230db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1083c2b20>, '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.wLzSYtGRUT/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.SxoBWlWQgp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2f/bd59dv5s1jjgys2lwzvcz7vm00000w/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 08:36:18 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 08:36:18 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 08:36:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wLzSYtGRUT/Render', 08:36:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:36:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:36:18 INFO - 'HOME': '/Users/cltbld', 08:36:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:36:18 INFO - 'LOGNAME': 'cltbld', 08:36:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:36:18 INFO - 'MOZ_NO_REMOTE': '1', 08:36:18 INFO - 'NO_EM_RESTART': '1', 08:36:18 INFO - 'PAGER': '/bin/cat', 08:36:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:36:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:36:18 INFO - 'PWD': '/builds/slave/test', 08:36:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:36:18 INFO - 'SHELL': '/bin/bash', 08:36:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SxoBWlWQgp/Listeners', 08:36:18 INFO - 'TMPDIR': '/var/folders/2f/bd59dv5s1jjgys2lwzvcz7vm00000w/T/', 08:36:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:36:18 INFO - 'USER': 'cltbld', 08:36:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:36:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:36:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:36:18 INFO - 'XPC_FLAGS': '0x0', 08:36:18 INFO - 'XPC_SERVICE_NAME': '0', 08:36:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:36:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:36:18 INFO - Downloading/unpacking jsonschema 08:36:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:36:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:36:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:36:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:36:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:36:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:36:21 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:36:21 INFO - Downloading/unpacking functools32 (from jsonschema) 08:36: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 08:36: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 08:36: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 08:36: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 08:36: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 08:36: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 08:36:21 INFO - Downloading functools32-3.2.3-2.tar.gz 08:36:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:36:21 INFO - warning: no files found matching '*.txt' 08:36:21 INFO - no previously-included directories found matching 'build' 08:36:21 INFO - no previously-included directories found matching 'dist' 08:36:21 INFO - no previously-included directories found matching '.git*' 08:36:21 INFO - Installing collected packages: jsonschema, functools32 08:36:21 INFO - Running setup.py install for functools32 08:36:21 INFO - warning: no files found matching '*.txt' 08:36:21 INFO - no previously-included directories found matching 'build' 08:36:21 INFO - no previously-included directories found matching 'dist' 08:36:21 INFO - no previously-included directories found matching '.git*' 08:36:21 INFO - Successfully installed jsonschema functools32 08:36:21 INFO - Cleaning up... 08:36:22 INFO - Return code: 0 08:36:22 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 08:36:22 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')]} 08:36:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:36:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:36:22 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')]} 08:36:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:36:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:36:22 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 0x108528a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108538420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbc0bc84e40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1083c7e00>, '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 0x108230db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1083c2b20>, '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.wLzSYtGRUT/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.SxoBWlWQgp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2f/bd59dv5s1jjgys2lwzvcz7vm00000w/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 08:36:22 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 08:36:22 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 08:36:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wLzSYtGRUT/Render', 08:36:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:36:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:36:22 INFO - 'HOME': '/Users/cltbld', 08:36:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:36:22 INFO - 'LOGNAME': 'cltbld', 08:36:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:36:22 INFO - 'MOZ_NO_REMOTE': '1', 08:36:22 INFO - 'NO_EM_RESTART': '1', 08:36:22 INFO - 'PAGER': '/bin/cat', 08:36:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:36:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:36:22 INFO - 'PWD': '/builds/slave/test', 08:36:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:36:22 INFO - 'SHELL': '/bin/bash', 08:36:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SxoBWlWQgp/Listeners', 08:36:22 INFO - 'TMPDIR': '/var/folders/2f/bd59dv5s1jjgys2lwzvcz7vm00000w/T/', 08:36:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:36:22 INFO - 'USER': 'cltbld', 08:36:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:36:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:36:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:36:22 INFO - 'XPC_FLAGS': '0x0', 08:36:22 INFO - 'XPC_SERVICE_NAME': '0', 08:36:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:36:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:36:22 INFO - Downloading/unpacking flake8 08:36:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:36:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:36:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:36:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:36:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:36:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:36:24 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 08:36:24 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 08:36:24 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 08:36:24 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 08:36:24 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 08:36:24 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 08:36:24 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 08:36:24 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 08:36:25 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 08:36:25 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 08:36: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 08:36: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 08:36: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 08:36: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 08:36: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 08:36: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 08:36:25 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 08:36: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 08:36: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 08:36: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 08:36: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 08:36: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 08:36: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 08:36:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 08:36:26 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:36:26 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:36:26 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:36:26 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:36:26 INFO - no previously-included directories found matching 'docs/_build' 08:36:26 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 08:36:26 INFO - Running setup.py install for pep8 08:36:26 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:36:26 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:36:26 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:36:26 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:36:26 INFO - no previously-included directories found matching 'docs/_build' 08:36:26 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 08:36:26 INFO - Successfully installed flake8 mccabe pyflakes pep8 08:36:26 INFO - Cleaning up... 08:36:26 INFO - Return code: 0 08:36:26 INFO - Running post-action listener: _resource_record_post_action 08:36:26 INFO - Running post-action listener: _start_resource_monitoring 08:36:26 INFO - Starting resource monitoring. 08:36:26 INFO - ##### 08:36:26 INFO - ##### Running install step. 08:36:26 INFO - ##### 08:36:26 INFO - Running pre-action listener: _resource_record_pre_action 08:36:26 INFO - Running main action method: install 08:36:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:36:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:36:26 INFO - Reading from file tmpfile_stdout 08:36:26 INFO - Detecting whether we're running mozinstall >=1.0... 08:36:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:36:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:36:26 INFO - Reading from file tmpfile_stdout 08:36:26 INFO - Output received: 08:36:26 INFO - Usage: mozinstall [options] installer 08:36:26 INFO - Options: 08:36:26 INFO - -h, --help show this help message and exit 08:36:26 INFO - -d DEST, --destination=DEST 08:36:26 INFO - Directory to install application into. [default: 08:36:26 INFO - "/builds/slave/test"] 08:36:26 INFO - --app=APP Application being installed. [default: firefox] 08:36:26 INFO - mkdir: /builds/slave/test/build/application 08:36:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 08:36:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0.en-US.mac.dmg --destination /builds/slave/test/build/application 08:36:48 INFO - Reading from file tmpfile_stdout 08:36:48 INFO - Output received: 08:36:48 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 08:36:48 INFO - Running post-action listener: _resource_record_post_action 08:36:48 INFO - ##### 08:36:48 INFO - ##### Running run-tests step. 08:36:48 INFO - ##### 08:36:48 INFO - Running pre-action listener: _resource_record_pre_action 08:36:48 INFO - Running main action method: run_tests 08:36:48 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:36:48 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:36:48 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:36:48 INFO - 2016-07-20 08:36:48.871 screenresolution[1645:7533] starting screenresolution argv=screenresolution get 08:36:48 INFO - 2016-07-20 08:36:48.874 screenresolution[1645:7533] Display 0: 1600x1200x32@60 08:36:48 INFO - 2016-07-20 08:36:48.880 screenresolution[1646:7535] starting screenresolution argv=screenresolution list 08:36:48 INFO - Available Modes on Display 0 08:36:48 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:36:48 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:36:48 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:36:48 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:36:49 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:36:49 INFO - Intel Iris: 08:36:49 INFO - Chipset Model: Intel Iris 08:36:49 INFO - Type: GPU 08:36:49 INFO - Bus: Built-In 08:36:49 INFO - VRAM (Dynamic, Max): 1536 MB 08:36:49 INFO - Vendor: Intel (0x8086) 08:36:49 INFO - Device ID: 0x0a2e 08:36:49 INFO - Revision ID: 0x0009 08:36:49 INFO - Displays: 08:36:49 INFO - Display: 08:36:49 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:36:49 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:36:49 INFO - Display Serial Number: 1600x1200 60 08:36:49 INFO - Main Display: Yes 08:36:49 INFO - Mirror: Off 08:36:49 INFO - Online: Yes 08:36:49 INFO - Rotation: Supported 08:36:49 INFO - Return code: 0 08:36:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:36:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:36:49 INFO - Python 2.7.3 08:36:49 INFO - Return code: 0 08:36:49 INFO - grabbing minidump binary from tooltool 08:36:49 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')]} 08:36:49 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 0x1083c7e00>, '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 0x108230db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1083c2b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:36:49 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 08:36:49 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 08:36:49 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:36:49 INFO - Return code: 0 08:36:49 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 08:36:49 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:36:49 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:36:49 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 08:36:49 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:36:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 08:36:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 08:36:50 INFO - Return code: 0 08:36:50 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-e10s', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/W_FQVZAfS4eUOCn6MeHuhw/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0055', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 08:36:50 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-e10s --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/W_FQVZAfS4eUOCn6MeHuhw/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0055 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 08:36:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wLzSYtGRUT/Render', 08:36:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:36:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:36:50 INFO - 'HOME': '/Users/cltbld', 08:36:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:36:50 INFO - 'LOGNAME': 'cltbld', 08:36:50 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:36:50 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 08:36:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:36:50 INFO - 'MOZ_NO_REMOTE': '1', 08:36:50 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:36:50 INFO - 'NO_EM_RESTART': '1', 08:36:50 INFO - 'PAGER': '/bin/cat', 08:36:50 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:36:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:36:50 INFO - 'PWD': '/builds/slave/test', 08:36:50 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:36:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:36:50 INFO - 'SHELL': '/bin/bash', 08:36:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SxoBWlWQgp/Listeners', 08:36:50 INFO - 'TMPDIR': '/var/folders/2f/bd59dv5s1jjgys2lwzvcz7vm00000w/T/', 08:36:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:36:50 INFO - 'USER': 'cltbld', 08:36:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:36:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:36:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:36:50 INFO - 'XPC_FLAGS': '0x0', 08:36:50 INFO - 'XPC_SERVICE_NAME': '0', 08:36:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:36:50 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/W_FQVZAfS4eUOCn6MeHuhw/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0055', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 08:36:50 INFO - mozversion application_buildid: 20160720071819 08:36:50 INFO - mozversion application_changeset: 9e887ad7d5ebd5369782230a86c3a51f84e9ab0e 08:36:50 INFO - mozversion application_display_name: Firefox 08:36:50 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:36:50 INFO - mozversion application_name: Firefox 08:36:50 INFO - mozversion application_remotingname: firefox 08:36:50 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 08:36:50 INFO - mozversion application_vendor: Mozilla 08:36:50 INFO - mozversion application_version: 48.0 08:36:50 INFO - mozversion platform_buildid: 20160720071819 08:36:50 INFO - mozversion platform_changeset: 9e887ad7d5ebd5369782230a86c3a51f84e9ab0e 08:36:50 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 08:36:50 INFO - mozversion platform_version: 48.0 08:36:50 INFO - using testdate: 1469029010 08:36:50 INFO - actual date: 1469029010 08:36:50 INFO - starting webserver on 'localhost:49275' 08:36:50 INFO - SUITE-START | Running 2 tests 08:36:50 INFO - TEST-START | dromaeo_css 08:36:50 INFO - operating with platform_type : mac_ 08:36:50 INFO - Initialising browser for dromaeo_css test... 08:36:50 INFO - TEST-INFO | started process 1664 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/2f/bd59dv5s1jjgys2lwzvcz7vm00000w/T/tmp2dHV15/profile http://localhost:49275/getInfo.html) 08:36:53 INFO - PROCESS | 1664 | __metrics Screen width/height:1600/1200 08:36:53 INFO - PROCESS | 1664 | colorDepth:24 08:36:53 INFO - PROCESS | 1664 | Browser inner width/height: 1024/689 08:36:53 INFO - PROCESS | 1664 | __metrics 08:36:53 ERROR - PROCESS | 1664 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2938: TypeError: this.tabs is undefined 08:36:53 INFO - TEST-INFO | 1664: exit 0 08:36:53 INFO - Browser initialized. 08:36:53 INFO - Running cycle 1/1 for dromaeo_css test... 08:36:53 INFO - TEST-INFO | started process 1668 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/2f/bd59dv5s1jjgys2lwzvcz7vm00000w/T/tmp2dHV15/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:37:05 INFO - PROCESS | 1668 | RSS: Main: 171028480 08:37:05 INFO - PROCESS | 1668 | 08:37:55 INFO - PROCESS | 1668 | 1469029075592 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] 08:40:06 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49275/tests/dromaeo/cssquery-ext.html) 08:40:07 INFO - PROCESS | 1668 | RSS: Main: 181657600 08:40:07 INFO - PROCESS | 1668 | 08:43:09 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-ext.html (next: http://localhost:49275/tests/dromaeo/cssquery-jquery.html) 08:43:10 INFO - PROCESS | 1668 | RSS: Main: 192450560 08:43:10 INFO - PROCESS | 1668 | 08:46:11 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49275/tests/dromaeo/cssquery-mootools.html) 08:46:12 INFO - PROCESS | 1668 | RSS: Main: 194805760 08:46:12 INFO - PROCESS | 1668 | 08:49:14 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49275/tests/dromaeo/cssquery-prototype.html) 08:49:14 INFO - PROCESS | 1668 | RSS: Main: 198344704 08:49:14 INFO - PROCESS | 1668 | 08:52:17 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49275/tests/dromaeo/cssquery-yui.html) 08:52:17 INFO - PROCESS | 1668 | RSS: Main: 197648384 08:52:17 INFO - PROCESS | 1668 | 08:55:20 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-yui.html (next: http://localhost:49275/tests/dromaeo/cssquery-dojo.html) 08:55:20 INFO - PROCESS | 1668 | RSS: Main: 203395072 08:55:20 INFO - PROCESS | 1668 | 08:55:20 INFO - PROCESS | 1668 | __start_tp_report 08:55:20 INFO - PROCESS | 1668 | _x_x_mozilla_page_load 08:55:20 INFO - PROCESS | 1668 | _x_x_mozilla_page_load_details 08:55:20 INFO - PROCESS | 1668 | |i|pagename|runs| 08:55:20 INFO - PROCESS | 1668 | |0;dojo.html;3498.2303893143508;3635.981820090901;3658.725595580332;3689.0408493791624;3692.7599706019105;5872.588918775677;5966.820995370135;6000.129981152736;6012.669303188334;6027.9397206027925;5986.850328741783;6008.489278411329;6035.336113027563;6062.363451837559;6065.423784740443;5349.384820745616;5399.136138217886;5517.2551705519645;5555.194496797962;5596.888062238752;5362.249285100089;5433.782648694068;5449.209864569635;5464.289642346489;5499.752511137009;5410.83767486976;5451.073317536028;5478.123500239963;5486.177073438977;5489.368722596892;5372.758225879845;5476.863078423032;5487.478689524489;5491.615586908918;5522.337319521643;4542.6138778203895;5319.069162896516;5423.132298832207;5451.073317535989;5493.066178749582;4572.9314060289125;5644.8024319148635;5733.111367738007;5816.912746308809;5833.212516310286;6223.3776622337855;6265.59273647216;6281.057841323838;6285.497160227171;6299.338569450188;6271.247450305992;6296.464800491964;6325.620462772248;6334.398232167937;6341;6003.8198854034445;6024.518038556905;6043.123747056696;6105.694715264219;6126.571140020245;6385.936140638627;6409.637835068457;6457.3865482779065;6470.708818103197;6473.546851720334;6307.180066591313;6324.272708638474;6327.4938004959495;6334.683265836689;6335.524835637346;5640.7590330127305;6266.655333956585;6295.685215739286;6344.873102537924;6355.142055822497;5978.55160862937;6270.498360131179;6275.623462592259;6298;6314.873702525923;6179.660118693515;6203.7828675996125;6292;6312.021636646327;6315.315990703933;4998.725070121178;5074.594032477393;5077.314562534085;5095.210242412432;5113.514216149534;4552.544745525421;4563.087382523442;4599.218132917345;4602.769861506911;4608.861734147981;5766.250387449605;5861.736221870026;6025.457708806229;6129.08063790435;6129.509639228851;4860.73265970368;5604.467575580314;6299.559030867796;6379.649119298483;6387.744490220432;6097.725602347817;6112.358202388685;6131.63210207389;6140.263168419729;6145.10895920098;5501.807436739775;5570.832875013675;5627.127795191752;5649.858753531194;5652.689102099424;6515.413612774873;6567.113439685581;6574.506911981525;6579.539432239793;6584.111144995556;6342.270638876404;6357.14178585885;6363.268224154096;6363.936360636334;6387.712552935222;6407.359264073555;6444.1622589065;6526.282108967915;6557.475401967736;6580.8354791130605;6264.968675156595;6282.465990390868;6283.5287353449585;6293.433590976834;6298.433141017331;6262.248530176225;6309.842253943688;6325.1144839721555;6327.17746692927;6341.619502829845;6117.480014198843;6168.167297414791;6180.5673602849165;6209.720562574605;6224.906626400517;6191.040388739752;6248.843778905381;6254.812355629157;6262.499000079892;6280.591761535486;5336.973315133399;6125.927962606615;6239.625622462667;6277.466415354564;6286.308506064421;6222.906656400067;6262.499000079892;6278.874422511432;6279.654618995999;6297;6196.194494715658;6207.16203312547;6265.467435268053;6269.090981807703;6290.937090629218 08:55:20 INFO - PROCESS | 1668 | |1;ext.html;519.516849330123;539.6519245086919;572.9684867332297;623.0902881792584;651.3909494622532;38598.22803543927;39725.2054958901;39874.003149921264;39879.80060099703;39898.40152397716;34141.48787768179;41017.38473922886;41021;41643.75068747935;41711;9696.46669433181;9932.453715045669;9950.203983681287;9955.502224888764;9971.850422243671;9758.951205243964;9812.362196457243;10006.649767258148;10023.047810457994;10024.74938126549;9969.55137018836;10029.197664186884;10040.146587540068;10042.69871903844;10076.596936122547;8441.198086181834;9944.602215911355;9977.800443991116;10019.699409017741;10021.59913603455;8831.911680883173;9727.07592778685;9891.653792117242;9893.604255829758;9901.960294169081;33262;39959.40060899089;40004.39993400101;40250.798746006374;40388.19223615511;3086.953695694544;3317.4692049272003;3345.6152542457685;3391.4743214801747;3427.0746898337557;26998;27870.442591148065;27884;28084;28644;2703.7972152088473;2717.483678101174;2721.96632782719;2742.163640089772;2841.4033053058884;385087;386589;390073;390094;390595;29452;35658.465123023176;35979.280414391564;35991.10022249465;37140;36532.45201321982;36533.08667283339;36712.98078605702;36858.447123293176;36888.63111368852;16384.508464746075;16518.42185523501;16690;16720.91639541819;16739.497815065566;13469.259190744408;13684.178949263076;13747.587572372844;13750;13793.931030344784;8278;8288.875666865002;8389.07720150783;8470.237678608955;8514.659413623385;3088.166195127348;3487.738419618539;3538.292341531704;3551.378508761008;3563.875264365735;968.2447690801187;1007.5566750629846;1043.645160645369;1142.4116579961326;1146.2549342927164;29182.75785142412;30013.94951176742;30166.69833301639;30529.389412212076;30722.385552289277;1207.5532053140394;1208.2025862930423;1236.6970092327438;1252.3550371558654;1253.529926277646;14995.100293982396;15223.543293701206;15351.462698805488;15632.609184770245;15760.842391576167;615716;641340;648179;650894;652871;63878.6806065976;64309.71380572362;64799;64959;65001.67499162569;1542.8225754038428;1559.1190977097904;1574.5669940766381;1575.4485929924435;1591.9204039797964;30405;30543.08370748881;30623.54064688987;30667.926622568102;30812;51702.48297516977;52410;52762.94474110573;53152;53466;508063;511123;511357;511917;513181;27502.724972750017;27897.302567435978;28055.579166312113;28084.43831123325;28522.286942826595;48085.278720819915;48578.757106214245;49683.254751178036;49728.25407618816;50006;39538.40692389674;39563.40654890236;39631;39935.2012959745;40710;31610;38563.614363856;39377.621783237446;39440.80279598584;39855.40216896807;38495.80752096222;39410.40884386679;39606.80196599114;39718;40247.597524024386;28177.57733633956;34096;34332.485012724326;35781.82109089438;35855.74504892316;21775.673364899223;23351.532969340857;26334.473310534064;26395.736042640096;26687.599686004338 08:55:20 INFO - PROCESS | 1668 | |2;jquery.html;412.2023883784876;415.83158820677596;416.09499338937815;421.38057056127496;426.846335319285;20818.89590552049;20963.37109886704;21265;21335.786642133575;21700.457488562795;20875;21115.683264751042;21533.892330538365;21791.910404479753;22031.889840550815;5414.8917021659645;5731.942680573204;5733.283339582552;5746.0806270996645;5764.308283006045;4287.764172970486;5608.355039170487;5641.548676105922;6085.695715214221;6372.076048972896;6258.655773932454;6316.084167795667;6360.52296077796;6361.68191590421;6367.204099487564;6332.303446620868;6562.606243625398;6868.690908909111;6905.75829845958;6968.477364197705;6126.326104128542;6174.567780255384;6202.596831205957;6217.595856269328;6221.720022598994;13912;14117.364718587585;14200.502982395567;14314.212718300489;14615.415383384652;2219.1012639880873;2242.506648537319;2262.016023029987;2313.664518644787;2394.748551402095;9656.90343096567;10278.7430314242;10566.9471652642;10971.23201375904;13202.471901123943;1779.6084861330487;1790.185465613143;1838.6966150585138;1920.807919208082;2017.6267390532798;104164.99999999924;111368;128172;128929;129919;19728;22326.88836555807;22392.992315345848;22933.541329173324;22957.540849182922;36631.450528242094;36986.8150659245;37498.43752343717;37736;37975.240495189944;11796.174267801343;11860.22908510944;11905.226160299553;11982.940085299517;12083.697907552381;8387.916120838714;9953;9954.402735835873;10020.749481262881;10052.798944021079;8356.749297521084;10359.119474844572;10528.684139475828;10569.365838049587;10607.416592087355;1990.5222746541015;2079.5944790765957;2086.885221312812;4027.8652314272895;4115.52671442782;937.3344925103116;966.0146650416535;990.8266053440619;1006.5621454667244;1054.667779649408;16639.833601663828;21518.56962860734;21658.566828663337;22324.665130023062;23008;999.7500624843789;1010.3028910052041;1039.9740006499899;1044.3107549017611;1109.3011402816173;11666.475008624633;12039.759204815855;12046.578369757191;12110.333931633844;12171.878281217252;646024;657274;657906;674822;680585;107783;123277;124978;130187;144131;1069.711177981956;1071.6463567022863;1091.9181061420425;1103.0458653264868;1104.6685994201707;14780.778288325899;18439.81560184381;19301.90349048246;19388.515287117934;19409.902950485157;53041.73479132734;55530.72234638801;55659;56025;58157.4184258152;72877;75301;76793;79392.80910786458;80115.19884801077;7877.409194310335;8138.186181381814;8414.537200454033;8651.178138076873;8816.471011739317;9836.901630983884;13259.403326850508;13321.533746318832;13407.731845363232;13702.725945481234;11473.254238474472;11518;11523.8271425927;11576.826347604625;11855;11303.47403100571;11414.600488983178;11416;11550;11616.244944078608;10982.725431864268;11058.060064894253;11897.702557436134;11911.3448760319;11919.761604767682;8399.286060684666;8480.27917626984;8705.521196334263;8736.344774142091;8877.511736854534;8696.695615653422;11469.0251328638;11975.580854670045;12079.335636540074;12322.753544928872 08:55:20 INFO - PROCESS | 1668 | |3;mootools.html;1617.191404297851;1628.8452597003281;1930.9034548272582;2033.9898300508505;2054.1577953039236;8599.22606965373;9127.178553930145;9409.059094090597;9420.905790942088;9610.37532560384;9272.258219342437;9295.581698823553;9348.719538413858;9447.527623618826;9481.762955926088;2562.9359266018314;2569.3319736868457;2585.870706464669;2595.5847064469594;2597.961030584533;2531.708853481855;2583.4962182374443;2599.272203782944;2602.2843717977516;2605.583106702928;2564.1025641025585;2573.768360847523;2601.5707408277613;2608.21753473958;2613.5556955317643;2175.380016695234;2573.2151693733404;2580.58710606303;2588.6505321781697;2602.349412646838;2559.9104031358997;2594.0402051241163;2595.143602611153;2618.0836707152343;2621.449495605925;9459.24326053914;9490.335676502578;9506.096920792514;9523;9554.713358599252;5763.991301522216;5786.594938354317;5809.564282678816;5959.523238140939;5967.104934259853;3747.887563373103;3858.131920317934;3870.9225815483533;3879.495665563487;3881.86413475527;1063.4044934836515;1076.2036093290988;1082.767205050918;1123.9325640461516;1125.5441546173813;12520.686982825411;12815.871841281469;12853.228806271654;12873.742525149444;12879.42042608085;4250.213710463574;5209.322788037607;5244.737763111829;5252.107141785906;5266.683998960075;9088.409253398508;10610.363378197333;10743.194260430499;10894.945525272324;11616.244944078608;5746.798862039808;5797.536197104221;5801.564882633819;5822.883542329215;5823.82528524145;4736.8578942631775;5176.1459359206065;5206.687598744087;5305.098133317269;5329.173978033411;4284.892877678083;4291.570842915746;4312.116016216668;4360.454943132108;4377.212101821639;1404.2767974493145;1422.7936949142315;1426.3723961456926;1432.4914655297428;1438.201798002098;949.6960972488876;968.3802366485455;969.3602222533094;970.4856426094041;988.6649562762957;6145.385461453819;6193.628382297076;6201.069839524108;6258.812235632939;6335.746570137143;444.3623400420407;475.61950439648143;485.1873112536487;487.04296058245717;487.60016786235656;4122.649574786117;4129.132882094734;4152.065785198367;4185.832566697298;4188.267053265667;11385.08919286455;11505.137114716263;11746;11913;11955.40222988847;9415.529223538795;11058.391788451552;11276;11448.713782155513;11619.767604648028;8759.824803504021;8867.379283450226;8944.239739622206;8975.955120224487;9009.729708108767;5943.197668314895;6154.353792851686;6168.1672974149715;6184.288806787097;6329;9852.704418867446;10183.592656293666;10267.691969240936;10285.228607854291;10447.373157610567;10102;10144.543495542866;10294.588216471257;10342.844857327296;10487.790244195226;7220.1696804866015;7669.156392796899;7937;7948.761537153895;7974.082980457321;8595.65617375323;8630.741077767678;8755.693550725695;8791.164839340252;8794.208521232864;6716.932830671631;7714.961425192838;7726;7843.7254696085365;7952.403569732178;7719.4210434218785;7787.922120778946;7865.252800983897;7945.364370850433;7950.602469876599;7382.077240344957;7459.664315105725;7518;7523.88714169277;7531.736389226351;5051.823186188466;5099.311592934906;5225.059489291964;5287.68273903567;5308.495692909168;5180.6891586504935;5243.056249875059;5277.815276465305;5422.322209723785;5424.810131645373 08:55:20 INFO - PROCESS | 1668 | |4;prototype.html;334.0812764896535;334.65864817885756;336.76258237942255;341.66175486268594;346.9826508674566;6240.28236752773;6881.864492358761;6889.138857642794;6922.342377474132;6972.930270697291;5637.4644408781205;6696.8995465068065;6812.352826481489;6849.280825513311;6890.724371025166;4542.659300552472;4555.726656400627;4767.928481072787;4882.926756098661;5058.519440653132;4957.157283261854;5011.198208286675;5026.698398096108;5036.949630503685;5051.166557518023;5005.624578156635;5020;5027.673201241908;5075.771590278447;5086.872828179288;5089.872753181163;5093.159628661267;5100.285959965608;5105.668131571455;5122.641415100945;4330.480342358906;4334.956650433487;4349.347597860315;4355.542668019875;4356.564343565649;5326.946730532683;5558.888222355505;5817.331006934214;6625.138731964862;6749.966250168767;4524.479684836253;5546.835164615395;5979.940200597982;6000.609960352563;6013.51891848651;7336.082989626297;7351.448641351866;7353.522021068614;7363.337299643004;7368.557886526825;4850.2724591311235;4869.561739443467;4889.437714662824;4890.462049174588;4901.730404827733;6686.899696504556;7711.26742959418;7759.262870027338;7770.57261850598;7779.338756205672;3476.860925563;4762.333273341735;4768.9523104769205;4788.473267940523;4839.080574690797;4276.444062271947;4640.654210278981;4842.080004799077;4872.098661747588;4914.017196560702;5879.265091863517;5886.3230728465915;5904.232449781501;5908.704564771744;5918.2898052234;7373.483856130127;7373.5575865448245;7377.233537423466;7398.149212840484;7419.962900185573;1477.394268349993;1672.4982505248377;1694.406957564867;1704.3097545494095;1707.9146042697816;906.9954650226707;1028.141501845952;1067.8451624514403;1070.5610699613121;1088.4013792414298;5542.365002324324;6787.694553745093;6795.116634837538;6805.319468053254;6834.692438840264;7386.815329616695;7580.924190758132;7601;7606.087269527692;7622.352100071445;6807.319268073252;6914.654267286615;6950.582965022115;6957.965210173917;7051.612161331073;4035.2938235808615;4072.8370865165653;4076.429299898017;4076.694247931417;4094.0174358154422;7948.125706172316;8044.557549334726;8045.316148127357;8079.4344395892895;8082.515049097073;7678.232176782389;7919.3369392427085;7967.56178410193;7978.0825205102155;8009.759707208793;7966.721164759206;8015.318697910627;8015.679372825255;8039.598020099089;8069.515829050276;6467.676616169078;7434.624594450044;7693.5768532729;7721.845563088819;7739.613019349123;6485.092087107903;7542.906278589464;7549.73575924862;7571.356434702891;7574.166841647525;6523.575967562093;7952.761417157494;8000;8024.438289319692;8031.51810891325;3951.980240098781;4768.976155119202;4802.159622066194;4809.78355973975;4816.518348165156;7293.854122917618;7302.817429564091;7651;7685.692572297045;7687.385009199363;7373.041504604367;7395.18652948186;7404.555726656418;7415.147258065392;7424.294692004251;7064.258252883579;7321.816954576178;7339.412846972123;7345.742898998509;7387.963060184665;7157.141143062866;7193.712251509881;7215.278472152742;7229.819254518679;7244.492885497964;7372.336489715952;7375.483716139819;7376.7418140364825;7400.925990740239;7412.1846596875375;6924.549904256207;7208.56748595086;7261.201267860637;7264.055672762507;7287.672054757655 08:55:20 INFO - PROCESS | 1668 | |5;yui.html;702.2205352059215;744.914334851492;752.1688534169746;754.8452567223719;780.5823884221942;15431;15449;15470.458533951314;15715.4499592514;15739.21303934803;14216.502422415217;14424.567262982102;14587.416503339853;14591;14621.342039608217;627.5293529852611;942.0626476655721;959.2421986630553;971.3977334052897;974.1768205866067;941.4680705401427;948.8054948735493;949.2738055387634;949.4825320200507;951.0109486134446;974.8099120671436;979.9412035277907;993.1905497019942;993.6820217530393;1020.0870221152064;807.9757607271791;954.4442558629424;979.3291595257236;988.9505524723735;1016.5984436147717;642.489221069251;683.8306495892031;711.6512908674712;740.7518481308714;756.4024420707634;15220.847791522165;15222.771658425132;15415.845841541553;15525.611859703486;15549.378024878992;13266.602001939957;13341.399637016357;13344.666383340396;13439.596812095653;13501.324933753272;10041.246906482043;10209.336393134423;10341.689749307532;10395.116415104725;10549.47252637365;3528.964710352915;3576.0523461282783;3581.6418358163974;3638.1632224588493;3808.428735689641;81207.37585248321;82519.17480825174;82808;83032;83929;9616.423014619146;9645.71062868115;9709.579108818221;9730.367526110922;10005.399676019462;22327.66508502374;22613.321600352017;23142.42143946415;23148.305550833502;23170.420739481648;7479.401647868158;7575.810604734926;7616.276453736886;7693.6537855795505;7703.768886933401;4128.153728485713;4187.685923555746;4209.957900421018;4264.552222016644;4359.084592235666;3642.5993140754495;3647.7811331320204;3675.1730860556695;3703.8518459261327;3720.627937206312;654.2737561306946;673.3737624009718;673.9764108256286;679.2324673119343;685.3557655803529;588.5968111843401;610.3987572241339;611.458858909868;619.5260625621403;624.5066397545978;8174.550399728072;8439.451435656663;8476.23713865755;8490.193431623986;8578.227959483676;526.5971531778192;594.9439744453543;603.1706403694919;623.9407256310643;639.3542522052667;3205.4550726376574;3942.073612701013;3951.7431366961055;3961.1285517186748;4036.6972477064337;86734;93108.53445732727;93831;95682.52158739301;95980;60248.79502409927;72334.19164520824;75484.62257688676;75491.22543872784;82178.58910705408;61713.07430388548;64883.05350839483;70130;70869.64565177244;72469.63765181246;6979.429628333584;7106.857862842818;7874.42993752285;7889.171636978034;7997.560134192675;48651.756741216064;49067.75466122646;49545.752271238416;49733.50266497434;50024.749876251844;45646.54353456423;50612.493875060776;65134.348656512826;66952.6652366735;68186;10188.898111018794;10300.896991030293;10388.42863642507;10518.631847885288;10601.41692206936;10894.182936279652;10954.835677464685;11060.39167845744;11079.279846809932;12016.939915300367;10331.94834025825;10395.792084158124;10502.737431563966;10577.259591828499;10681.89318106809;10379.688609341732;10618.097461715532;10690.62582809598;10789.40658263803;11092.389918554558;9827.656032038843;10039.799204016024;10118.08937195656;10199.592016319264;10558.630447934285;8857.689980850639;8880.422772520023;9196.770080748034;9209.21721653667;9319.580618872302;9042;9063.773405664911;9153.084691530794;9184.035676253898;9230.538473076185 08:55:20 INFO - PROCESS | 1668 | __end_tp_report 08:55:20 INFO - PROCESS | 1668 | __start_cc_report 08:55:20 INFO - PROCESS | 1668 | _x_x_mozilla_cycle_collect,399 08:55:20 INFO - PROCESS | 1668 | __end_cc_report 08:55:20 INFO - PROCESS | 1668 | __startTimestamp1469030120289__endTimestamp 08:55:20 INFO - PROCESS | 1668 | 08:55:20 INFO - PROCESS | 1668 | ------- Summary: start ------- 08:55:20 INFO - PROCESS | 1668 | Number of tests: 6 08:55:20 INFO - PROCESS | 1668 | 08:55:20 INFO - PROCESS | 1668 | [#0] dojo.html Cycles:165 Average:5898.23 Median:6168.17 stddev:629.31 (10.2%) stddev-sans-first:602.42 08:55:20 INFO - PROCESS | 1668 | Values: 3498.2 3636.0 3658.7 3689.0 3692.8 5872.6 5966.8 6000.1 6012.7 6027.9 5986.9 6008.5 6035.3 6062.4 6065.4 5349.4 5399.1 5517.3 5555.2 5596.9 5362.2 5433.8 5449.2 5464.3 5499.8 5410.8 5451.1 5478.1 5486.2 5489.4 5372.8 5476.9 5487.5 5491.6 5522.3 4542.6 5319.1 5423.1 5451.1 5493.1 4572.9 5644.8 5733.1 5816.9 5833.2 6223.4 6265.6 6281.1 6285.5 6299.3 6271.2 6296.5 6325.6 6334.4 6341.0 6003.8 6024.5 6043.1 6105.7 6126.6 6385.9 6409.6 6457.4 6470.7 6473.5 6307.2 6324.3 6327.5 6334.7 6335.5 5640.8 6266.7 6295.7 6344.9 6355.1 5978.6 6270.5 6275.6 6298.0 6314.9 6179.7 6203.8 6292.0 6312.0 6315.3 4998.7 5074.6 5077.3 5095.2 5113.5 4552.5 4563.1 4599.2 4602.8 4608.9 5766.3 5861.7 6025.5 6129.1 6129.5 4860.7 5604.5 6299.6 6379.6 6387.7 6097.7 6112.4 6131.6 6140.3 6145.1 5501.8 5570.8 5627.1 5649.9 5652.7 6515.4 6567.1 6574.5 6579.5 6584.1 6342.3 6357.1 6363.3 6363.9 6387.7 6407.4 6444.2 6526.3 6557.5 6580.8 6265.0 6282.5 6283.5 6293.4 6298.4 6262.2 6309.8 6325.1 6327.2 6341.6 6117.5 6168.2 6180.6 6209.7 6224.9 6191.0 6248.8 6254.8 6262.5 6280.6 5337.0 6125.9 6239.6 6277.5 6286.3 6222.9 6262.5 6278.9 6279.7 6297.0 6196.2 6207.2 6265.5 6269.1 6290.9 08:55:20 INFO - PROCESS | 1668 | 08:55:20 INFO - PROCESS | 1668 | [#1] ext.html Cycles:180 Average:64091.73 Median:36532.77 stddev:140238.00 (383.9%) stddev-sans-first:140550.17 08:55:20 INFO - PROCESS | 1668 | Values: 519.5 539.7 573.0 623.1 651.4 38598.2 39725.2 39874.0 39879.8 39898.4 34141.5 41017.4 41021.0 41643.8 41711.0 9696.5 9932.5 9950.2 9955.5 9971.9 9759.0 9812.4 10006.6 10023.0 10024.7 9969.6 10029.2 10040.1 10042.7 10076.6 8441.2 9944.6 9977.8 10019.7 10021.6 8831.9 9727.1 9891.7 9893.6 9902.0 33262.0 39959.4 40004.4 40250.8 40388.2 3087.0 3317.5 3345.6 3391.5 3427.1 26998.0 27870.4 27884.0 28084.0 28644.0 2703.8 2717.5 2722.0 2742.2 2841.4 385087.0 386589.0 390073.0 390094.0 390595.0 29452.0 35658.5 35979.3 35991.1 37140.0 36532.5 36533.1 36713.0 36858.4 36888.6 16384.5 16518.4 16690.0 16720.9 16739.5 13469.3 13684.2 13747.6 13750.0 13793.9 8278.0 8288.9 8389.1 8470.2 8514.7 3088.2 3487.7 3538.3 3551.4 3563.9 968.2 1007.6 1043.6 1142.4 1146.3 29182.8 30013.9 30166.7 30529.4 30722.4 1207.6 1208.2 1236.7 1252.4 1253.5 14995.1 15223.5 15351.5 15632.6 15760.8 615716.0 641340.0 648179.0 650894.0 652871.0 63878.7 64309.7 64799.0 64959.0 65001.7 1542.8 1559.1 1574.6 1575.4 1591.9 30405.0 30543.1 30623.5 30667.9 30812.0 51702.5 52410.0 52762.9 53152.0 53466.0 508063.0 511123.0 511357.0 511917.0 513181.0 27502.7 27897.3 28055.6 28084.4 28522.3 48085.3 48578.8 49683.3 49728.3 50006.0 39538.4 39563.4 39631.0 39935.2 40710.0 31610.0 38563.6 39377.6 39440.8 39855.4 38495.8 39410.4 39606.8 39718.0 40247.6 28177.6 34096.0 34332.5 35781.8 35855.7 21775.7 23351.5 26334.5 26395.7 26687.6 08:55:20 INFO - PROCESS | 1668 | 08:55:20 INFO - PROCESS | 1668 | [#2] jquery.html Cycles:180 Average:38040.88 Median:21526.23 stddev:110000.53 (511.0%) stddev-sans-first:110272.82 08:55:20 INFO - PROCESS | 1668 | Values: 412.2 415.8 416.1 421.4 426.8 20818.9 20963.4 21265.0 21335.8 21700.5 20875.0 21115.7 21533.9 21791.9 22031.9 5414.9 5731.9 5733.3 5746.1 5764.3 4287.8 5608.4 5641.5 6085.7 6372.1 6258.7 6316.1 6360.5 6361.7 6367.2 6332.3 6562.6 6868.7 6905.8 6968.5 6126.3 6174.6 6202.6 6217.6 6221.7 13912.0 14117.4 14200.5 14314.2 14615.4 2219.1 2242.5 2262.0 2313.7 2394.7 9656.9 10278.7 10566.9 10971.2 13202.5 1779.6 1790.2 1838.7 1920.8 2017.6 104165.0 111368.0 128172.0 128929.0 129919.0 19728.0 22326.9 22393.0 22933.5 22957.5 36631.5 36986.8 37498.4 37736.0 37975.2 11796.2 11860.2 11905.2 11982.9 12083.7 8387.9 9953.0 9954.4 10020.7 10052.8 8356.7 10359.1 10528.7 10569.4 10607.4 1990.5 2079.6 2086.9 4027.9 4115.5 937.3 966.0 990.8 1006.6 1054.7 16639.8 21518.6 21658.6 22324.7 23008.0 999.8 1010.3 1040.0 1044.3 1109.3 11666.5 12039.8 12046.6 12110.3 12171.9 646024.0 657274.0 657906.0 674822.0 680585.0 107783.0 123277.0 124978.0 130187.0 144131.0 1069.7 1071.6 1091.9 1103.0 1104.7 14780.8 18439.8 19301.9 19388.5 19409.9 53041.7 55530.7 55659.0 56025.0 58157.4 72877.0 75301.0 76793.0 79392.8 80115.2 7877.4 8138.2 8414.5 8651.2 8816.5 9836.9 13259.4 13321.5 13407.7 13702.7 11473.3 11518.0 11523.8 11576.8 11855.0 11303.5 11414.6 11416.0 11550.0 11616.2 10982.7 11058.1 11897.7 11911.3 11919.8 8399.3 8480.3 8705.5 8736.3 8877.5 8696.7 11469.0 11975.6 12079.3 12322.8 08:55:20 INFO - PROCESS | 1668 | 08:55:20 INFO - PROCESS | 1668 | [#3] mootools.html Cycles:180 Average:6074.50 Median:5137.73 stddev:3400.45 (66.2%) stddev-sans-first:3393.49 08:55:20 INFO - PROCESS | 1668 | Values: 1617.2 1628.8 1930.9 2034.0 2054.2 8599.2 9127.2 9409.1 9420.9 9610.4 9272.3 9295.6 9348.7 9447.5 9481.8 2562.9 2569.3 2585.9 2595.6 2598.0 2531.7 2583.5 2599.3 2602.3 2605.6 2564.1 2573.8 2601.6 2608.2 2613.6 2175.4 2573.2 2580.6 2588.7 2602.3 2559.9 2594.0 2595.1 2618.1 2621.4 9459.2 9490.3 9506.1 9523.0 9554.7 5764.0 5786.6 5809.6 5959.5 5967.1 3747.9 3858.1 3870.9 3879.5 3881.9 1063.4 1076.2 1082.8 1123.9 1125.5 12520.7 12815.9 12853.2 12873.7 12879.4 4250.2 5209.3 5244.7 5252.1 5266.7 9088.4 10610.4 10743.2 10894.9 11616.2 5746.8 5797.5 5801.6 5822.9 5823.8 4736.9 5176.1 5206.7 5305.1 5329.2 4284.9 4291.6 4312.1 4360.5 4377.2 1404.3 1422.8 1426.4 1432.5 1438.2 949.7 968.4 969.4 970.5 988.7 6145.4 6193.6 6201.1 6258.8 6335.7 444.4 475.6 485.2 487.0 487.6 4122.6 4129.1 4152.1 4185.8 4188.3 11385.1 11505.1 11746.0 11913.0 11955.4 9415.5 11058.4 11276.0 11448.7 11619.8 8759.8 8867.4 8944.2 8976.0 9009.7 5943.2 6154.4 6168.2 6184.3 6329.0 9852.7 10183.6 10267.7 10285.2 10447.4 10102.0 10144.5 10294.6 10342.8 10487.8 7220.2 7669.2 7937.0 7948.8 7974.1 8595.7 8630.7 8755.7 8791.2 8794.2 6716.9 7715.0 7726.0 7843.7 7952.4 7719.4 7787.9 7865.3 7945.4 7950.6 7382.1 7459.7 7518.0 7523.9 7531.7 5051.8 5099.3 5225.1 5287.7 5308.5 5180.7 5243.1 5277.8 5422.3 5424.8 08:55:20 INFO - PROCESS | 1668 | 08:55:20 INFO - PROCESS | 1668 | [#4] prototype.html Cycles:180 Average:5965.75 Median:6809.84 stddev:1950.72 (28.6%) stddev-sans-first:1909.85 08:55:20 INFO - PROCESS | 1668 | Values: 334.1 334.7 336.8 341.7 347.0 6240.3 6881.9 6889.1 6922.3 6972.9 5637.5 6696.9 6812.4 6849.3 6890.7 4542.7 4555.7 4767.9 4882.9 5058.5 4957.2 5011.2 5026.7 5036.9 5051.2 5005.6 5020.0 5027.7 5075.8 5086.9 5089.9 5093.2 5100.3 5105.7 5122.6 4330.5 4335.0 4349.3 4355.5 4356.6 5326.9 5558.9 5817.3 6625.1 6750.0 4524.5 5546.8 5979.9 6000.6 6013.5 7336.1 7351.4 7353.5 7363.3 7368.6 4850.3 4869.6 4889.4 4890.5 4901.7 6686.9 7711.3 7759.3 7770.6 7779.3 3476.9 4762.3 4769.0 4788.5 4839.1 4276.4 4640.7 4842.1 4872.1 4914.0 5879.3 5886.3 5904.2 5908.7 5918.3 7373.5 7373.6 7377.2 7398.1 7420.0 1477.4 1672.5 1694.4 1704.3 1707.9 907.0 1028.1 1067.8 1070.6 1088.4 5542.4 6787.7 6795.1 6805.3 6834.7 7386.8 7580.9 7601.0 7606.1 7622.4 6807.3 6914.7 6950.6 6958.0 7051.6 4035.3 4072.8 4076.4 4076.7 4094.0 7948.1 8044.6 8045.3 8079.4 8082.5 7678.2 7919.3 7967.6 7978.1 8009.8 7966.7 8015.3 8015.7 8039.6 8069.5 6467.7 7434.6 7693.6 7721.8 7739.6 6485.1 7542.9 7549.7 7571.4 7574.2 6523.6 7952.8 8000.0 8024.4 8031.5 3952.0 4769.0 4802.2 4809.8 4816.5 7293.9 7302.8 7651.0 7685.7 7687.4 7373.0 7395.2 7404.6 7415.1 7424.3 7064.3 7321.8 7339.4 7345.7 7388.0 7157.1 7193.7 7215.3 7229.8 7244.5 7372.3 7375.5 7376.7 7400.9 7412.2 6924.5 7208.6 7261.2 7264.1 7287.7 08:55:20 INFO - PROCESS | 1668 | 08:55:20 INFO - PROCESS | 1668 | [#5] yui.html Cycles:180 Average:17907.23 Median:31162.27 stddev:25142.43 (80.7%) stddev-sans-first:25179.77 08:55:20 INFO - PROCESS | 1668 | Values: 702.2 744.9 752.2 754.8 780.6 15431.0 15449.0 15470.5 15715.4 15739.2 14216.5 14424.6 14587.4 14591.0 14621.3 627.5 942.1 959.2 971.4 974.2 941.5 948.8 949.3 949.5 951.0 974.8 979.9 993.2 993.7 1020.1 808.0 954.4 979.3 989.0 1016.6 642.5 683.8 711.7 740.8 756.4 15220.8 15222.8 15415.8 15525.6 15549.4 13266.6 13341.4 13344.7 13439.6 13501.3 10041.2 10209.3 10341.7 10395.1 10549.5 3529.0 3576.1 3581.6 3638.2 3808.4 81207.4 82519.2 82808.0 83032.0 83929.0 9616.4 9645.7 9709.6 9730.4 10005.4 22327.7 22613.3 23142.4 23148.3 23170.4 7479.4 7575.8 7616.3 7693.7 7703.8 4128.2 4187.7 4210.0 4264.6 4359.1 3642.6 3647.8 3675.2 3703.9 3720.6 654.3 673.4 674.0 679.2 685.4 588.6 610.4 611.5 619.5 624.5 8174.6 8439.5 8476.2 8490.2 8578.2 526.6 594.9 603.2 623.9 639.4 3205.5 3942.1 3951.7 3961.1 4036.7 86734.0 93108.5 93831.0 95682.5 95980.0 60248.8 72334.2 75484.6 75491.2 82178.6 61713.1 64883.1 70130.0 70869.6 72469.6 6979.4 7106.9 7874.4 7889.2 7997.6 48651.8 49067.8 49545.8 49733.5 50024.7 45646.5 50612.5 65134.3 66952.7 68186.0 10188.9 10300.9 10388.4 10518.6 10601.4 10894.2 10954.8 11060.4 11079.3 12016.9 10331.9 10395.8 10502.7 10577.3 10681.9 10379.7 10618.1 10690.6 10789.4 11092.4 9827.7 10039.8 10118.1 10199.6 10558.6 8857.7 8880.4 9196.8 9209.2 9319.6 9042.0 9063.8 9153.1 9184.0 9230.5 08:55:20 INFO - PROCESS | 1668 | -------- Summary: end -------- 08:55:20 INFO - PROCESS | 1668 | 08:55:20 INFO - TEST-INFO | 1668: exit 0 08:55:20 INFO - TEST-OK | dromaeo_css | took 1110255ms 08:55:20 INFO - TEST-START | kraken 08:55:20 INFO - operating with platform_type : mac_ 08:55:20 INFO - Initialising browser for kraken test... 08:55:20 INFO - TEST-INFO | started process 1676 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/2f/bd59dv5s1jjgys2lwzvcz7vm00000w/T/tmpKTZ36I/profile http://localhost:49275/getInfo.html) 08:55:23 INFO - PROCESS | 1676 | __metrics Screen width/height:1600/1200 08:55:23 INFO - PROCESS | 1676 | colorDepth:24 08:55:23 INFO - PROCESS | 1676 | Browser inner width/height: 1024/689 08:55:23 INFO - PROCESS | 1676 | __metrics 08:55:23 ERROR - PROCESS | 1676 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2938: TypeError: this.tabs is undefined 08:55:23 INFO - TEST-INFO | 1676: exit 0 08:55:23 INFO - Browser initialized. 08:55:23 INFO - Running cycle 1/1 for kraken test... 08:55:23 INFO - TEST-INFO | started process 1680 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/2f/bd59dv5s1jjgys2lwzvcz7vm00000w/T/tmpKTZ36I/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:55:35 INFO - PROCESS | 1680 | RSS: Main: 171200512 08:55:35 INFO - PROCESS | 1680 | 08:55:38 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-beat-detection) 08:55:39 INFO - PROCESS | 1680 | RSS: Main: 183980032 08:55:39 INFO - PROCESS | 1680 | 08:55:42 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-dft) 08:55:42 INFO - PROCESS | 1680 | RSS: Main: 193105920 08:55:42 INFO - PROCESS | 1680 | 08:55:46 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-fft) 08:55:46 INFO - PROCESS | 1680 | RSS: Main: 196747264 08:55:46 INFO - PROCESS | 1680 | 08:55:48 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-oscillator) 08:55:49 INFO - PROCESS | 1680 | RSS: Main: 198111232 08:55:49 INFO - PROCESS | 1680 | 08:55:51 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:55:51 INFO - PROCESS | 1680 | RSS: Main: 199204864 08:55:51 INFO - PROCESS | 1680 | 08:55:54 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-darkroom) 08:55:55 INFO - PROCESS | 1680 | RSS: Main: 198656000 08:55:55 INFO - PROCESS | 1680 | 08:55:58 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-desaturate) 08:55:58 INFO - PROCESS | 1680 | RSS: Main: 198631424 08:55:58 INFO - PROCESS | 1680 | 08:56:01 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49275/tests/kraken/driver.html?testName=json-parse-financial) 08:56:02 INFO - PROCESS | 1680 | RSS: Main: 198639616 08:56:02 INFO - PROCESS | 1680 | 08:56:03 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49275/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:56:04 INFO - PROCESS | 1680 | RSS: Main: 198066176 08:56:04 INFO - PROCESS | 1680 | 08:56:06 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:56:07 INFO - PROCESS | 1680 | RSS: Main: 198103040 08:56:07 INFO - PROCESS | 1680 | 08:56:09 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:56:10 INFO - PROCESS | 1680 | RSS: Main: 198033408 08:56:10 INFO - PROCESS | 1680 | 08:56:12 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:56:13 INFO - PROCESS | 1680 | RSS: Main: 198189056 08:56:13 INFO - PROCESS | 1680 | 08:56:16 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:56:16 INFO - PROCESS | 1680 | RSS: Main: 198164480 08:56:16 INFO - PROCESS | 1680 | 08:56:18 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49275/tests/kraken/driver.html?testName=ai-astar) 08:56:18 INFO - PROCESS | 1680 | RSS: Main: 200130560 08:56:18 INFO - PROCESS | 1680 | 08:56:18 INFO - PROCESS | 1680 | __start_tp_report 08:56:18 INFO - PROCESS | 1680 | _x_x_mozilla_page_load 08:56:18 INFO - PROCESS | 1680 | _x_x_mozilla_page_load_details 08:56:18 INFO - PROCESS | 1680 | |i|pagename|runs| 08:56:18 INFO - PROCESS | 1680 | |0;ai-astar;117;114;117;120;173;191;164;116;118;130 08:56:18 INFO - PROCESS | 1680 | |1;audio-beat-detection;155;124;160;197;118;142;120;155;155;120 08:56:18 INFO - PROCESS | 1680 | |2;audio-dft;201;196;200;194;197;194;264;274;239;194 08:56:18 INFO - PROCESS | 1680 | |3;audio-fft;65;68;82;148;57;56;58;61;133;57 08:56:18 INFO - PROCESS | 1680 | |4;audio-oscillator;79;81;124;79;80;93;120;79;83;154 08:56:18 INFO - PROCESS | 1680 | |5;imaging-gaussian-blur;91;89;92;89;93;89;92;91;92;89 08:56:18 INFO - PROCESS | 1680 | |6;imaging-darkroom;96;97;97;96;97;96;97;97;95;98 08:56:18 INFO - PROCESS | 1680 | |7;imaging-desaturate;91;94;90;91;109;142;148;90;91;91 08:56:18 INFO - PROCESS | 1680 | |8;json-parse-financial;48;61;85;58;71;67;56;87;95;91 08:56:18 INFO - PROCESS | 1680 | |9;json-stringify-tinderbox;56;85;52;104;103;84;65;78;58;79 08:56:18 INFO - PROCESS | 1680 | |10;stanford-crypto-aes;82;81;97;107;75;71;94;77;71;108 08:56:18 INFO - PROCESS | 1680 | |11;stanford-crypto-ccm;131;132;140;130;147;152;125;119;178;168 08:56:18 INFO - PROCESS | 1680 | |12;stanford-crypto-pbkdf2;167;161;169;163;168;165;166;175;176;206 08:56:18 INFO - PROCESS | 1680 | |13;stanford-crypto-sha256-iterative;70;70;69;89;70;66;68;66;71;75 08:56:18 INFO - PROCESS | 1680 | __end_tp_report 08:56:18 INFO - PROCESS | 1680 | __start_cc_report 08:56:18 INFO - PROCESS | 1680 | _x_x_mozilla_cycle_collect,1033 08:56:18 INFO - PROCESS | 1680 | __end_cc_report 08:56:18 INFO - PROCESS | 1680 | __startTimestamp1469030178863__endTimestamp 08:56:18 INFO - PROCESS | 1680 | 08:56:18 INFO - PROCESS | 1680 | ------- Summary: start ------- 08:56:18 INFO - PROCESS | 1680 | Number of tests: 14 08:56:18 INFO - PROCESS | 1680 | 08:56:18 INFO - PROCESS | 1680 | [#0] ai-astar Cycles:10 Average:136.00 Median:125.00 stddev:28.67 (22.9%) stddev-sans-first:29.58 08:56:18 INFO - PROCESS | 1680 | Values: 117.0 114.0 117.0 120.0 173.0 191.0 164.0 116.0 118.0 130.0 08:56:18 INFO - PROCESS | 1680 | 08:56:18 INFO - PROCESS | 1680 | [#1] audio-beat-detection Cycles:10 Average:144.60 Median:155.00 stddev:25.07 (16.2%) stddev-sans-first:26.31 08:56:18 INFO - PROCESS | 1680 | Values: 155.0 124.0 160.0 197.0 118.0 142.0 120.0 155.0 155.0 120.0 08:56:18 INFO - PROCESS | 1680 | 08:56:18 INFO - PROCESS | 1680 | [#2] audio-dft Cycles:10 Average:215.30 Median:200.50 stddev:31.42 (15.7%) stddev-sans-first:32.90 08:56:18 INFO - PROCESS | 1680 | Values: 201.0 196.0 200.0 194.0 197.0 194.0 264.0 274.0 239.0 194.0 08:56:18 INFO - PROCESS | 1680 | 08:56:18 INFO - PROCESS | 1680 | [#3] audio-fft Cycles:10 Average:78.50 Median:59.50 stddev:33.77 (56.8%) stddev-sans-first:35.46 08:56:18 INFO - PROCESS | 1680 | Values: 65.0 68.0 82.0 148.0 57.0 56.0 58.0 61.0 133.0 57.0 08:56:18 INFO - PROCESS | 1680 | 08:56:18 INFO - PROCESS | 1680 | [#4] audio-oscillator Cycles:10 Average:97.20 Median:79.50 stddev:26.32 (33.1%) stddev-sans-first:27.08 08:56:18 INFO - PROCESS | 1680 | Values: 79.0 81.0 124.0 79.0 80.0 93.0 120.0 79.0 83.0 154.0 08:56:18 INFO - PROCESS | 1680 | 08:56:18 INFO - PROCESS | 1680 | [#5] imaging-gaussian-blur Cycles:10 Average:90.70 Median:91.50 stddev:1.57 (1.7%) stddev-sans-first:1.66 08:56:18 INFO - PROCESS | 1680 | Values: 91.0 89.0 92.0 89.0 93.0 89.0 92.0 91.0 92.0 89.0 08:56:18 INFO - PROCESS | 1680 | 08:56:18 INFO - PROCESS | 1680 | [#6] imaging-darkroom Cycles:10 Average:96.60 Median:97.00 stddev:0.84 (0.9%) stddev-sans-first:0.87 08:56:18 INFO - PROCESS | 1680 | Values: 96.0 97.0 97.0 96.0 97.0 96.0 97.0 97.0 95.0 98.0 08:56:18 INFO - PROCESS | 1680 | 08:56:18 INFO - PROCESS | 1680 | [#7] imaging-desaturate Cycles:10 Average:103.70 Median:91.00 stddev:22.54 (24.8%) stddev-sans-first:23.43 08:56:18 INFO - PROCESS | 1680 | Values: 91.0 94.0 90.0 91.0 109.0 142.0 148.0 90.0 91.0 91.0 08:56:18 INFO - PROCESS | 1680 | 08:56:18 INFO - PROCESS | 1680 | [#8] json-parse-financial Cycles:10 Average:71.90 Median:78.00 stddev:16.53 (21.2%) stddev-sans-first:15.10 08:56:18 INFO - PROCESS | 1680 | Values: 48.0 61.0 85.0 58.0 71.0 67.0 56.0 87.0 95.0 91.0 08:56:18 INFO - PROCESS | 1680 | 08:56:18 INFO - PROCESS | 1680 | [#9] json-stringify-tinderbox Cycles:10 Average:76.40 Median:71.50 stddev:18.53 (25.9%) stddev-sans-first:18.12 08:56:18 INFO - PROCESS | 1680 | Values: 56.0 85.0 52.0 104.0 103.0 84.0 65.0 78.0 58.0 79.0 08:56:18 INFO - PROCESS | 1680 | 08:56:18 INFO - PROCESS | 1680 | [#10] stanford-crypto-aes Cycles:10 Average:86.30 Median:79.00 stddev:14.15 (17.9%) stddev-sans-first:14.92 08:56:18 INFO - PROCESS | 1680 | Values: 82.0 81.0 97.0 107.0 75.0 71.0 94.0 77.0 71.0 108.0 08:56:18 INFO - PROCESS | 1680 | 08:56:18 INFO - PROCESS | 1680 | [#11] stanford-crypto-ccm Cycles:10 Average:142.20 Median:143.50 stddev:19.10 (13.3%) stddev-sans-first:19.82 08:56:18 INFO - PROCESS | 1680 | Values: 131.0 132.0 140.0 130.0 147.0 152.0 125.0 119.0 178.0 168.0 08:56:18 INFO - PROCESS | 1680 | 08:56:18 INFO - PROCESS | 1680 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.60 Median:168.50 stddev:12.98 (7.7%) stddev-sans-first:13.66 08:56:18 INFO - PROCESS | 1680 | Values: 167.0 161.0 169.0 163.0 168.0 165.0 166.0 175.0 176.0 206.0 08:56:18 INFO - PROCESS | 1680 | 08:56:18 INFO - PROCESS | 1680 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.40 Median:70.00 stddev:6.70 (9.6%) stddev-sans-first:7.09 08:56:18 INFO - PROCESS | 1680 | Values: 70.0 70.0 69.0 89.0 70.0 66.0 68.0 66.0 71.0 75.0 08:56:18 INFO - PROCESS | 1680 | -------- Summary: end -------- 08:56:18 INFO - PROCESS | 1680 | 08:56:19 INFO - TEST-INFO | 1680: exit 0 08:56:19 INFO - TEST-OK | kraken | took 58854ms 08:56:19 INFO - SUITE-END | took 1169s 08:56:20 INFO - Completed test suite (00:19:29) 08:56:20 INFO - javascript benchmark 08:56:20 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3498.2303893143508, 3635.981820090901, 3658.725595580332, 3689.0408493791624, 3692.7599706019105, 5872.588918775677, 5966.820995370135, 6000.129981152736, 6012.669303188334, 6027.9397206027925, 5986.850328741783, 6008.489278411329, 6035.336113027563, 6062.363451837559, 6065.423784740443, 5349.384820745616, 5399.136138217886, 5517.2551705519645, 5555.194496797962, 5596.888062238752, 5362.249285100089, 5433.782648694068, 5449.209864569635, 5464.289642346489, 5499.752511137009, 5410.83767486976, 5451.073317536028, 5478.123500239963, 5486.177073438977, 5489.368722596892, 5372.758225879845, 5476.863078423032, 5487.478689524489, 5491.615586908918, 5522.337319521643, 4542.6138778203895, 5319.069162896516, 5423.132298832207, 5451.073317535989, 5493.066178749582, 4572.9314060289125, 5644.8024319148635, 5733.111367738007, 5816.912746308809, 5833.212516310286, 6223.3776622337855, 6265.59273647216, 6281.057841323838, 6285.497160227171, 6299.338569450188, 6271.247450305992, 6296.464800491964, 6325.620462772248, 6334.398232167937, 6341.0, 6003.8198854034445, 6024.518038556905, 6043.123747056696, 6105.694715264219, 6126.571140020245, 6385.936140638627, 6409.637835068457, 6457.3865482779065, 6470.708818103197, 6473.546851720334, 6307.180066591313, 6324.272708638474, 6327.4938004959495, 6334.683265836689, 6335.524835637346, 5640.7590330127305, 6266.655333956585, 6295.685215739286, 6344.873102537924, 6355.142055822497, 5978.55160862937, 6270.498360131179, 6275.623462592259, 6298.0, 6314.873702525923, 6179.660118693515, 6203.7828675996125, 6292.0, 6312.021636646327, 6315.315990703933, 4998.725070121178, 5074.594032477393, 5077.314562534085, 5095.210242412432, 5113.514216149534, 4552.544745525421, 4563.087382523442, 4599.218132917345, 4602.769861506911, 4608.861734147981, 5766.250387449605, 5861.736221870026, 6025.457708806229, 6129.08063790435, 6129.509639228851, 4860.73265970368, 5604.467575580314, 6299.559030867796, 6379.649119298483, 6387.744490220432, 6097.725602347817, 6112.358202388685, 6131.63210207389, 6140.263168419729, 6145.10895920098, 5501.807436739775, 5570.832875013675, 5627.127795191752, 5649.858753531194, 5652.689102099424, 6515.413612774873, 6567.113439685581, 6574.506911981525, 6579.539432239793, 6584.111144995556, 6342.270638876404, 6357.14178585885, 6363.268224154096, 6363.936360636334, 6387.712552935222, 6407.359264073555, 6444.1622589065, 6526.282108967915, 6557.475401967736, 6580.8354791130605, 6264.968675156595, 6282.465990390868, 6283.5287353449585, 6293.433590976834, 6298.433141017331, 6262.248530176225, 6309.842253943688, 6325.1144839721555, 6327.17746692927, 6341.619502829845, 6117.480014198843, 6168.167297414791, 6180.5673602849165, 6209.720562574605, 6224.906626400517, 6191.040388739752, 6248.843778905381, 6254.812355629157, 6262.499000079892, 6280.591761535486, 5336.973315133399, 6125.927962606615, 6239.625622462667, 6277.466415354564, 6286.308506064421, 6222.906656400067, 6262.499000079892, 6278.874422511432, 6279.654618995999, 6297.0, 6196.194494715658, 6207.16203312547, 6265.467435268053, 6269.090981807703, 6290.937090629218], "value": 5861.983052996401, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [519.516849330123, 539.6519245086919, 572.9684867332297, 623.0902881792584, 651.3909494622532, 38598.22803543927, 39725.2054958901, 39874.003149921264, 39879.80060099703, 39898.40152397716, 34141.48787768179, 41017.38473922886, 41021.0, 41643.75068747935, 41711.0, 9696.46669433181, 9932.453715045669, 9950.203983681287, 9955.502224888764, 9971.850422243671, 9758.951205243964, 9812.362196457243, 10006.649767258148, 10023.047810457994, 10024.74938126549, 9969.55137018836, 10029.197664186884, 10040.146587540068, 10042.69871903844, 10076.596936122547, 8441.198086181834, 9944.602215911355, 9977.800443991116, 10019.699409017741, 10021.59913603455, 8831.911680883173, 9727.07592778685, 9891.653792117242, 9893.604255829758, 9901.960294169081, 33262.0, 39959.40060899089, 40004.39993400101, 40250.798746006374, 40388.19223615511, 3086.953695694544, 3317.4692049272003, 3345.6152542457685, 3391.4743214801747, 3427.0746898337557, 26998.0, 27870.442591148065, 27884.0, 28084.0, 28644.0, 2703.7972152088473, 2717.483678101174, 2721.96632782719, 2742.163640089772, 2841.4033053058884, 385087.0, 386589.0, 390073.0, 390094.0, 390595.0, 29452.0, 35658.465123023176, 35979.280414391564, 35991.10022249465, 37140.0, 36532.45201321982, 36533.08667283339, 36712.98078605702, 36858.447123293176, 36888.63111368852, 16384.508464746075, 16518.42185523501, 16690.0, 16720.91639541819, 16739.497815065566, 13469.259190744408, 13684.178949263076, 13747.587572372844, 13750.0, 13793.931030344784, 8278.0, 8288.875666865002, 8389.07720150783, 8470.237678608955, 8514.659413623385, 3088.166195127348, 3487.738419618539, 3538.292341531704, 3551.378508761008, 3563.875264365735, 968.2447690801187, 1007.5566750629846, 1043.645160645369, 1142.4116579961326, 1146.2549342927164, 29182.75785142412, 30013.94951176742, 30166.69833301639, 30529.389412212076, 30722.385552289277, 1207.5532053140394, 1208.2025862930423, 1236.6970092327438, 1252.3550371558654, 1253.529926277646, 14995.100293982396, 15223.543293701206, 15351.462698805488, 15632.609184770245, 15760.842391576167, 615716.0, 641340.0, 648179.0, 650894.0, 652871.0, 63878.6806065976, 64309.71380572362, 64799.0, 64959.0, 65001.67499162569, 1542.8225754038428, 1559.1190977097904, 1574.5669940766381, 1575.4485929924435, 1591.9204039797964, 30405.0, 30543.08370748881, 30623.54064688987, 30667.926622568102, 30812.0, 51702.48297516977, 52410.0, 52762.94474110573, 53152.0, 53466.0, 508063.0, 511123.0, 511357.0, 511917.0, 513181.0, 27502.724972750017, 27897.302567435978, 28055.579166312113, 28084.43831123325, 28522.286942826595, 48085.278720819915, 48578.757106214245, 49683.254751178036, 49728.25407618816, 50006.0, 39538.40692389674, 39563.40654890236, 39631.0, 39935.2012959745, 40710.0, 31610.0, 38563.614363856, 39377.621783237446, 39440.80279598584, 39855.40216896807, 38495.80752096222, 39410.40884386679, 39606.80196599114, 39718.0, 40247.597524024386, 28177.57733633956, 34096.0, 34332.485012724326, 35781.82109089438, 35855.74504892316, 21775.673364899223, 23351.532969340857, 26334.473310534064, 26395.736042640096, 26687.599686004338], "value": 18698.904089958494, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [412.2023883784876, 415.83158820677596, 416.09499338937815, 421.38057056127496, 426.846335319285, 20818.89590552049, 20963.37109886704, 21265.0, 21335.786642133575, 21700.457488562795, 20875.0, 21115.683264751042, 21533.892330538365, 21791.910404479753, 22031.889840550815, 5414.8917021659645, 5731.942680573204, 5733.283339582552, 5746.0806270996645, 5764.308283006045, 4287.764172970486, 5608.355039170487, 5641.548676105922, 6085.695715214221, 6372.076048972896, 6258.655773932454, 6316.084167795667, 6360.52296077796, 6361.68191590421, 6367.204099487564, 6332.303446620868, 6562.606243625398, 6868.690908909111, 6905.75829845958, 6968.477364197705, 6126.326104128542, 6174.567780255384, 6202.596831205957, 6217.595856269328, 6221.720022598994, 13912.0, 14117.364718587585, 14200.502982395567, 14314.212718300489, 14615.415383384652, 2219.1012639880873, 2242.506648537319, 2262.016023029987, 2313.664518644787, 2394.748551402095, 9656.90343096567, 10278.7430314242, 10566.9471652642, 10971.23201375904, 13202.471901123943, 1779.6084861330487, 1790.185465613143, 1838.6966150585138, 1920.807919208082, 2017.6267390532798, 104164.99999999924, 111368.0, 128172.0, 128929.0, 129919.0, 19728.0, 22326.88836555807, 22392.992315345848, 22933.541329173324, 22957.540849182922, 36631.450528242094, 36986.8150659245, 37498.43752343717, 37736.0, 37975.240495189944, 11796.174267801343, 11860.22908510944, 11905.226160299553, 11982.940085299517, 12083.697907552381, 8387.916120838714, 9953.0, 9954.402735835873, 10020.749481262881, 10052.798944021079, 8356.749297521084, 10359.119474844572, 10528.684139475828, 10569.365838049587, 10607.416592087355, 1990.5222746541015, 2079.5944790765957, 2086.885221312812, 4027.8652314272895, 4115.52671442782, 937.3344925103116, 966.0146650416535, 990.8266053440619, 1006.5621454667244, 1054.667779649408, 16639.833601663828, 21518.56962860734, 21658.566828663337, 22324.665130023062, 23008.0, 999.7500624843789, 1010.3028910052041, 1039.9740006499899, 1044.3107549017611, 1109.3011402816173, 11666.475008624633, 12039.759204815855, 12046.578369757191, 12110.333931633844, 12171.878281217252, 646024.0, 657274.0, 657906.0, 674822.0, 680585.0, 107783.0, 123277.0, 124978.0, 130187.0, 144131.0, 1069.711177981956, 1071.6463567022863, 1091.9181061420425, 1103.0458653264868, 1104.6685994201707, 14780.778288325899, 18439.81560184381, 19301.90349048246, 19388.515287117934, 19409.902950485157, 53041.73479132734, 55530.72234638801, 55659.0, 56025.0, 58157.4184258152, 72877.0, 75301.0, 76793.0, 79392.80910786458, 80115.19884801077, 7877.409194310335, 8138.186181381814, 8414.537200454033, 8651.178138076873, 8816.471011739317, 9836.901630983884, 13259.403326850508, 13321.533746318832, 13407.731845363232, 13702.725945481234, 11473.254238474472, 11518.0, 11523.8271425927, 11576.826347604625, 11855.0, 11303.47403100571, 11414.600488983178, 11416.0, 11550.0, 11616.244944078608, 10982.725431864268, 11058.060064894253, 11897.702557436134, 11911.3448760319, 11919.761604767682, 8399.286060684666, 8480.27917626984, 8705.521196334263, 8736.344774142091, 8877.511736854534, 8696.695615653422, 11469.0251328638, 11975.580854670045, 12079.335636540074, 12322.753544928872], "value": 10673.706672212407, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1617.191404297851, 1628.8452597003281, 1930.9034548272582, 2033.9898300508505, 2054.1577953039236, 8599.22606965373, 9127.178553930145, 9409.059094090597, 9420.905790942088, 9610.37532560384, 9272.258219342437, 9295.581698823553, 9348.719538413858, 9447.527623618826, 9481.762955926088, 2562.9359266018314, 2569.3319736868457, 2585.870706464669, 2595.5847064469594, 2597.961030584533, 2531.708853481855, 2583.4962182374443, 2599.272203782944, 2602.2843717977516, 2605.583106702928, 2564.1025641025585, 2573.768360847523, 2601.5707408277613, 2608.21753473958, 2613.5556955317643, 2175.380016695234, 2573.2151693733404, 2580.58710606303, 2588.6505321781697, 2602.349412646838, 2559.9104031358997, 2594.0402051241163, 2595.143602611153, 2618.0836707152343, 2621.449495605925, 9459.24326053914, 9490.335676502578, 9506.096920792514, 9523.0, 9554.713358599252, 5763.991301522216, 5786.594938354317, 5809.564282678816, 5959.523238140939, 5967.104934259853, 3747.887563373103, 3858.131920317934, 3870.9225815483533, 3879.495665563487, 3881.86413475527, 1063.4044934836515, 1076.2036093290988, 1082.767205050918, 1123.9325640461516, 1125.5441546173813, 12520.686982825411, 12815.871841281469, 12853.228806271654, 12873.742525149444, 12879.42042608085, 4250.213710463574, 5209.322788037607, 5244.737763111829, 5252.107141785906, 5266.683998960075, 9088.409253398508, 10610.363378197333, 10743.194260430499, 10894.945525272324, 11616.244944078608, 5746.798862039808, 5797.536197104221, 5801.564882633819, 5822.883542329215, 5823.82528524145, 4736.8578942631775, 5176.1459359206065, 5206.687598744087, 5305.098133317269, 5329.173978033411, 4284.892877678083, 4291.570842915746, 4312.116016216668, 4360.454943132108, 4377.212101821639, 1404.2767974493145, 1422.7936949142315, 1426.3723961456926, 1432.4914655297428, 1438.201798002098, 949.6960972488876, 968.3802366485455, 969.3602222533094, 970.4856426094041, 988.6649562762957, 6145.385461453819, 6193.628382297076, 6201.069839524108, 6258.812235632939, 6335.746570137143, 444.3623400420407, 475.61950439648143, 485.1873112536487, 487.04296058245717, 487.60016786235656, 4122.649574786117, 4129.132882094734, 4152.065785198367, 4185.832566697298, 4188.267053265667, 11385.08919286455, 11505.137114716263, 11746.0, 11913.0, 11955.40222988847, 9415.529223538795, 11058.391788451552, 11276.0, 11448.713782155513, 11619.767604648028, 8759.824803504021, 8867.379283450226, 8944.239739622206, 8975.955120224487, 9009.729708108767, 5943.197668314895, 6154.353792851686, 6168.1672974149715, 6184.288806787097, 6329.0, 9852.704418867446, 10183.592656293666, 10267.691969240936, 10285.228607854291, 10447.373157610567, 10102.0, 10144.543495542866, 10294.588216471257, 10342.844857327296, 10487.790244195226, 7220.1696804866015, 7669.156392796899, 7937.0, 7948.761537153895, 7974.082980457321, 8595.65617375323, 8630.741077767678, 8755.693550725695, 8791.164839340252, 8794.208521232864, 6716.932830671631, 7714.961425192838, 7726.0, 7843.7254696085365, 7952.403569732178, 7719.4210434218785, 7787.922120778946, 7865.252800983897, 7945.364370850433, 7950.602469876599, 7382.077240344957, 7459.664315105725, 7518.0, 7523.88714169277, 7531.736389226351, 5051.823186188466, 5099.311592934906, 5225.059489291964, 5287.68273903567, 5308.495692909168, 5180.6891586504935, 5243.056249875059, 5277.815276465305, 5422.322209723785, 5424.810131645373], "value": 4820.700113918723, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [334.0812764896535, 334.65864817885756, 336.76258237942255, 341.66175486268594, 346.9826508674566, 6240.28236752773, 6881.864492358761, 6889.138857642794, 6922.342377474132, 6972.930270697291, 5637.4644408781205, 6696.8995465068065, 6812.352826481489, 6849.280825513311, 6890.724371025166, 4542.659300552472, 4555.726656400627, 4767.928481072787, 4882.926756098661, 5058.519440653132, 4957.157283261854, 5011.198208286675, 5026.698398096108, 5036.949630503685, 5051.166557518023, 5005.624578156635, 5020.0, 5027.673201241908, 5075.771590278447, 5086.872828179288, 5089.872753181163, 5093.159628661267, 5100.285959965608, 5105.668131571455, 5122.641415100945, 4330.480342358906, 4334.956650433487, 4349.347597860315, 4355.542668019875, 4356.564343565649, 5326.946730532683, 5558.888222355505, 5817.331006934214, 6625.138731964862, 6749.966250168767, 4524.479684836253, 5546.835164615395, 5979.940200597982, 6000.609960352563, 6013.51891848651, 7336.082989626297, 7351.448641351866, 7353.522021068614, 7363.337299643004, 7368.557886526825, 4850.2724591311235, 4869.561739443467, 4889.437714662824, 4890.462049174588, 4901.730404827733, 6686.899696504556, 7711.26742959418, 7759.262870027338, 7770.57261850598, 7779.338756205672, 3476.860925563, 4762.333273341735, 4768.9523104769205, 4788.473267940523, 4839.080574690797, 4276.444062271947, 4640.654210278981, 4842.080004799077, 4872.098661747588, 4914.017196560702, 5879.265091863517, 5886.3230728465915, 5904.232449781501, 5908.704564771744, 5918.2898052234, 7373.483856130127, 7373.5575865448245, 7377.233537423466, 7398.149212840484, 7419.962900185573, 1477.394268349993, 1672.4982505248377, 1694.406957564867, 1704.3097545494095, 1707.9146042697816, 906.9954650226707, 1028.141501845952, 1067.8451624514403, 1070.5610699613121, 1088.4013792414298, 5542.365002324324, 6787.694553745093, 6795.116634837538, 6805.319468053254, 6834.692438840264, 7386.815329616695, 7580.924190758132, 7601.0, 7606.087269527692, 7622.352100071445, 6807.319268073252, 6914.654267286615, 6950.582965022115, 6957.965210173917, 7051.612161331073, 4035.2938235808615, 4072.8370865165653, 4076.429299898017, 4076.694247931417, 4094.0174358154422, 7948.125706172316, 8044.557549334726, 8045.316148127357, 8079.4344395892895, 8082.515049097073, 7678.232176782389, 7919.3369392427085, 7967.56178410193, 7978.0825205102155, 8009.759707208793, 7966.721164759206, 8015.318697910627, 8015.679372825255, 8039.598020099089, 8069.515829050276, 6467.676616169078, 7434.624594450044, 7693.5768532729, 7721.845563088819, 7739.613019349123, 6485.092087107903, 7542.906278589464, 7549.73575924862, 7571.356434702891, 7574.166841647525, 6523.575967562093, 7952.761417157494, 8000.0, 8024.438289319692, 8031.51810891325, 3951.980240098781, 4768.976155119202, 4802.159622066194, 4809.78355973975, 4816.518348165156, 7293.854122917618, 7302.817429564091, 7651.0, 7685.692572297045, 7687.385009199363, 7373.041504604367, 7395.18652948186, 7404.555726656418, 7415.147258065392, 7424.294692004251, 7064.258252883579, 7321.816954576178, 7339.412846972123, 7345.742898998509, 7387.963060184665, 7157.141143062866, 7193.712251509881, 7215.278472152742, 7229.819254518679, 7244.492885497964, 7372.336489715952, 7375.483716139819, 7376.7418140364825, 7400.925990740239, 7412.1846596875375, 6924.549904256207, 7208.56748595086, 7261.201267860637, 7264.055672762507, 7287.672054757655], "value": 5309.371231775875, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [702.2205352059215, 744.914334851492, 752.1688534169746, 754.8452567223719, 780.5823884221942, 15431.0, 15449.0, 15470.458533951314, 15715.4499592514, 15739.21303934803, 14216.502422415217, 14424.567262982102, 14587.416503339853, 14591.0, 14621.342039608217, 627.5293529852611, 942.0626476655721, 959.2421986630553, 971.3977334052897, 974.1768205866067, 941.4680705401427, 948.8054948735493, 949.2738055387634, 949.4825320200507, 951.0109486134446, 974.8099120671436, 979.9412035277907, 993.1905497019942, 993.6820217530393, 1020.0870221152064, 807.9757607271791, 954.4442558629424, 979.3291595257236, 988.9505524723735, 1016.5984436147717, 642.489221069251, 683.8306495892031, 711.6512908674712, 740.7518481308714, 756.4024420707634, 15220.847791522165, 15222.771658425132, 15415.845841541553, 15525.611859703486, 15549.378024878992, 13266.602001939957, 13341.399637016357, 13344.666383340396, 13439.596812095653, 13501.324933753272, 10041.246906482043, 10209.336393134423, 10341.689749307532, 10395.116415104725, 10549.47252637365, 3528.964710352915, 3576.0523461282783, 3581.6418358163974, 3638.1632224588493, 3808.428735689641, 81207.37585248321, 82519.17480825174, 82808.0, 83032.0, 83929.0, 9616.423014619146, 9645.71062868115, 9709.579108818221, 9730.367526110922, 10005.399676019462, 22327.66508502374, 22613.321600352017, 23142.42143946415, 23148.305550833502, 23170.420739481648, 7479.401647868158, 7575.810604734926, 7616.276453736886, 7693.6537855795505, 7703.768886933401, 4128.153728485713, 4187.685923555746, 4209.957900421018, 4264.552222016644, 4359.084592235666, 3642.5993140754495, 3647.7811331320204, 3675.1730860556695, 3703.8518459261327, 3720.627937206312, 654.2737561306946, 673.3737624009718, 673.9764108256286, 679.2324673119343, 685.3557655803529, 588.5968111843401, 610.3987572241339, 611.458858909868, 619.5260625621403, 624.5066397545978, 8174.550399728072, 8439.451435656663, 8476.23713865755, 8490.193431623986, 8578.227959483676, 526.5971531778192, 594.9439744453543, 603.1706403694919, 623.9407256310643, 639.3542522052667, 3205.4550726376574, 3942.073612701013, 3951.7431366961055, 3961.1285517186748, 4036.6972477064337, 86734.0, 93108.53445732727, 93831.0, 95682.52158739301, 95980.0, 60248.79502409927, 72334.19164520824, 75484.62257688676, 75491.22543872784, 82178.58910705408, 61713.07430388548, 64883.05350839483, 70130.0, 70869.64565177244, 72469.63765181246, 6979.429628333584, 7106.857862842818, 7874.42993752285, 7889.171636978034, 7997.560134192675, 48651.756741216064, 49067.75466122646, 49545.752271238416, 49733.50266497434, 50024.749876251844, 45646.54353456423, 50612.493875060776, 65134.348656512826, 66952.6652366735, 68186.0, 10188.898111018794, 10300.896991030293, 10388.42863642507, 10518.631847885288, 10601.41692206936, 10894.182936279652, 10954.835677464685, 11060.39167845744, 11079.279846809932, 12016.939915300367, 10331.94834025825, 10395.792084158124, 10502.737431563966, 10577.259591828499, 10681.89318106809, 10379.688609341732, 10618.097461715532, 10690.62582809598, 10789.40658263803, 11092.389918554558, 9827.656032038843, 10039.799204016024, 10118.08937195656, 10199.592016319264, 10558.630447934285, 8857.689980850639, 8880.422772520023, 9196.770080748034, 9209.21721653667, 9319.580618872302, 9042.0, 9063.773405664911, 9153.084691530794, 9184.035676253898, 9230.538473076185], "value": 6883.439157838998, "unit": "score"}], "name": "dromaeo_css", "value": 7685.900662191442, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 114.0, 117.0, 120.0, 173.0, 191.0, 164.0, 116.0, 118.0, 130.0], "value": 136.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 124.0, 160.0, 197.0, 118.0, 142.0, 120.0, 155.0, 155.0, 120.0], "value": 144.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [201.0, 196.0, 200.0, 194.0, 197.0, 194.0, 264.0, 274.0, 239.0, 194.0], "value": 215.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 68.0, 82.0, 148.0, 57.0, 56.0, 58.0, 61.0, 133.0, 57.0], "value": 78.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 81.0, 124.0, 79.0, 80.0, 93.0, 120.0, 79.0, 83.0, 154.0], "value": 97.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 89.0, 92.0, 89.0, 93.0, 89.0, 92.0, 91.0, 92.0, 89.0], "value": 90.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 97.0, 97.0, 96.0, 97.0, 96.0, 97.0, 97.0, 95.0, 98.0], "value": 96.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 94.0, 90.0, 91.0, 109.0, 142.0, 148.0, 90.0, 91.0, 91.0], "value": 103.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [48.0, 61.0, 85.0, 58.0, 71.0, 67.0, 56.0, 87.0, 95.0, 91.0], "value": 71.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 85.0, 52.0, 104.0, 103.0, 84.0, 65.0, 78.0, 58.0, 79.0], "value": 76.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 81.0, 97.0, 107.0, 75.0, 71.0, 94.0, 77.0, 71.0, 108.0], "value": 86.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [131.0, 132.0, 140.0, 130.0, 147.0, 152.0, 125.0, 119.0, 178.0, 168.0], "value": 142.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 161.0, 169.0, 163.0, 168.0, 165.0, 166.0, 175.0, 176.0, 206.0], "value": 171.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 70.0, 69.0, 89.0, 70.0, 66.0, 68.0, 66.0, 71.0, 75.0], "value": 71.4, "unit": "score"}], "name": "kraken", "value": 1582.4000000000003, "alertThreshold": 2.0}]} 08:56:20 INFO - Return code: 0 08:56:20 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 08:56:20 ERROR - # TBPL SUCCESS # 08:56:20 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:56:20 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:56:20 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:56:20 INFO - 2016-07-20 08:56:20.200 screenresolution[1685:10361] starting screenresolution argv=screenresolution get 08:56:20 INFO - 2016-07-20 08:56:20.203 screenresolution[1685:10361] Display 0: 1600x1200x32@60 08:56:20 INFO - 2016-07-20 08:56:20.209 screenresolution[1686:10364] starting screenresolution argv=screenresolution list 08:56:20 INFO - Available Modes on Display 0 08:56:20 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:56:20 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:56:20 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:56:20 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:56:20 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:56:20 INFO - Intel Iris: 08:56:20 INFO - Chipset Model: Intel Iris 08:56:20 INFO - Type: GPU 08:56:20 INFO - Bus: Built-In 08:56:20 INFO - VRAM (Dynamic, Max): 1536 MB 08:56:20 INFO - Vendor: Intel (0x8086) 08:56:20 INFO - Device ID: 0x0a2e 08:56:20 INFO - Revision ID: 0x0009 08:56:20 INFO - Displays: 08:56:20 INFO - Display: 08:56:20 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:56:20 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:56:20 INFO - Display Serial Number: 1600x1200 60 08:56:20 INFO - Main Display: Yes 08:56:20 INFO - Mirror: Off 08:56:20 INFO - Online: Yes 08:56:20 INFO - Rotation: Supported 08:56:20 INFO - Return code: 0 08:56:20 INFO - Running post-action listener: _resource_record_post_action 08:56:20 INFO - Running post-run listener: _resource_record_post_run 08:56:21 INFO - Total resource usage - Wall time: 1193s; CPU: 53.0%; Read bytes: 38237696; Write bytes: 496939008; Read time: 378; Write time: 1886 08:56:21 INFO - install - Wall time: 22s; CPU: 55.0%; Read bytes: 196680192; Write bytes: 188311552; Read time: 17353; Write time: 651 08:56:21 INFO - run-tests - Wall time: 1172s; CPU: 53.0%; Read bytes: 31120896; Write bytes: 297834496; Read time: 295; Write time: 1205 08:56:21 INFO - Running post-run listener: _upload_blobber_files 08:56:21 INFO - Blob upload gear active. 08:56:21 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:56:21 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 08:56:21 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'] 08:56:21 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 08:56:21 INFO - (blobuploader) - INFO - Open directory for files ... 08:56:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 08:56:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:56:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:56:22 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 08:56:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:56:22 INFO - (blobuploader) - INFO - Done attempting. 08:56:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 08:56:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:56:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:56:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 08:56:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:56:24 INFO - (blobuploader) - INFO - Done attempting. 08:56:24 INFO - (blobuploader) - INFO - Iteration through files over. 08:56:24 INFO - Return code: 0 08:56:24 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:56:24 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:56:24 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/223cce8ae2a61762300f11593d509fde0ff98eecc34712fa923e5e652cb591700d34f09445bbb25cd253e00deeecb09ecf28007543a6aaf44ce94cdd88f01156", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/69986c3463483f315ea8a240838f7080f3ae82a4eb86821861f045fd7daafc7c2eab82b07c5366661ed7dc969380bcfab8569e42a46040ce78d8c58ccffe5ad7"} 08:56:24 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:56:24 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:56:24 INFO - Contents: 08:56:24 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/223cce8ae2a61762300f11593d509fde0ff98eecc34712fa923e5e652cb591700d34f09445bbb25cd253e00deeecb09ecf28007543a6aaf44ce94cdd88f01156", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/69986c3463483f315ea8a240838f7080f3ae82a4eb86821861f045fd7daafc7c2eab82b07c5366661ed7dc969380bcfab8569e42a46040ce78d8c58ccffe5ad7"} 08:56:24 INFO - Running post-run listener: copy_logs_to_upload_dir 08:56:24 INFO - Copying logs to upload dir... 08:56:24 INFO - mkdir: /builds/slave/test/build/upload/logs 08:56:24 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1253.866852 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2016-07-20 08:56:24.154149) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-20 08:56:24.157468) ========= 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.wLzSYtGRUT/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.SxoBWlWQgp/Listeners TMPDIR=/var/folders/2f/bd59dv5s1jjgys2lwzvcz7vm00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/223cce8ae2a61762300f11593d509fde0ff98eecc34712fa923e5e652cb591700d34f09445bbb25cd253e00deeecb09ecf28007543a6aaf44ce94cdd88f01156", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/69986c3463483f315ea8a240838f7080f3ae82a4eb86821861f045fd7daafc7c2eab82b07c5366661ed7dc969380bcfab8569e42a46040ce78d8c58ccffe5ad7"} build_url:https://queue.taskcluster.net/v1/task/W_FQVZAfS4eUOCn6MeHuhw/artifacts/public/build/firefox-48.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010856 build_url: 'https://queue.taskcluster.net/v1/task/W_FQVZAfS4eUOCn6MeHuhw/artifacts/public/build/firefox-48.0.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/223cce8ae2a61762300f11593d509fde0ff98eecc34712fa923e5e652cb591700d34f09445bbb25cd253e00deeecb09ecf28007543a6aaf44ce94cdd88f01156", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/69986c3463483f315ea8a240838f7080f3ae82a4eb86821861f045fd7daafc7c2eab82b07c5366661ed7dc969380bcfab8569e42a46040ce78d8c58ccffe5ad7"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-20 08:56:24.194084) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-20 08:56:24.194781) ========= 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.wLzSYtGRUT/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.SxoBWlWQgp/Listeners TMPDIR=/var/folders/2f/bd59dv5s1jjgys2lwzvcz7vm00000w/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.005003 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-20 08:56:24.249165) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-20 08:56:24.249876) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-20 08:56:24.250599) ========= ========= Total master_lag: 0.28 =========