builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0191 starttime: 1467031717.8 results: success (0) buildid: 20160627035125 builduid: 013aa0857a754087b841b859adddd064 revision: 6a6dc3f2075a2ee976b1728d791e94c1a88e5c8e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-27 05:48:37.795864) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-27 05:48:37.796628) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-27 05:48:37.796896) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-27 05:48:37.828616) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 05:48:37.828902) ========= 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.y36R0E9T3F/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.YR2tEHnXOg/Listeners TMPDIR=/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/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-06-27 05:48:37-- 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% 6.11M=0.002s 2016-06-27 05:48:38 (6.11 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.473664 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 05:48:38.323953) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 05:48:38.324297) ========= 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.y36R0E9T3F/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.YR2tEHnXOg/Listeners TMPDIR=/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/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.021111 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 05:48:38.372927) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 05:48:38.373284) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 6a6dc3f2075a2ee976b1728d791e94c1a88e5c8e --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 6a6dc3f2075a2ee976b1728d791e94c1a88e5c8e --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.y36R0E9T3F/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.YR2tEHnXOg/Listeners TMPDIR=/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/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-06-27 05:48:38,447 truncating revision to first 12 chars 2016-06-27 05:48:38,447 Setting DEBUG logging. 2016-06-27 05:48:38,447 attempt 1/10 2016-06-27 05:48:38,448 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/6a6dc3f2075a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-27 05:48:38,783 unpacking tar archive at: mozilla-beta-6a6dc3f2075a/testing/mozharness/ program finished with exit code 0 elapsedTime=0.600577 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 05:48:38.995711) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-27 05:48:38.996041) ========= script_repo_revision: 6a6dc3f2075a2ee976b1728d791e94c1a88e5c8e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-27 05:48:38.996505) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-27 05:48:38.996890) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-27 05:48:39.015620) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 19 secs) (at 2016-06-27 05:48:39.015965) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.y36R0E9T3F/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.YR2tEHnXOg/Listeners TMPDIR=/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/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 05:48:39 INFO - MultiFileLogger online at 20160627 05:48:39 in /builds/slave/test 05:48:39 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 05:48:39 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:48:39 INFO - {'append_to_log': False, 05:48:39 INFO - 'base_work_dir': '/builds/slave/test', 05:48:39 INFO - 'blob_upload_branch': 'Mozilla-Beta', 05:48:39 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:48:39 INFO - 'branch': 'Mozilla-Beta', 05:48:39 INFO - 'buildbot_json_path': 'buildprops.json', 05:48:39 INFO - 'config_files': ('talos/mac_config.py',), 05:48:39 INFO - 'default_actions': ('clobber', 05:48:39 INFO - 'read-buildbot-config', 05:48:39 INFO - 'download-and-extract', 05:48:39 INFO - 'populate-webroot', 05:48:39 INFO - 'create-virtualenv', 05:48:39 INFO - 'install', 05:48:39 INFO - 'run-tests'), 05:48:39 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:48:39 INFO - 'download_minidump_stackwalk': True, 05:48:39 INFO - 'download_symbols': 'ondemand', 05:48:39 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:48:39 INFO - 'tooltool.py': '/tools/tooltool.py', 05:48:39 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:48:39 INFO - '/tools/misc-python/virtualenv.py')}, 05:48:39 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:48:39 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:48:39 INFO - 'installer_path': 'installer.exe', 05:48:39 INFO - 'log_level': 'info', 05:48:39 INFO - 'log_name': 'talos', 05:48:39 INFO - 'log_to_console': True, 05:48:39 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 05:48:39 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 05:48:39 INFO - 'opt_config_files': (), 05:48:39 INFO - 'pip_index': False, 05:48:39 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:48:39 INFO - 'cmd': ('bash', 05:48:39 INFO - '-c', 05:48:39 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:48:39 INFO - 'enabled': True, 05:48:39 INFO - 'halt_on_failure': False, 05:48:39 INFO - 'name': 'check_screen_resolution'},), 05:48:39 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:48:39 INFO - 'cmd': ('bash', 05:48:39 INFO - '-c', 05:48:39 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:48:39 INFO - 'enabled': True, 05:48:39 INFO - 'halt_on_failure': False, 05:48:39 INFO - 'name': 'check_screen_resolution'},), 05:48:39 INFO - 'run_cmd_checks_enabled': True, 05:48:39 INFO - 'sps_profile': False, 05:48:39 INFO - 'sps_profile_interval': 0, 05:48:39 INFO - 'suite': 'dromaeojs', 05:48:39 INFO - 'system_bits': '32', 05:48:39 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:48:39 INFO - 'title': 't-yosemite-r7-0191', 05:48:39 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:48:39 INFO - 'use_talos_json': True, 05:48:39 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:48:39 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:48:39 INFO - 'work_dir': 'build'} 05:48:39 INFO - ##### 05:48:39 INFO - ##### Running clobber step. 05:48:39 INFO - ##### 05:48:39 INFO - Running pre-action listener: _resource_record_pre_action 05:48:39 INFO - Running main action method: clobber 05:48:39 INFO - rmtree: /builds/slave/test/build 05:48:39 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:48:40 INFO - Running post-action listener: _resource_record_post_action 05:48:40 INFO - ##### 05:48:40 INFO - ##### Running read-buildbot-config step. 05:48:40 INFO - ##### 05:48:40 INFO - Running pre-action listener: _resource_record_pre_action 05:48:40 INFO - Running main action method: read_buildbot_config 05:48:40 INFO - Using buildbot properties: 05:48:40 INFO - { 05:48:40 INFO - "project": "", 05:48:40 INFO - "product": "firefox", 05:48:40 INFO - "script_repo_revision": "production", 05:48:40 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 05:48:40 INFO - "repository": "", 05:48:40 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 05:48:40 INFO - "buildid": "20160627035125", 05:48:40 INFO - "pgo_build": "False", 05:48:40 INFO - "basedir": "/builds/slave/test", 05:48:40 INFO - "buildnumber": 42, 05:48:40 INFO - "slavename": "t-yosemite-r7-0191", 05:48:40 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 05:48:40 INFO - "platform": "yosemite_r7", 05:48:40 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 05:48:40 INFO - "branch": "mozilla-beta", 05:48:40 INFO - "repo_path": "releases/mozilla-beta", 05:48:40 INFO - "revision": "6a6dc3f2075a2ee976b1728d791e94c1a88e5c8e", 05:48:40 INFO - "stage_platform": "macosx64", 05:48:40 INFO - "builduid": "013aa0857a754087b841b859adddd064", 05:48:40 INFO - "slavebuilddir": "test" 05:48:40 INFO - } 05:48:40 INFO - Found installer url https://queue.taskcluster.net/v1/task/HNf6UujUQ5mnMECPR4aaTg/artifacts/public/build/firefox-48.0.en-US.mac.dmg. 05:48:40 INFO - Running post-action listener: _resource_record_post_action 05:48:40 INFO - ##### 05:48:40 INFO - ##### Running download-and-extract step. 05:48:40 INFO - ##### 05:48:40 INFO - Running pre-action listener: _resource_record_pre_action 05:48:40 INFO - Running main action method: download_and_extract 05:48:40 INFO - mkdir: /builds/slave/test/build/tests 05:48:40 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')]} 05:48:40 INFO - https://queue.taskcluster.net/v1/task/HNf6UujUQ5mnMECPR4aaTg/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json matches https://queue.taskcluster.net 05:48:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HNf6UujUQ5mnMECPR4aaTg/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json 05:48:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HNf6UujUQ5mnMECPR4aaTg/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json 05:48:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HNf6UujUQ5mnMECPR4aaTg/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 05:48:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HNf6UujUQ5mnMECPR4aaTg/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 05:49:00 INFO - Downloaded 1165 bytes. 05:49:00 INFO - Reading from file /builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json 05:49:00 INFO - Using the following test package requirements: 05:49:00 INFO - {u'common': [u'firefox-48.0.en-US.mac.common.tests.zip'], 05:49:00 INFO - u'cppunittest': [u'firefox-48.0.en-US.mac.common.tests.zip', 05:49:00 INFO - u'firefox-48.0.en-US.mac.cppunittest.tests.zip'], 05:49:00 INFO - u'gtest': [u'firefox-48.0.en-US.mac.common.tests.zip', 05:49:00 INFO - u'firefox-48.0.en-US.mac.gtest.tests.zip'], 05:49:00 INFO - u'jittest': [u'firefox-48.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 05:49:00 INFO - u'mochitest': [u'firefox-48.0.en-US.mac.common.tests.zip', 05:49:00 INFO - u'firefox-48.0.en-US.mac.mochitest.tests.zip'], 05:49:00 INFO - u'mozbase': [u'firefox-48.0.en-US.mac.common.tests.zip'], 05:49:00 INFO - u'reftest': [u'firefox-48.0.en-US.mac.common.tests.zip', 05:49:00 INFO - u'firefox-48.0.en-US.mac.reftest.tests.zip'], 05:49:00 INFO - u'talos': [u'firefox-48.0.en-US.mac.common.tests.zip', 05:49:00 INFO - u'firefox-48.0.en-US.mac.talos.tests.zip'], 05:49:00 INFO - u'web-platform': [u'firefox-48.0.en-US.mac.common.tests.zip', 05:49:00 INFO - u'firefox-48.0.en-US.mac.web-platform.tests.zip'], 05:49:00 INFO - u'xpcshell': [u'firefox-48.0.en-US.mac.common.tests.zip', 05:49:00 INFO - u'firefox-48.0.en-US.mac.xpcshell.tests.zip']} 05:49:00 INFO - Downloading packages: [u'firefox-48.0.en-US.mac.common.tests.zip'] for test suite category: common 05:49: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')]} 05:49:00 INFO - https://queue.taskcluster.net/v1/task/HNf6UujUQ5mnMECPR4aaTg/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 05:49:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HNf6UujUQ5mnMECPR4aaTg/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 05:49:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HNf6UujUQ5mnMECPR4aaTg/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 05:49:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HNf6UujUQ5mnMECPR4aaTg/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 05:49:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HNf6UujUQ5mnMECPR4aaTg/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 05:49:02 INFO - Downloaded 18344101 bytes. 05:49:02 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'] 05:49:02 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 05:49:05 INFO - Return code: 0 05:49:05 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 05:49:05 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')]} 05:49:05 INFO - https://queue.taskcluster.net/v1/task/HNf6UujUQ5mnMECPR4aaTg/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 05:49:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HNf6UujUQ5mnMECPR4aaTg/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 05:49:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HNf6UujUQ5mnMECPR4aaTg/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 05:49:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HNf6UujUQ5mnMECPR4aaTg/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 05:49:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HNf6UujUQ5mnMECPR4aaTg/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 05:49:06 INFO - Downloaded 18344101 bytes. 05:49:06 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'] 05:49:06 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 05:49:10 INFO - Return code: 0 05:49:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:49:10 INFO - https://queue.taskcluster.net/v1/task/HNf6UujUQ5mnMECPR4aaTg/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 05:49:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HNf6UujUQ5mnMECPR4aaTg/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip 05:49:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HNf6UujUQ5mnMECPR4aaTg/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip 05:49:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HNf6UujUQ5mnMECPR4aaTg/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 05:49:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HNf6UujUQ5mnMECPR4aaTg/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 05:49:11 INFO - Downloaded 10840145 bytes. 05:49:11 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'] 05:49:11 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 05:49:11 INFO - Return code: 0 05:49:11 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')]} 05:49:11 INFO - https://queue.taskcluster.net/v1/task/HNf6UujUQ5mnMECPR4aaTg/artifacts/public/build/firefox-48.0.en-US.mac.dmg matches https://queue.taskcluster.net 05:49:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HNf6UujUQ5mnMECPR4aaTg/artifacts/public/build/firefox-48.0.en-US.mac.dmg 05:49:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HNf6UujUQ5mnMECPR4aaTg/artifacts/public/build/firefox-48.0.en-US.mac.dmg 05:49:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HNf6UujUQ5mnMECPR4aaTg/artifacts/public/build/firefox-48.0.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0.en-US.mac.dmg 05:49:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HNf6UujUQ5mnMECPR4aaTg/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 05:49:23 INFO - Downloaded 86228333 bytes. 05:49:23 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/HNf6UujUQ5mnMECPR4aaTg/artifacts/public/build/firefox-48.0.en-US.mac.dmg 05:49:23 INFO - mkdir: /builds/slave/test/properties 05:49:23 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:49:23 INFO - Writing to file /builds/slave/test/properties/build_url 05:49:23 INFO - Contents: 05:49:23 INFO - build_url:https://queue.taskcluster.net/v1/task/HNf6UujUQ5mnMECPR4aaTg/artifacts/public/build/firefox-48.0.en-US.mac.dmg 05:49:24 INFO - Running post-action listener: _resource_record_post_action 05:49:24 INFO - Running post-action listener: set_extra_try_arguments 05:49:24 INFO - ##### 05:49:24 INFO - ##### Running populate-webroot step. 05:49:24 INFO - ##### 05:49:24 INFO - Running pre-action listener: _resource_record_pre_action 05:49:24 INFO - Running main action method: populate_webroot 05:49:24 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:49:24 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:49:24 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:49:24 INFO - '--tppagecycles', 05:49:24 INFO - '7'], 05:49:24 INFO - 'tests': ['tsvgm']}}, 05:49:24 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:49:24 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:49:24 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:49:24 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:49:24 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:49:24 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:49:24 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:49:24 INFO - 'talos_options': ['--disable-e10s'], 05:49:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:49:24 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:49:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:49:24 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:49:24 INFO - 'talos_options': ['--disable-e10s'], 05:49:24 INFO - 'tests': ['damp', 'tps']}, 05:49:24 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:49:24 INFO - 'tests': ['damp', 'tps']}, 05:49:24 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:49:24 INFO - 'tests': ['dromaeo_dom']}, 05:49:24 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:49:24 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:49:24 INFO - 'tests': ['a11yr', 05:49:24 INFO - 'ts_paint', 05:49:24 INFO - 'tpaint', 05:49:24 INFO - 'sessionrestore', 05:49:24 INFO - 'sessionrestore_no_auto_restore', 05:49:24 INFO - 'tabpaint']}, 05:49:24 INFO - 'other-e10s': {'tests': ['a11yr', 05:49:24 INFO - 'ts_paint', 05:49:24 INFO - 'tpaint', 05:49:24 INFO - 'sessionrestore', 05:49:24 INFO - 'sessionrestore_no_auto_restore', 05:49:24 INFO - 'tabpaint']}, 05:49:24 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:49:24 INFO - 'ts_paint', 05:49:24 INFO - 'tpaint', 05:49:24 INFO - 'sessionrestore', 05:49:24 INFO - 'sessionrestore_no_auto_restore', 05:49:24 INFO - 'tabpaint']}, 05:49:24 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:49:24 INFO - 'ts_paint', 05:49:24 INFO - 'tpaint', 05:49:24 INFO - 'sessionrestore', 05:49:24 INFO - 'sessionrestore_no_auto_restore', 05:49:24 INFO - 'tabpaint']}, 05:49:24 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:49:24 INFO - 'tests': ['a11yr', 05:49:24 INFO - 'ts_paint', 05:49:24 INFO - 'tpaint', 05:49:24 INFO - 'sessionrestore', 05:49:24 INFO - 'sessionrestore_no_auto_restore', 05:49:24 INFO - 'tabpaint']}, 05:49:24 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:49:24 INFO - 'tests': ['a11yr', 05:49:24 INFO - 'ts_paint', 05:49:24 INFO - 'tpaint', 05:49:24 INFO - 'sessionrestore', 05:49:24 INFO - 'sessionrestore_no_auto_restore', 05:49:24 INFO - 'tabpaint']}, 05:49:24 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:49:24 INFO - 'tests': ['tsvgx', 05:49:24 INFO - 'tsvgr_opacity', 05:49:24 INFO - 'tart', 05:49:24 INFO - 'tscrollx', 05:49:24 INFO - 'cart']}, 05:49:24 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:49:24 INFO - 'tsvgr_opacity', 05:49:24 INFO - 'tart', 05:49:24 INFO - 'tscrollx', 05:49:24 INFO - 'cart']}, 05:49:24 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:49:24 INFO - 'talos_options': ['--disable-e10s'], 05:49:24 INFO - 'tests': ['tp5o']}, 05:49:24 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:49:24 INFO - 'tests': ['tp5o']}, 05:49:24 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:49:24 INFO - 'talos_options': ['--disable-e10s', 05:49:24 INFO - '--xperf_path', 05:49:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:49:24 INFO - 'tests': ['tp5n']}, 05:49:24 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:49:24 INFO - 'talos_options': ['--xperf_path', 05:49:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:49:24 INFO - 'tests': ['tp5n']}}, 05:49:24 INFO - 'talos.zip': {'path': '', 05:49:24 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:49:24 INFO - Running post-action listener: _resource_record_post_action 05:49:24 INFO - ##### 05:49:24 INFO - ##### Running create-virtualenv step. 05:49:24 INFO - ##### 05:49:24 INFO - Running pre-action listener: _resource_record_pre_action 05:49:24 INFO - Running main action method: create_virtualenv 05:49:24 INFO - Creating virtualenv /builds/slave/test/build/venv 05:49:24 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 05:49:24 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:49:24 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:49:24 INFO - Using real prefix '/tools/python27' 05:49:24 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:49:25 INFO - Installing distribute.............................................................................................................................................................................................done. 05:49:28 INFO - Installing pip.................done. 05:49:28 INFO - Return code: 0 05:49:28 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:49:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:49:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:49:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:49:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:49:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x105171a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105181420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc448d74d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105010e00>, '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 0x104e79db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10500bb20>, '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.y36R0E9T3F/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.YR2tEHnXOg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/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 05:49:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 05:49:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:49:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.y36R0E9T3F/Render', 05:49:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:49:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:49:28 INFO - 'HOME': '/Users/cltbld', 05:49:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:49:28 INFO - 'LOGNAME': 'cltbld', 05:49:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:49:28 INFO - 'MOZ_NO_REMOTE': '1', 05:49:28 INFO - 'NO_EM_RESTART': '1', 05:49:28 INFO - 'PAGER': '/bin/cat', 05:49:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:49:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:49:28 INFO - 'PWD': '/builds/slave/test', 05:49:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:49:28 INFO - 'SHELL': '/bin/bash', 05:49:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YR2tEHnXOg/Listeners', 05:49:28 INFO - 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/', 05:49:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:49:28 INFO - 'USER': 'cltbld', 05:49:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:49:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:49:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:49:28 INFO - 'XPC_FLAGS': '0x0', 05:49:28 INFO - 'XPC_SERVICE_NAME': '0', 05:49:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:49:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:49:28 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 05:49:28 INFO - Cleaning up... 05:49:28 INFO - Return code: 0 05:49:28 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 05:49:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:49:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:49:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:49:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:49:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x105171a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105181420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc448d74d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105010e00>, '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 0x104e79db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10500bb20>, '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.y36R0E9T3F/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.YR2tEHnXOg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/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 05:49:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 05:49:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 05:49:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.y36R0E9T3F/Render', 05:49:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:49:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:49:28 INFO - 'HOME': '/Users/cltbld', 05:49:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:49:28 INFO - 'LOGNAME': 'cltbld', 05:49:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:49:28 INFO - 'MOZ_NO_REMOTE': '1', 05:49:28 INFO - 'NO_EM_RESTART': '1', 05:49:28 INFO - 'PAGER': '/bin/cat', 05:49:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:49:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:49:28 INFO - 'PWD': '/builds/slave/test', 05:49:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:49:28 INFO - 'SHELL': '/bin/bash', 05:49:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YR2tEHnXOg/Listeners', 05:49:28 INFO - 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/', 05:49:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:49:28 INFO - 'USER': 'cltbld', 05:49:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:49:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:49:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:49:28 INFO - 'XPC_FLAGS': '0x0', 05:49:28 INFO - 'XPC_SERVICE_NAME': '0', 05:49:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:49:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:49:29 INFO - Downloading/unpacking psutil>=0.7.1 05:49:29 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 05:49:29 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 05:49:29 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 05:49:29 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 05:49:29 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 05:49:29 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 05:49:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:49:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:49:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:49:31 INFO - Installing collected packages: psutil 05:49:31 INFO - Running setup.py install for psutil 05:49:32 INFO - building 'psutil._psutil_osx' extension 05:49:32 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 05:49:32 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 05:49:32 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 05:49:32 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 05:49:32 INFO - building 'psutil._psutil_posix' extension 05:49:32 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 05:49:32 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 05:49:32 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 05:49:32 INFO - ^ 05:49:32 INFO - 1 warning generated. 05:49:32 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 05:49:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:49:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:49:32 INFO - Successfully installed psutil 05:49:32 INFO - Cleaning up... 05:49:32 INFO - Return code: 0 05:49:32 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 05:49: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')]} 05:49:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:49:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49: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')]} 05:49:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:49:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49:32 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 0x105171a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105181420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc448d74d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105010e00>, '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 0x104e79db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10500bb20>, '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.y36R0E9T3F/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.YR2tEHnXOg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/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 05:49:32 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 05:49:32 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 05:49:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.y36R0E9T3F/Render', 05:49:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:49:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:49:32 INFO - 'HOME': '/Users/cltbld', 05:49:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:49:32 INFO - 'LOGNAME': 'cltbld', 05:49:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:49:32 INFO - 'MOZ_NO_REMOTE': '1', 05:49:32 INFO - 'NO_EM_RESTART': '1', 05:49:32 INFO - 'PAGER': '/bin/cat', 05:49:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:49:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:49:32 INFO - 'PWD': '/builds/slave/test', 05:49:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:49:32 INFO - 'SHELL': '/bin/bash', 05:49:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YR2tEHnXOg/Listeners', 05:49:32 INFO - 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/', 05:49:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:49:32 INFO - 'USER': 'cltbld', 05:49:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:49:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:49:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:49:32 INFO - 'XPC_FLAGS': '0x0', 05:49:32 INFO - 'XPC_SERVICE_NAME': '0', 05:49:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:49:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:49:33 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:49:33 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 05:49:33 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 05:49:33 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 05:49:33 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 05:49:33 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 05:49:33 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 05:49:35 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:49:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:49:35 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 05:49:35 INFO - Installing collected packages: mozsystemmonitor 05:49:35 INFO - Running setup.py install for mozsystemmonitor 05:49:35 INFO - Successfully installed mozsystemmonitor 05:49:35 INFO - Cleaning up... 05:49:35 INFO - Return code: 0 05:49:35 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:49:35 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')]} 05:49:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:49:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49:35 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')]} 05:49:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:49:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49:35 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 0x105171a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105181420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc448d74d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105010e00>, '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 0x104e79db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10500bb20>, '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.y36R0E9T3F/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.YR2tEHnXOg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/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 05:49:35 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 05:49:35 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 05:49:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.y36R0E9T3F/Render', 05:49:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:49:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:49:35 INFO - 'HOME': '/Users/cltbld', 05:49:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:49:35 INFO - 'LOGNAME': 'cltbld', 05:49:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:49:35 INFO - 'MOZ_NO_REMOTE': '1', 05:49:35 INFO - 'NO_EM_RESTART': '1', 05:49:35 INFO - 'PAGER': '/bin/cat', 05:49:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:49:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:49:35 INFO - 'PWD': '/builds/slave/test', 05:49:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:49:35 INFO - 'SHELL': '/bin/bash', 05:49:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YR2tEHnXOg/Listeners', 05:49:35 INFO - 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/', 05:49:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:49:35 INFO - 'USER': 'cltbld', 05:49:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:49:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:49:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:49:35 INFO - 'XPC_FLAGS': '0x0', 05:49:35 INFO - 'XPC_SERVICE_NAME': '0', 05:49:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:49:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:49:36 INFO - Downloading/unpacking blobuploader==1.2.4 05:49:36 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 05:49:36 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 05:49:36 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 05:49:36 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 05:49:36 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 05:49:36 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 05:49:38 INFO - Downloading blobuploader-1.2.4.tar.gz 05:49:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:49:38 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:49:38 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 05:49:38 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 05:49:38 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 05:49:38 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 05:49:38 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 05:49:38 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 05:49:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:49:39 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:49:39 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 05:49:39 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 05:49:39 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 05:49:39 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 05:49:39 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 05:49:39 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 05:49:39 INFO - Downloading docopt-0.6.1.tar.gz 05:49:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:49:39 INFO - Installing collected packages: blobuploader, requests, docopt 05:49:39 INFO - Running setup.py install for blobuploader 05:49:39 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:49:39 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:49:39 INFO - Running setup.py install for requests 05:49:40 INFO - Running setup.py install for docopt 05:49:40 INFO - Successfully installed blobuploader requests docopt 05:49:40 INFO - Cleaning up... 05:49:40 INFO - Return code: 0 05:49:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:49:40 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')]} 05:49:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:49:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49: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')]} 05:49:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:49:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49:41 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 0x105171a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105181420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc448d74d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105010e00>, '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 0x104e79db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10500bb20>, '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.y36R0E9T3F/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.YR2tEHnXOg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/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 05:49:41 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 05:49:41 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 05:49:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.y36R0E9T3F/Render', 05:49:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:49:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:49:41 INFO - 'HOME': '/Users/cltbld', 05:49:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:49:41 INFO - 'LOGNAME': 'cltbld', 05:49:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:49:41 INFO - 'MOZ_NO_REMOTE': '1', 05:49:41 INFO - 'NO_EM_RESTART': '1', 05:49:41 INFO - 'PAGER': '/bin/cat', 05:49:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:49:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:49:41 INFO - 'PWD': '/builds/slave/test', 05:49:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:49:41 INFO - 'SHELL': '/bin/bash', 05:49:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YR2tEHnXOg/Listeners', 05:49:41 INFO - 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/', 05:49:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:49:41 INFO - 'USER': 'cltbld', 05:49:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:49:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:49:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:49:41 INFO - 'XPC_FLAGS': '0x0', 05:49:41 INFO - 'XPC_SERVICE_NAME': '0', 05:49:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:49:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:49:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:49:41 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-2GY8hH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:49:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:49:41 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-uEP7RP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:49:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:49:41 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-JEjLtk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:49:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:49:41 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-A0TJ6g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:49:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:49:41 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-8DcEXP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:49:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:49:42 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-lB1FMe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:49:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:49:42 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-_NYbOC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:49:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:49:42 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-OWxRN_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:49:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:49:42 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-ot1a5Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:49:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:49:42 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-pUND_M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:49:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:49:42 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-cbtN4a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:49:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:49:42 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-TzwWGM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:49:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:49:42 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-v0UBFj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:49:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:49:42 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-KSC5G3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:49:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:49:42 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-LfdZZi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:49:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:49:43 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-io5tpl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:49:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:49:43 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-zOr7Vk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:49:43 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:49:43 INFO - Running setup.py install for manifestparser 05:49:43 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:49:43 INFO - Running setup.py install for mozcrash 05:49:43 INFO - Running setup.py install for mozdebug 05:49:43 INFO - Running setup.py install for mozdevice 05:49:43 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:49:43 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:49:43 INFO - Running setup.py install for mozfile 05:49:43 INFO - Running setup.py install for mozhttpd 05:49:44 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:49:44 INFO - Running setup.py install for mozinfo 05:49:44 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:49:44 INFO - Running setup.py install for mozInstall 05:49:44 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:49:44 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:49:44 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:49:44 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:49:44 INFO - Running setup.py install for mozleak 05:49:44 INFO - Running setup.py install for mozlog 05:49:44 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:49:44 INFO - Running setup.py install for moznetwork 05:49:44 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:49:44 INFO - Running setup.py install for mozprocess 05:49:45 INFO - Running setup.py install for mozprofile 05:49:45 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:49:45 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:49:45 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:49:45 INFO - Running setup.py install for mozrunner 05:49:45 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:49:45 INFO - Running setup.py install for mozscreenshot 05:49:45 INFO - Running setup.py install for moztest 05:49:45 INFO - Running setup.py install for mozversion 05:49:45 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:49:45 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:49:45 INFO - Cleaning up... 05:49:45 INFO - Return code: 0 05:49:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:49:45 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')]} 05:49:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:49:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49:45 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')]} 05:49:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:49:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49:45 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 0x105171a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105181420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc448d74d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105010e00>, '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 0x104e79db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10500bb20>, '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.y36R0E9T3F/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.YR2tEHnXOg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/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 05:49:45 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 05:49:45 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 05:49:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.y36R0E9T3F/Render', 05:49:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:49:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:49:45 INFO - 'HOME': '/Users/cltbld', 05:49:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:49:45 INFO - 'LOGNAME': 'cltbld', 05:49:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:49:45 INFO - 'MOZ_NO_REMOTE': '1', 05:49:45 INFO - 'NO_EM_RESTART': '1', 05:49:45 INFO - 'PAGER': '/bin/cat', 05:49:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:49:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:49:45 INFO - 'PWD': '/builds/slave/test', 05:49:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:49:45 INFO - 'SHELL': '/bin/bash', 05:49:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YR2tEHnXOg/Listeners', 05:49:45 INFO - 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/', 05:49:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:49:45 INFO - 'USER': 'cltbld', 05:49:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:49:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:49:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:49:45 INFO - 'XPC_FLAGS': '0x0', 05:49:45 INFO - 'XPC_SERVICE_NAME': '0', 05:49:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:49:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:49:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:49:46 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-U7Kmjb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:49:46 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)) 05:49:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:49:46 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-O0Ajco-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:49:46 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)) 05:49:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:49:46 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-iTSmPH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:49:46 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)) 05:49:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:49:46 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-a3ffSK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:49:46 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)) 05:49:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:49:46 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-zNVMfD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:49:46 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)) 05:49:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:49:46 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-Vuk_R9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:49:46 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)) 05:49:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:49:46 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-EDxVwR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:49:46 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)) 05:49:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:49:46 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-Wwjs5w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:49:46 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)) 05:49:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:49:46 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-XyNkm2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:49:47 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)) 05:49:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:49:47 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-ee_SGl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:49:47 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)) 05:49:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:49:47 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-8iKQX0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:49:47 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)) 05:49:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:49:47 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-NgKhjA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:49:47 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)) 05:49:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:49:47 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-cGTLb3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:49:47 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)) 05:49:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:49:47 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-wwiN0l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:49:47 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)) 05:49:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:49:47 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-uq8Jks-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:49:47 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)) 05:49:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:49:47 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-_lrnBC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:49:47 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)) 05:49:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:49:47 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-94tRFp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:49:47 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)) 05:49:47 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)) 05:49:47 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)) 05:49:47 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)) 05:49:47 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)) 05:49:47 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)) 05:49:47 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:49:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:49:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:49:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:49:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:49:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:49:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:49:50 INFO - Downloading blessings-1.6.tar.gz 05:49:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:49:50 INFO - Installing collected packages: blessings 05:49:50 INFO - Running setup.py install for blessings 05:49:51 INFO - Successfully installed blessings 05:49:51 INFO - Cleaning up... 05:49:51 INFO - Return code: 0 05:49:51 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:49:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:49:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:49:51 INFO - Reading from file tmpfile_stdout 05:49:51 INFO - Current package versions: 05:49:51 INFO - blessings == 1.6 05:49:51 INFO - blobuploader == 1.2.4 05:49:51 INFO - docopt == 0.6.1 05:49:51 INFO - manifestparser == 1.1 05:49:51 INFO - mozInstall == 1.12 05:49:51 INFO - mozcrash == 0.17 05:49:51 INFO - mozdebug == 0.1 05:49:51 INFO - mozdevice == 0.48 05:49:51 INFO - mozfile == 1.2 05:49:51 INFO - mozhttpd == 0.7 05:49:51 INFO - mozinfo == 0.9 05:49:51 INFO - mozleak == 0.1 05:49:51 INFO - mozlog == 3.1 05:49:51 INFO - moznetwork == 0.27 05:49:51 INFO - mozprocess == 0.22 05:49:51 INFO - mozprofile == 0.28 05:49:51 INFO - mozrunner == 6.11 05:49:51 INFO - mozscreenshot == 0.1 05:49:51 INFO - mozsystemmonitor == 0.0 05:49:51 INFO - moztest == 0.7 05:49:51 INFO - mozversion == 1.4 05:49:51 INFO - psutil == 3.1.1 05:49:51 INFO - requests == 1.2.3 05:49:51 INFO - wsgiref == 0.1.2 05:49:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:49:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:49:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:49:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:49:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:49:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49:51 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 0x105171a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105181420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc448d74d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105010e00>, '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 0x104e79db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10500bb20>, '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.y36R0E9T3F/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.YR2tEHnXOg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/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 05:49:51 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 05:49:51 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 05:49:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.y36R0E9T3F/Render', 05:49:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:49:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:49:51 INFO - 'HOME': '/Users/cltbld', 05:49:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:49:51 INFO - 'LOGNAME': 'cltbld', 05:49:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:49:51 INFO - 'MOZ_NO_REMOTE': '1', 05:49:51 INFO - 'NO_EM_RESTART': '1', 05:49:51 INFO - 'PAGER': '/bin/cat', 05:49:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:49:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:49:51 INFO - 'PWD': '/builds/slave/test', 05:49:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:49:51 INFO - 'SHELL': '/bin/bash', 05:49:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YR2tEHnXOg/Listeners', 05:49:51 INFO - 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/', 05:49:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:49:51 INFO - 'USER': 'cltbld', 05:49:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:49:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:49:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:49:51 INFO - 'XPC_FLAGS': '0x0', 05:49:51 INFO - 'XPC_SERVICE_NAME': '0', 05:49:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:49:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:49:51 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)) 05:49:51 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)) 05:49:51 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)) 05:49:51 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)) 05:49:51 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)) 05:49:51 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)) 05:49:51 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)) 05:49:51 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)) 05:49:51 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)) 05:49:51 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)) 05:49:51 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)) 05:49:51 INFO - Cleaning up... 05:49:51 INFO - Return code: 0 05:49:51 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:49:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:49:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:49:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:49:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:49:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x105171a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105181420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc448d74d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105010e00>, '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 0x104e79db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10500bb20>, '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.y36R0E9T3F/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.YR2tEHnXOg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/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 05:49:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 05:49:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:49:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.y36R0E9T3F/Render', 05:49:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:49:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:49:51 INFO - 'HOME': '/Users/cltbld', 05:49:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:49:51 INFO - 'LOGNAME': 'cltbld', 05:49:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:49:51 INFO - 'MOZ_NO_REMOTE': '1', 05:49:51 INFO - 'NO_EM_RESTART': '1', 05:49:51 INFO - 'PAGER': '/bin/cat', 05:49:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:49:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:49:51 INFO - 'PWD': '/builds/slave/test', 05:49:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:49:51 INFO - 'SHELL': '/bin/bash', 05:49:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YR2tEHnXOg/Listeners', 05:49:51 INFO - 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/', 05:49:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:49:51 INFO - 'USER': 'cltbld', 05:49:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:49:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:49:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:49:51 INFO - 'XPC_FLAGS': '0x0', 05:49:51 INFO - 'XPC_SERVICE_NAME': '0', 05:49:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:49:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:49:52 INFO - Downloading/unpacking jsonschema 05:49:52 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 05:49:52 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 05:49:52 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 05:49:52 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 05:49:52 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 05:49:52 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 05:49:54 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:49:54 INFO - Downloading/unpacking functools32 (from jsonschema) 05:49:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:49:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:49:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:49:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:49:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:49:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:49:54 INFO - Downloading functools32-3.2.3-2.tar.gz 05:49:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:49:55 INFO - warning: no files found matching '*.txt' 05:49:55 INFO - no previously-included directories found matching 'build' 05:49:55 INFO - no previously-included directories found matching 'dist' 05:49:55 INFO - no previously-included directories found matching '.git*' 05:49:55 INFO - Installing collected packages: jsonschema, functools32 05:49:55 INFO - Running setup.py install for functools32 05:49:55 INFO - warning: no files found matching '*.txt' 05:49:55 INFO - no previously-included directories found matching 'build' 05:49:55 INFO - no previously-included directories found matching 'dist' 05:49:55 INFO - no previously-included directories found matching '.git*' 05:49:55 INFO - Successfully installed jsonschema functools32 05:49:55 INFO - Cleaning up... 05:49:55 INFO - Return code: 0 05:49:55 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 05:49:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:49:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:49:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:49:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:49:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x105171a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105181420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc448d74d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105010e00>, '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 0x104e79db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10500bb20>, '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.y36R0E9T3F/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.YR2tEHnXOg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/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 05:49:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 05:49:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 05:49:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.y36R0E9T3F/Render', 05:49:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:49:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:49:55 INFO - 'HOME': '/Users/cltbld', 05:49:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:49:55 INFO - 'LOGNAME': 'cltbld', 05:49:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:49:55 INFO - 'MOZ_NO_REMOTE': '1', 05:49:55 INFO - 'NO_EM_RESTART': '1', 05:49:55 INFO - 'PAGER': '/bin/cat', 05:49:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:49:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:49:55 INFO - 'PWD': '/builds/slave/test', 05:49:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:49:55 INFO - 'SHELL': '/bin/bash', 05:49:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YR2tEHnXOg/Listeners', 05:49:55 INFO - 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/', 05:49:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:49:55 INFO - 'USER': 'cltbld', 05:49:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:49:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:49:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:49:55 INFO - 'XPC_FLAGS': '0x0', 05:49:55 INFO - 'XPC_SERVICE_NAME': '0', 05:49:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:49:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:49:55 INFO - Downloading/unpacking flake8 05:49:55 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 05:49:55 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 05:49:55 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 05:49:55 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 05:49:55 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 05:49:55 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 05:49:57 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:49:57 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:49:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:49:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:49:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:49:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:49:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:49:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:49:58 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:49:58 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:49:58 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 05:49:58 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 05:49:58 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 05:49:58 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 05:49:58 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 05:49:58 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 05:49:58 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:49:58 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 05:49:58 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 05:49:58 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 05:49:58 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 05:49:58 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 05:49:58 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 05:49:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 05:49:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:49:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:49:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:49:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:49:59 INFO - no previously-included directories found matching 'docs/_build' 05:49:59 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:49:59 INFO - Running setup.py install for pep8 05:49:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:49:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:49:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:49:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:49:59 INFO - no previously-included directories found matching 'docs/_build' 05:49:59 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 05:49:59 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:49:59 INFO - Cleaning up... 05:49:59 INFO - Return code: 0 05:49:59 INFO - Running post-action listener: _resource_record_post_action 05:49:59 INFO - Running post-action listener: _start_resource_monitoring 05:49:59 INFO - Starting resource monitoring. 05:49:59 INFO - ##### 05:49:59 INFO - ##### Running install step. 05:49:59 INFO - ##### 05:49:59 INFO - Running pre-action listener: _resource_record_pre_action 05:49:59 INFO - Running main action method: install 05:49:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:49:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:49:59 INFO - Reading from file tmpfile_stdout 05:49:59 INFO - Detecting whether we're running mozinstall >=1.0... 05:49:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:49:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:50:00 INFO - Reading from file tmpfile_stdout 05:50:00 INFO - Output received: 05:50:00 INFO - Usage: mozinstall [options] installer 05:50:00 INFO - Options: 05:50:00 INFO - -h, --help show this help message and exit 05:50:00 INFO - -d DEST, --destination=DEST 05:50:00 INFO - Directory to install application into. [default: 05:50:00 INFO - "/builds/slave/test"] 05:50:00 INFO - --app=APP Application being installed. [default: firefox] 05:50:00 INFO - mkdir: /builds/slave/test/build/application 05:50:00 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'] 05:50:00 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 05:50:22 INFO - Reading from file tmpfile_stdout 05:50:22 INFO - Output received: 05:50:22 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 05:50:22 INFO - Running post-action listener: _resource_record_post_action 05:50:22 INFO - ##### 05:50:22 INFO - ##### Running run-tests step. 05:50:22 INFO - ##### 05:50:22 INFO - Running pre-action listener: _resource_record_pre_action 05:50:22 INFO - Running main action method: run_tests 05:50:22 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:50:22 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:50:22 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:50:22 INFO - 2016-06-27 05:50:22.348 screenresolution[1923:19491] starting screenresolution argv=screenresolution get 05:50:22 INFO - 2016-06-27 05:50:22.351 screenresolution[1923:19491] Display 0: 1600x1200x32@60 05:50:22 INFO - 2016-06-27 05:50:22.357 screenresolution[1924:19494] starting screenresolution argv=screenresolution list 05:50:22 INFO - Available Modes on Display 0 05:50:22 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:50:22 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:50:22 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:50:22 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:50:22 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:50:22 INFO - Intel Iris: 05:50:22 INFO - Chipset Model: Intel Iris 05:50:22 INFO - Type: GPU 05:50:22 INFO - Bus: Built-In 05:50:22 INFO - VRAM (Dynamic, Max): 1536 MB 05:50:22 INFO - Vendor: Intel (0x8086) 05:50:22 INFO - Device ID: 0x0a2e 05:50:22 INFO - Revision ID: 0x0009 05:50:22 INFO - Displays: 05:50:22 INFO - Display: 05:50:22 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:50:22 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:50:22 INFO - Display Serial Number: 1600x1200 60 05:50:22 INFO - Main Display: Yes 05:50:22 INFO - Mirror: Off 05:50:22 INFO - Online: Yes 05:50:22 INFO - Rotation: Supported 05:50:22 INFO - Return code: 0 05:50:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:50:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:50:22 INFO - Python 2.7.3 05:50:22 INFO - Return code: 0 05:50:22 INFO - grabbing minidump binary from tooltool 05:50: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')]} 05:50:22 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 0x105010e00>, '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 0x104e79db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10500bb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:50:22 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 05:50:22 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 05:50:22 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:50:22 INFO - Return code: 0 05:50:22 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 05:50:22 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:50:22 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:50:22 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 05:50:22 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:50:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 05:50:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 05:50:23 INFO - Return code: 0 05:50:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HNf6UujUQ5mnMECPR4aaTg/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0191', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 05:50:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/HNf6UujUQ5mnMECPR4aaTg/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0191 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 05:50:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.y36R0E9T3F/Render', 05:50:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:50:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:50:23 INFO - 'HOME': '/Users/cltbld', 05:50:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:50:23 INFO - 'LOGNAME': 'cltbld', 05:50:23 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:50:23 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 05:50:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:50:23 INFO - 'MOZ_NO_REMOTE': '1', 05:50:23 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:50:23 INFO - 'NO_EM_RESTART': '1', 05:50:23 INFO - 'PAGER': '/bin/cat', 05:50:23 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:50:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:50:23 INFO - 'PWD': '/builds/slave/test', 05:50:23 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:50:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:50:23 INFO - 'SHELL': '/bin/bash', 05:50:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YR2tEHnXOg/Listeners', 05:50:23 INFO - 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/', 05:50:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:50:23 INFO - 'USER': 'cltbld', 05:50:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:50:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:50:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:50:23 INFO - 'XPC_FLAGS': '0x0', 05:50:23 INFO - 'XPC_SERVICE_NAME': '0', 05:50:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:50:23 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HNf6UujUQ5mnMECPR4aaTg/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0191', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 05:50:23 INFO - mozversion application_buildid: 20160627035125 05:50:23 INFO - mozversion application_changeset: 6a6dc3f2075a2ee976b1728d791e94c1a88e5c8e 05:50:23 INFO - mozversion application_display_name: Firefox 05:50:23 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:50:23 INFO - mozversion application_name: Firefox 05:50:23 INFO - mozversion application_remotingname: firefox 05:50:23 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 05:50:23 INFO - mozversion application_vendor: Mozilla 05:50:23 INFO - mozversion application_version: 48.0 05:50:23 INFO - mozversion platform_buildid: 20160627035125 05:50:23 INFO - mozversion platform_changeset: 6a6dc3f2075a2ee976b1728d791e94c1a88e5c8e 05:50:23 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 05:50:23 INFO - mozversion platform_version: 48.0 05:50:23 INFO - using testdate: 1467031823 05:50:23 INFO - actual date: 1467031823 05:50:23 INFO - starting webserver on 'localhost:55855' 05:50:23 INFO - SUITE-START | Running 2 tests 05:50:23 INFO - TEST-START | dromaeo_css 05:50:23 INFO - operating with platform_type : mac_ 05:50:23 INFO - Initialising browser for dromaeo_css test... 05:50:24 INFO - TEST-INFO | started process 1942 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/tmpPz0NNv/profile http://localhost:55855/getInfo.html) 05:50:26 INFO - PROCESS | 1942 | __metrics Screen width/height:1600/1200 05:50:26 INFO - PROCESS | 1942 | colorDepth:24 05:50:26 INFO - PROCESS | 1942 | Browser inner width/height: 1024/689 05:50:26 INFO - PROCESS | 1942 | __metrics 05:50:26 INFO - PROCESS | 1942 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 05:50:26 ERROR - PROCESS | 1942 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 05:50:26 INFO - TEST-INFO | 1942: exit 0 05:50:26 INFO - Browser initialized. 05:50:26 INFO - Running cycle 1/1 for dromaeo_css test... 05:50:26 INFO - TEST-INFO | started process 1945 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/tmpPz0NNv/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:50:38 INFO - PROCESS | 1945 | RSS: Main: 162037760 05:50:38 INFO - PROCESS | 1945 | 05:51:30 INFO - PROCESS | 1945 | 1467031890008 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] 05:53:39 INFO - PROCESS | 1945 | Cycle 1(1): loaded http://localhost:55855/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55855/tests/dromaeo/cssquery-ext.html) 05:53:41 INFO - PROCESS | 1945 | RSS: Main: 249929728 05:53:41 INFO - PROCESS | 1945 | 05:56:43 INFO - PROCESS | 1945 | Cycle 1(1): loaded http://localhost:55855/tests/dromaeo/cssquery-ext.html (next: http://localhost:55855/tests/dromaeo/cssquery-jquery.html) 05:56:44 INFO - PROCESS | 1945 | RSS: Main: 306655232 05:56:44 INFO - PROCESS | 1945 | 05:59:46 INFO - PROCESS | 1945 | Cycle 1(1): loaded http://localhost:55855/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55855/tests/dromaeo/cssquery-mootools.html) 05:59:47 INFO - PROCESS | 1945 | RSS: Main: 310956032 05:59:47 INFO - PROCESS | 1945 | 06:02:49 INFO - PROCESS | 1945 | Cycle 1(1): loaded http://localhost:55855/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55855/tests/dromaeo/cssquery-prototype.html) 06:02:49 INFO - PROCESS | 1945 | RSS: Main: 308805632 06:02:49 INFO - PROCESS | 1945 | 06:05:52 INFO - PROCESS | 1945 | Cycle 1(1): loaded http://localhost:55855/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55855/tests/dromaeo/cssquery-yui.html) 06:05:53 INFO - PROCESS | 1945 | RSS: Main: 270336000 06:05:53 INFO - PROCESS | 1945 | 06:08:55 INFO - PROCESS | 1945 | Cycle 1(1): loaded http://localhost:55855/tests/dromaeo/cssquery-yui.html (next: http://localhost:55855/tests/dromaeo/cssquery-dojo.html) 06:08:56 INFO - PROCESS | 1945 | RSS: Main: 314122240 06:08:56 INFO - PROCESS | 1945 | 06:08:56 INFO - PROCESS | 1945 | __start_tp_report 06:08:56 INFO - PROCESS | 1945 | _x_x_mozilla_page_load 06:08:56 INFO - PROCESS | 1945 | _x_x_mozilla_page_load_details 06:08:56 INFO - PROCESS | 1945 | |i|pagename|runs| 06:08:56 INFO - PROCESS | 1945 | |0;dojo.html;3135.968640313597;3631.818409079547;3632.11013301741;3632.9636703632955;3725.813709314535;5962.672053037081;5985.4912332451795;5997.164649974041;6050.455459008688;6074.574779765413;5970.73131709073;6001.129836173752;6038.516918646509;6040.969795151029;6086.117512960629;5330.973345133269;5410.810621628244;5465.207544905987;5473.261109750172;5529.225908372831;5446;5493.2034854946005;5497.615166938316;5499.560035197194;5515.61390702649;5435.972820135894;5484.424135465779;5493.23094766733;5523.7790488380415;5549.556035517169;5486.341639003325;5489.862753431156;5493.093639549469;5533.916991245134;5598.58010649203;4068.471098757172;5347.41178470368;5359.812406565751;5410.3507579090765;5452.454754524555;5872.442117998826;5918.40815918409;5930.911036334458;5967.1347654589845;5992.820215393545;6284.34014428483;6289.867823791716;6335.049742538656;6340.682965851735;6345.238571371418;6275.560710750249;6340.302566717657;6424.26120996082;6426.485881129498;6430.16407866979;6145.002874065946;6158.353372895871;6175.228096487939;6186.041163619646;6199.845003874939;6546.607203567801;6560.835979100465;6565.507586930904;6566.737330506822;6581.605103693698;6100.48145907594;6153.753849846045;6187.102870083812;6205.5345849061505;6291.339409362043;6377.617342959437;6391.488680905516;6396.776112836028;6401.615903045832;6412.551121421456;6243.25080990275;6290.433860952537;6304.275008374004;6304.621722696653;6316.2736285326855;6212.72042758077;6231.40801623845;6275.435210831047;6276;6286.717097730521;5102.285680004802;5110.514501122388;5113.897722045538;5121.334226550524;5124.871878203075;4600.5169457207185;4624.167649822997;4636.4899861015265;4647.18674232008;4666.859994200179;5977.402259774075;6049;6098.390160983955;6101.725422356005;6105.908411373833;6376.553641245161;6408.58344207625;6417.679116044179;6421.775237866652;6432;5952.553558483044;6047.546434017467;6075.726592303357;6107.328193898667;6126.540509461808;5475.206095116186;5541.722913854291;5593.608447408724;5599.188117722989;5631.436856314336;6655.267920528738;6669.733210671713;6680.832979175462;6687.565308254948;6694.564853284521;6403;6406;6419.422251997343;6430.324815894451;6445.9033114504255;6439.967800160969;6462.386073323027;6511.446527045254;6553;6638.402543771083;6289.150964619717;6319.715612797343;6326.873462530815;6328.208973878265;6339.461145802658;6379.425851673372;6414.743410263537;6433.935660643334;6442.033694945796;6447.290798012121;6134.191681013941;6200.782972595937;6207.751689932352;6242.781502647385;6282.1519094921605;6243.656598887105;6251.343608920998;6254.874902502015;6257.78097766576;6292.307846137013;6137.570370074052;6265.091561723616;6275.780347687809;6288.779892703734;6296;6168.845778855564;6181.505479561534;6201.317855036033;6232.220972378453;6284.371562843679;6221.160143380585;6225.31521532622;6247.3440288769025;6248.968755156195;6293.118963345044 06:08:56 INFO - PROCESS | 1945 | |1;ext.html;509.80882169186555;518.0597216052864;571.8770464350164;598.0043228025338;602.4939051196993;28799.856000719992;33295.00114996551;40102.79691609253;40558.59441405585;40704.77885663427;44370.55629443705;44816;44817.32774008392;44841.65475035746;44845.327320090226;9788.951055244714;10002.749931251741;10004.19966402686;10011.849822252672;10024.54889529973;9828.410295382264;9940.453275069869;9989.400635961865;9993.500324983757;9996.550155242996;10132.392056476636;10188.083072523472;10206.948965255164;10214.336068155546;10219.335743176707;8660;10137.39175649456;10144.340617859816;10144.492775361203;10149.035841595074;9751.21990240779;9843.655472058515;9858.852117218248;9862.40825550462;9869.407835529892;42224.366634500504;42768.144637107085;42825.78587107076;42833.92915177145;42858.78570607158;3223.09753269085;3354.4297469430257;3408.062782734743;3496.527968724215;3808.8857334279737;24630.753692463026;28522.714772852214;30118.698813011808;30218;31407.37185256282;2751.931201719953;2826.279298778819;2833.546632538784;2843.516602177635;2886.2495751104652;409100;409315;411035;411184;411814;38830;39486.80256598699;70019;70681.58636827234;70695.9395609056;38881;38988.41517377242;39069.218615628095;39089.80455097706;39636.40545391821;16174.27215775293;16355.672886542203;16357.754633680504;16370.427035053715;16379.508614741577;13581.592552223448;13642.590722278348;13646.044776865525;13689.520866769815;13690.726185476235;8749.387542871938;8857.202851743374;8936.41913275635;8946.463212207158;8999.910000899907;3581.6239294873662;3630.1650620357464;3643.5809881863397;3648.8540458381367;3661.8718344857803;959.9616015359308;1024.2369434771142;1061.3950048472298;1067.2976602319288;1127.1827924754487;31807.84096079505;32687.34625307528;32744.67255327464;33311.46889286386;33491;1135.0975974100609;1168.6735555144971;1217.0567809947186;1231.5197073141483;1266.2149467330314;15515.922420387826;15594.688106238038;15677.529674109795;15901.761473577906;15919.204039798195;638728;639376;647584;648797;649563;63845.361546383945;64042.359576403636;64127.679361602895;64189.67905160444;64297.67851160808;1414.1373762005169;1448.5509492057497;1457.890658200639;1496.5061529695174;1593.768903509008;30698.846505767327;30902.690973089982;31338.68661313449;31926.201844954063;32159;54918.17622735582;55439.72280138735;56714;57030.7148464255;57143.857122856476;474332;479363;487344;488220;488355;38309.808450957564;44218.89452763578;45150.32274515819;46049.76975115103;49512;48972.77568060827;49169;49984.75007624939;50391.74804125956;51234;39212.60787392204;39569.208615826945;41325.79337103295;41399.37900931428;41683.7915810419;39322;39761.2047759049;39809.20381592294;39989.80005099956;40373;38785.61214387933;39537.406938895365;39718.80140599279;40944.59055409408;41145.97135071647;34743.65256347404;34795.82602086973;35744.82127589345;35774.284514309045;37492.81253593715;25931;26603;26644.733552664224;26789.062382816508;26815.597766033134 06:08:56 INFO - PROCESS | 1945 | |2;jquery.html;387.21202353211214;412.95934245700835;414.952280487744;419.37722482114054;426.6373582454914;15660.765088523682;20902.581948361025;21323;21529.46176345592;21665.458363540918;15387.461438849643;16306.510804675878;20997.47506312343;21430.571388572218;21462.89268553655;5329.680219186852;5682.147677848335;5684.346300175471;5689.089745640698;5694.117411801178;5581.10702287632;5660.915086273709;5661.179129026289;5665.3768085510565;5668.914966275509;5924.940750592504;6028.638281703112;6171.413715697002;6250.624962502242;6258.061290806393;5762.366139724627;6183.165272688175;6192.876142477147;6211.503079753654;6227.626342419447;5334.626576139672;5455.1271796512365;5498.285222921035;5508.14623733322;5508.4491550845;14620.780688289684;14672.339744711513;17607.911960440117;27886.721132788818;27950.881964721386;2388.1402695029774;2438.8414753041175;2669.759721625063;2682.852443115628;2974.866131024109;10393.324433911846;10526.42104684242;10584.629537966212;10928.890711092867;11009.119270458425;1733.5926057376507;1785.61609254011;1916.0898573177628;1920.3758778397078;1933.690609502487;121536;124987;126712;127375;127609.64112909278;10019.899801001897;11780.469878855301;12042.277463352228;12072.215306005082;12077.214981026205;16148.111853847917;16226.675466490604;16246.918765406097;16283.104429256267;16300.592485187728;9115.134062264207;9234.49210293427;9248.907510924939;9287.860682089775;9369;9258.537073146315;9269.90730092704;9270.44377337362;9341.439513629068;9344.859827102599;4864.416270047617;4975.701457912464;4980.402351717745;4983.352164218701;5057.089723849669;1996.6106609211065;2057.2902348689677;2062.3091264426585;2062.5462398272357;2063.494443861264;888.8933328000552;957.4398976598768;964.4840010594298;971.3928794503436;981.6367943860818;20837;21819.01814418355;21969.340919772432;22065.227717029826;22095.226667066574;974.2595627323144;984.8128855517572;1011.6408674920444;1016.5120742043861;1058.4072919165292;8956.596953137125;9425.245980321557;11090.334579925231;11569.652910412533;11610.419479026015;625909;628700;637557;637683;642576.7871160707;124917.37541312235;128186;128335;128608;136541;929.2101713543569;984.9901500985042;998.9411224102474;1019.8521214423866;1025.29254814178;19283.93938333405;19309.324173653855;19381.61236775285;19408.902955485133;19527.804721952598;37668.62331376761;42571.36142957796;42944;43443.782781085894;55388.44611553994;68617.65691171512;69335.65332173307;70578;74663;75931;7783.299503044753;8078.434509584273;8241.95879020625;8481.36389770782;8575.31397488212;12518.499260029861;12745.235285882876;12956.546520871725;13031.413586388446;13173.670658233621;11113;11153.944230279121;11177.993980541465;11490.310581365145;11634.95285424282;11043.668689939315;11199.10407167441;11286.435678215892;11296.661100167008;11476.885231147582;11524.481398336928;11675.241109328206;11742.765144697229;11970.880291196976;12117.212381195193;8464.068952415353;8571;8573.785655358666;8615.827683446421;8719.825603488021;8686.565671716262;10027.097561219234;11316.321020738782;11603.245789023686;11858.466369013242 06:08:56 INFO - PROCESS | 1945 | |3;mootools.html;1508.3287936868098;1627.1620115640444;1658.6765580711763;1913.0817207740283;2012.8188463038332;8222.58887055647;8910.821783564334;9028.593713282902;9040;9059.954700226497;7420.96289518553;9058.864117038233;9063.229625481825;9076.63693452261;9081.318901082412;2520.193538067819;2547.885345159463;2550.311415917701;2551.4386834896295;2551.8596477193746;2491.377155711072;2532.556802559554;2566.217303722364;2567.063021996967;2568.306557229547;2513.522430738163;2525.053105085593;2567.281161274846;2575.072973729456;2578.948421031578;2514.924552263435;2549.464612431382;2558.2836805694437;2570.4216551276;2575.9227223183334;2506.7994560435122;2557.4885022995477;2558.0790915270486;2563.474487730011;2570.961435578468;8839.381243312971;9050.683226087056;9148.039455857172;9218.907810921872;9232.861507077332;5624.746886390122;5870.20752198452;5870.853228669274;5874.265716785402;5874.941250587525;3666.6699997000132;3722.7021838252876;3789.5831458539537;3811.6760075393627;3813.0086177594026;1030.2685093583564;1038;1053.3627155570846;1067.4662668665667;1089.0307626212677;12329.630111096682;12565.497380104785;12582;12592.559260425842;12644.988400927996;4806.351142595775;4821.432140216215;4821.807127714922;4826.8793280168275;4940.802367905316;9726.076022777825;9729.610815567297;9736.41581505112;9767.51162441875;9777.266704997153;5628.324601047901;5628.549716022709;5633.802816901471;5636.492715655529;5676.68778217202;4604.884877878013;4778.808847646124;5004.549590536869;5103.055934652101;5229.921551176735;3213.7268332192025;4033.858814941463;4102.958970410317;4124.319487284564;4127.050778321003;1247.4324182496941;1252.6179515247936;1258.6098309524077;1264.5574049082932;1271.650296168561;936.948467834262;938.8450905600636;963.6097380560884;964.3249725192394;990.0940639314946;6112.847178820565;6139.386061393825;6160.722767475474;6229.314775374705;6269.498440124779;423.9745615263094;477.7578296429256;489.3149590573155;944.3483996042709;1006.7634105985234;4023.2154729827403;4025.295573274665;4049.595040495986;4109.56849530795;4114.115465175002;10873.184511161695;11353.54585816558;11363.37501437429;11372.829407558893;11393.259438136494;11116.777664446827;11129.833052504218;11144.554217831195;11216.607418740305;11268.887311126948;6790.219124800711;8499.320054395634;8568.657253709782;8613.052564217931;8613.956930215434;6031.939680603314;6097.024476083805;6140.5394595406415;6181.072839074175;6200.255969283535;9728.978457261886;9831.754206144618;9861.161801246973;10114.241431892784;10133.949330253301;10305.124064454305;10403.791924161626;10461.476926153815;10707.089897358812;10711.357318560911;6015.87968240624;6947.305269473214;7004.124484439445;7895.84208315842;8047;8637.654493820428;8723.91276087231;8747.650093996423;8758.386912916034;8759.868601970848;7603.315701586884;7665.3101220890385;7668.693252269847;7788.88316675239;7799.220077992155;7445.255474452511;7529.472936894584;7587;7608.543487390774;7673.923260767321;7171.282871712787;7173.24680908518;7230.891536626849;7237.312455316736;7237.63811809418;4892.608591312615;4904.215325547895;4996.7001979881325;4998.850034498971;5020.397552293748;4436.713353127686;4550.7712917512745;4877.609791216765;4963.057019166346;5291.365036195682 06:08:56 INFO - PROCESS | 1945 | |4;prototype.html;332.54109329125805;337.8310844577711;340.2697284309288;346.62564430415154;348.4024897301128;6596.076549283104;6867;6870.209925858521;6873.621950792704;6878.9312106878915;6646.867062658744;6652.135222421079;6656.6671666416605;6674;6703.463722902168;4745.59662428694;4901.289313049606;4905.852824415273;4909.926351104737;4911.729854857981;4882.41411030675;4926.778294976734;4980.576650984653;4997.4003119625695;5049.091163590552;4834;4905.705657660552;4924.138275801738;4931.137051016076;4941.777620007108;4943.579795717368;4944.406671199461;4963.528464795839;4965.131102057126;4969.9751501242445;4044.373122166069;4129.710920235585;4196.3705444183615;4198.223328684203;4231.449911511515;6290.3709629037185;6291.1192433059405;6310.5898116622275;6396.584222025554;6425.811224923357;5865.120231965197;5865.912011319833;5875.412458754133;5881.14723365114;5895.823125306205;6765.05289259504;7063.646817659096;7068.505204635678;7090.610016449094;7124.073870396815;3845.65389114981;3845.7115716321387;4755.9286610700865;4756.976215118937;4768.785404656799;7135.928640713579;7466.328030477337;7522.360599349062;7529.435292353095;7555.093388793325;4703.553162449562;4707.646926480527;4711.246200607886;4720.268358404453;4726.314684370747;4773.570378665937;4787.808487660524;4800.783964721596;4806.062817750505;4819.59033482151;5737.139429085671;5755.740991655385;5765.3946335634155;5767;5775.566832487496;6831.146106736658;7077.716891324392;7120.394766444911;7143.4999550031;7166.068411106627;1645.8189599144084;1659.1952902842113;1669.1070277401532;1672.1555614414642;1676.8993860368416;1037.870266216723;1048.2662136504478;1064.3188359449957;1065.7158124460007;1067.6903697927514;6480.31956644555;6652.70062847173;6723.731050758012;6728.764493242811;6741.696623651947;7295.89056164158;7397.593132377663;7469.290417410337;7505.737299194502;7535.284148006041;6797.082393876863;6798.864022719518;6807.795766127024;6822.317768223138;6826.385625293748;3409.6760807723226;3783.2622638585212;3911.1786524830104;3972.1261322509004;3974.205158968218;5955.37468565803;7814.726484573012;7882.369410447265;7896.328812050925;7900.051993760785;7707.768766936889;7753.728619498291;7755.650995705207;7772.494787838772;7797.688092476237;6287.308396076428;7851.960740196262;7853.450258481851;7854.978852749106;7872.33085187754;7419.777406677808;7429.777106686808;7433.182349941394;7450.8882366763455;7474.850502990019;7172.246914074156;7330.780076597711;7353.522021068614;7396.445266605134;7398.482106252511;7803.414743894345;7835.294823465915;7876.251756083163;7896.68413263486;7897.802554936173;4709.128811169944;4761.500042495627;4764.809407623657;4766.666333356632;4776.785044672929;7475.2151024141685;7481.17707052213;7484.812879677834;7495.362894154058;7504.774856754306;6131.264248290234;6776.424003959719;7236.638168091469;7241.4206863449745;7252.093488313961;5826.388229235869;7188.28117188277;7233.457490688114;7249.275072492708;7255.129384473897;7057.2237053925055;7058.858822823412;7063.223045464892;7068.752593659197;7072.186698529529;5833.883322333445;7213.963930180315;7219.772638651547;7231.8553628928175;7237.023001894677;6773.390394864486;6830.282820303796;7057.588482303458;7090.822729431806;7100.538464999759 06:08:56 INFO - PROCESS | 1945 | |5;yui.html;676.8747781660393;701.3512500936632;758.6017340896029;777.2577188784711;791.6556298010364;15205.011674241194;15622.531324060283;15673.373065077398;15794.368225270975;15864.841351586481;12734.426950787214;14466.493672721457;14471.638209044779;14488.492902748407;14514.782278265835;935.303199116659;965.6330594374128;966.1980556138424;966.9661561845337;968.3802366485455;939.0421769794805;958.1185309515263;958.8897276813151;959.6545243712258;963.9807203855919;1045.3623289793259;1045.6497073480393;1047.287844265899;1048.5805677728931;1050.1703654113242;1040.3653771199563;1040.8646875906122;1041.9374837509774;1042.3224903812545;1044.597829835515;771.3019717155983;773.1186447449911;773.234497847133;773.4856320546829;777.1218523068952;15675.686486270211;15711.528654140395;15717;15741.449049283334;15802.841971580252;12849.164804287691;13013.60959171217;13030.478780848754;13077.803832942513;13319.667008324772;10359.896401035969;10361.222908281834;10463.424511651856;10737.24839261252;10802.243842930999;3559.697425718817;3569.1790888095625;3604.3499742974172;3610.277944411102;3812.3137835189655;67125;78091.82862257071;78402.21597784063;80133.59933200413;82215.42276617917;9724.854127188099;9753.414795112316;9893.851592226123;10265.178785697126;10420.218483613759;21674.34976950694;21679.891600541898;21680.132794688037;21706.240281590384;21744.673829892563;7650.770476885702;7683.6926522939575;7812.218778122256;7944.761657150295;8007.359411247086;4173.791310434466;4209.305464598368;4264.936025959551;4283.678724095706;4336.50130235027;3272.4927636216426;3736.5516138063062;3817.3701339279264;3817.809109544567;3822.9235415292096;607.471499795181;665.7769647168253;686.3513979289623;688.6281408039703;692.4252870117891;597.5130268830889;602.4246844263718;604.597942368329;615.1725928625991;628.4281304013326;8320.292775114061;8436.282915952213;8510.106438823834;8566.91433085661;8842.46945183291;522.6368319861703;566.3996164066103;582.790195529609;605.449041372349;624.1979056911847;3927.7250592458254;3928.783916884599;4017.276890159741;4024.4969378827645;4136.896577585584;91752.5412372934;93771.53114234385;94688;94730.52634736782;94803;68702;76216.23783762203;76424.23575764282;78887.60556197182;79883;54318.91362172734;68000.3199967994;68787.31212687909;70804;71378.64310678413;8652.610632521426;8750.431221970552;8885.777855553662;8953.776155596162;9126;48344.75827620839;49277.07229277187;49512;49896;51548.64933779292;67503;70367.64816175886;70508.64745676238;71030;71368.92946605702;10615.522301496605;10844.024037836632;11061.949114834079;11149.108071354434;11393.886061139283;11824;12005.75988480243;12061.095417843522;12270.938645306716;12490.75018499643;11496.597619083292;11599.014083802971;11614.825777613512;11709.765804683688;11791.410429478321;11178.329300242012;11350.432478375884;11561.653150405502;11638.836116388293;12061.457234424297;11143.2199746017;11204.551817927191;11320.320780753182;11503.137264705349;12077.456514457046;9424;9731.951340243253;9743.171830394496;9827.950860245654;9971.900280997097;8760.60577274037;9755.365901216399;9790.216782657228;9823.557939892866;9863.358881672668 06:08:56 INFO - PROCESS | 1945 | __end_tp_report 06:08:56 INFO - PROCESS | 1945 | __start_cc_report 06:08:56 INFO - PROCESS | 1945 | _x_x_mozilla_cycle_collect,1219 06:08:56 INFO - PROCESS | 1945 | __end_cc_report 06:08:56 INFO - PROCESS | 1945 | __startTimestamp1467032936174__endTimestamp 06:08:56 INFO - PROCESS | 1945 | 06:08:56 INFO - PROCESS | 1945 | ------- Summary: start ------- 06:08:56 INFO - PROCESS | 1945 | Number of tests: 6 06:08:56 INFO - PROCESS | 1945 | 06:08:56 INFO - PROCESS | 1945 | [#0] dojo.html Cycles:165 Average:5957.07 Median:6200.78 stddev:642.73 (10.4%) stddev-sans-first:605.40 06:08:56 INFO - PROCESS | 1945 | Values: 3136.0 3631.8 3632.1 3633.0 3725.8 5962.7 5985.5 5997.2 6050.5 6074.6 5970.7 6001.1 6038.5 6041.0 6086.1 5331.0 5410.8 5465.2 5473.3 5529.2 5446.0 5493.2 5497.6 5499.6 5515.6 5436.0 5484.4 5493.2 5523.8 5549.6 5486.3 5489.9 5493.1 5533.9 5598.6 4068.5 5347.4 5359.8 5410.4 5452.5 5872.4 5918.4 5930.9 5967.1 5992.8 6284.3 6289.9 6335.0 6340.7 6345.2 6275.6 6340.3 6424.3 6426.5 6430.2 6145.0 6158.4 6175.2 6186.0 6199.8 6546.6 6560.8 6565.5 6566.7 6581.6 6100.5 6153.8 6187.1 6205.5 6291.3 6377.6 6391.5 6396.8 6401.6 6412.6 6243.3 6290.4 6304.3 6304.6 6316.3 6212.7 6231.4 6275.4 6276.0 6286.7 5102.3 5110.5 5113.9 5121.3 5124.9 4600.5 4624.2 4636.5 4647.2 4666.9 5977.4 6049.0 6098.4 6101.7 6105.9 6376.6 6408.6 6417.7 6421.8 6432.0 5952.6 6047.5 6075.7 6107.3 6126.5 5475.2 5541.7 5593.6 5599.2 5631.4 6655.3 6669.7 6680.8 6687.6 6694.6 6403.0 6406.0 6419.4 6430.3 6445.9 6440.0 6462.4 6511.4 6553.0 6638.4 6289.2 6319.7 6326.9 6328.2 6339.5 6379.4 6414.7 6433.9 6442.0 6447.3 6134.2 6200.8 6207.8 6242.8 6282.2 6243.7 6251.3 6254.9 6257.8 6292.3 6137.6 6265.1 6275.8 6288.8 6296.0 6168.8 6181.5 6201.3 6232.2 6284.4 6221.2 6225.3 6247.3 6249.0 6293.1 06:08:56 INFO - PROCESS | 1945 | 06:08:56 INFO - PROCESS | 1945 | [#1] ext.html Cycles:180 Average:65821.05 Median:39151.21 stddev:139362.83 (356.0%) stddev-sans-first:139667.51 06:08:56 INFO - PROCESS | 1945 | Values: 509.8 518.1 571.9 598.0 602.5 28799.9 33295.0 40102.8 40558.6 40704.8 44370.6 44816.0 44817.3 44841.7 44845.3 9789.0 10002.7 10004.2 10011.8 10024.5 9828.4 9940.5 9989.4 9993.5 9996.6 10132.4 10188.1 10206.9 10214.3 10219.3 8660.0 10137.4 10144.3 10144.5 10149.0 9751.2 9843.7 9858.9 9862.4 9869.4 42224.4 42768.1 42825.8 42833.9 42858.8 3223.1 3354.4 3408.1 3496.5 3808.9 24630.8 28522.7 30118.7 30218.0 31407.4 2751.9 2826.3 2833.5 2843.5 2886.2 409100.0 409315.0 411035.0 411184.0 411814.0 38830.0 39486.8 70019.0 70681.6 70695.9 38881.0 38988.4 39069.2 39089.8 39636.4 16174.3 16355.7 16357.8 16370.4 16379.5 13581.6 13642.6 13646.0 13689.5 13690.7 8749.4 8857.2 8936.4 8946.5 8999.9 3581.6 3630.2 3643.6 3648.9 3661.9 960.0 1024.2 1061.4 1067.3 1127.2 31807.8 32687.3 32744.7 33311.5 33491.0 1135.1 1168.7 1217.1 1231.5 1266.2 15515.9 15594.7 15677.5 15901.8 15919.2 638728.0 639376.0 647584.0 648797.0 649563.0 63845.4 64042.4 64127.7 64189.7 64297.7 1414.1 1448.6 1457.9 1496.5 1593.8 30698.8 30902.7 31338.7 31926.2 32159.0 54918.2 55439.7 56714.0 57030.7 57143.9 474332.0 479363.0 487344.0 488220.0 488355.0 38309.8 44218.9 45150.3 46049.8 49512.0 48972.8 49169.0 49984.8 50391.7 51234.0 39212.6 39569.2 41325.8 41399.4 41683.8 39322.0 39761.2 39809.2 39989.8 40373.0 38785.6 39537.4 39718.8 40944.6 41146.0 34743.7 34795.8 35744.8 35774.3 37492.8 25931.0 26603.0 26644.7 26789.1 26815.6 06:08:56 INFO - PROCESS | 1945 | 06:08:56 INFO - PROCESS | 1945 | [#2] jquery.html Cycles:180 Average:35914.69 Median:2413.49 stddev:105676.74 (4378.6%) stddev-sans-first:105939.52 06:08:56 INFO - PROCESS | 1945 | Values: 387.2 413.0 415.0 419.4 426.6 15660.8 20902.6 21323.0 21529.5 21665.5 15387.5 16306.5 20997.5 21430.6 21462.9 5329.7 5682.1 5684.3 5689.1 5694.1 5581.1 5660.9 5661.2 5665.4 5668.9 5924.9 6028.6 6171.4 6250.6 6258.1 5762.4 6183.2 6192.9 6211.5 6227.6 5334.6 5455.1 5498.3 5508.1 5508.4 14620.8 14672.3 17607.9 27886.7 27950.9 2388.1 2438.8 2669.8 2682.9 2974.9 10393.3 10526.4 10584.6 10928.9 11009.1 1733.6 1785.6 1916.1 1920.4 1933.7 121536.0 124987.0 126712.0 127375.0 127609.6 10019.9 11780.5 12042.3 12072.2 12077.2 16148.1 16226.7 16246.9 16283.1 16300.6 9115.1 9234.5 9248.9 9287.9 9369.0 9258.5 9269.9 9270.4 9341.4 9344.9 4864.4 4975.7 4980.4 4983.4 5057.1 1996.6 2057.3 2062.3 2062.5 2063.5 888.9 957.4 964.5 971.4 981.6 20837.0 21819.0 21969.3 22065.2 22095.2 974.3 984.8 1011.6 1016.5 1058.4 8956.6 9425.2 11090.3 11569.7 11610.4 625909.0 628700.0 637557.0 637683.0 642576.8 124917.4 128186.0 128335.0 128608.0 136541.0 929.2 985.0 998.9 1019.9 1025.3 19283.9 19309.3 19381.6 19408.9 19527.8 37668.6 42571.4 42944.0 43443.8 55388.4 68617.7 69335.7 70578.0 74663.0 75931.0 7783.3 8078.4 8242.0 8481.4 8575.3 12518.5 12745.2 12956.5 13031.4 13173.7 11113.0 11153.9 11178.0 11490.3 11635.0 11043.7 11199.1 11286.4 11296.7 11476.9 11524.5 11675.2 11742.8 11970.9 12117.2 8464.1 8571.0 8573.8 8615.8 8719.8 8686.6 10027.1 11316.3 11603.2 11858.5 06:08:56 INFO - PROCESS | 1945 | 06:08:56 INFO - PROCESS | 1945 | [#3] mootools.html Cycles:180 Average:5889.34 Median:4898.41 stddev:3306.67 (67.5%) stddev-sans-first:3299.55 06:08:56 INFO - PROCESS | 1945 | Values: 1508.3 1627.2 1658.7 1913.1 2012.8 8222.6 8910.8 9028.6 9040.0 9060.0 7421.0 9058.9 9063.2 9076.6 9081.3 2520.2 2547.9 2550.3 2551.4 2551.9 2491.4 2532.6 2566.2 2567.1 2568.3 2513.5 2525.1 2567.3 2575.1 2578.9 2514.9 2549.5 2558.3 2570.4 2575.9 2506.8 2557.5 2558.1 2563.5 2571.0 8839.4 9050.7 9148.0 9218.9 9232.9 5624.7 5870.2 5870.9 5874.3 5874.9 3666.7 3722.7 3789.6 3811.7 3813.0 1030.3 1038.0 1053.4 1067.5 1089.0 12329.6 12565.5 12582.0 12592.6 12645.0 4806.4 4821.4 4821.8 4826.9 4940.8 9726.1 9729.6 9736.4 9767.5 9777.3 5628.3 5628.5 5633.8 5636.5 5676.7 4604.9 4778.8 5004.5 5103.1 5229.9 3213.7 4033.9 4103.0 4124.3 4127.1 1247.4 1252.6 1258.6 1264.6 1271.7 936.9 938.8 963.6 964.3 990.1 6112.8 6139.4 6160.7 6229.3 6269.5 424.0 477.8 489.3 944.3 1006.8 4023.2 4025.3 4049.6 4109.6 4114.1 10873.2 11353.5 11363.4 11372.8 11393.3 11116.8 11129.8 11144.6 11216.6 11268.9 6790.2 8499.3 8568.7 8613.1 8614.0 6031.9 6097.0 6140.5 6181.1 6200.3 9729.0 9831.8 9861.2 10114.2 10133.9 10305.1 10403.8 10461.5 10707.1 10711.4 6015.9 6947.3 7004.1 7895.8 8047.0 8637.7 8723.9 8747.7 8758.4 8759.9 7603.3 7665.3 7668.7 7788.9 7799.2 7445.3 7529.5 7587.0 7608.5 7673.9 7171.3 7173.2 7230.9 7237.3 7237.6 4892.6 4904.2 4996.7 4998.9 5020.4 4436.7 4550.8 4877.6 4963.1 5291.4 06:08:56 INFO - PROCESS | 1945 | 06:08:56 INFO - PROCESS | 1945 | [#4] prototype.html Cycles:180 Average:5863.52 Median:6665.33 stddev:1887.06 (28.3%) stddev-sans-first:1846.13 06:08:56 INFO - PROCESS | 1945 | Values: 332.5 337.8 340.3 346.6 348.4 6596.1 6867.0 6870.2 6873.6 6878.9 6646.9 6652.1 6656.7 6674.0 6703.5 4745.6 4901.3 4905.9 4909.9 4911.7 4882.4 4926.8 4980.6 4997.4 5049.1 4834.0 4905.7 4924.1 4931.1 4941.8 4943.6 4944.4 4963.5 4965.1 4970.0 4044.4 4129.7 4196.4 4198.2 4231.4 6290.4 6291.1 6310.6 6396.6 6425.8 5865.1 5865.9 5875.4 5881.1 5895.8 6765.1 7063.6 7068.5 7090.6 7124.1 3845.7 3845.7 4755.9 4757.0 4768.8 7135.9 7466.3 7522.4 7529.4 7555.1 4703.6 4707.6 4711.2 4720.3 4726.3 4773.6 4787.8 4800.8 4806.1 4819.6 5737.1 5755.7 5765.4 5767.0 5775.6 6831.1 7077.7 7120.4 7143.5 7166.1 1645.8 1659.2 1669.1 1672.2 1676.9 1037.9 1048.3 1064.3 1065.7 1067.7 6480.3 6652.7 6723.7 6728.8 6741.7 7295.9 7397.6 7469.3 7505.7 7535.3 6797.1 6798.9 6807.8 6822.3 6826.4 3409.7 3783.3 3911.2 3972.1 3974.2 5955.4 7814.7 7882.4 7896.3 7900.1 7707.8 7753.7 7755.7 7772.5 7797.7 6287.3 7852.0 7853.5 7855.0 7872.3 7419.8 7429.8 7433.2 7450.9 7474.9 7172.2 7330.8 7353.5 7396.4 7398.5 7803.4 7835.3 7876.3 7896.7 7897.8 4709.1 4761.5 4764.8 4766.7 4776.8 7475.2 7481.2 7484.8 7495.4 7504.8 6131.3 6776.4 7236.6 7241.4 7252.1 5826.4 7188.3 7233.5 7249.3 7255.1 7057.2 7058.9 7063.2 7068.8 7072.2 5833.9 7214.0 7219.8 7231.9 7237.0 6773.4 6830.3 7057.6 7090.8 7100.5 06:08:56 INFO - PROCESS | 1945 | 06:08:56 INFO - PROCESS | 1945 | [#5] yui.html Cycles:180 Average:18328.55 Median:50722.32 stddev:25388.59 (50.1%) stddev-sans-first:25425.21 06:08:56 INFO - PROCESS | 1945 | Values: 676.9 701.4 758.6 777.3 791.7 15205.0 15622.5 15673.4 15794.4 15864.8 12734.4 14466.5 14471.6 14488.5 14514.8 935.3 965.6 966.2 967.0 968.4 939.0 958.1 958.9 959.7 964.0 1045.4 1045.6 1047.3 1048.6 1050.2 1040.4 1040.9 1041.9 1042.3 1044.6 771.3 773.1 773.2 773.5 777.1 15675.7 15711.5 15717.0 15741.4 15802.8 12849.2 13013.6 13030.5 13077.8 13319.7 10359.9 10361.2 10463.4 10737.2 10802.2 3559.7 3569.2 3604.3 3610.3 3812.3 67125.0 78091.8 78402.2 80133.6 82215.4 9724.9 9753.4 9893.9 10265.2 10420.2 21674.3 21679.9 21680.1 21706.2 21744.7 7650.8 7683.7 7812.2 7944.8 8007.4 4173.8 4209.3 4264.9 4283.7 4336.5 3272.5 3736.6 3817.4 3817.8 3822.9 607.5 665.8 686.4 688.6 692.4 597.5 602.4 604.6 615.2 628.4 8320.3 8436.3 8510.1 8566.9 8842.5 522.6 566.4 582.8 605.4 624.2 3927.7 3928.8 4017.3 4024.5 4136.9 91752.5 93771.5 94688.0 94730.5 94803.0 68702.0 76216.2 76424.2 78887.6 79883.0 54318.9 68000.3 68787.3 70804.0 71378.6 8652.6 8750.4 8885.8 8953.8 9126.0 48344.8 49277.1 49512.0 49896.0 51548.6 67503.0 70367.6 70508.6 71030.0 71368.9 10615.5 10844.0 11061.9 11149.1 11393.9 11824.0 12005.8 12061.1 12270.9 12490.8 11496.6 11599.0 11614.8 11709.8 11791.4 11178.3 11350.4 11561.7 11638.8 12061.5 11143.2 11204.6 11320.3 11503.1 12077.5 9424.0 9732.0 9743.2 9828.0 9971.9 8760.6 9755.4 9790.2 9823.6 9863.4 06:08:56 INFO - PROCESS | 1945 | -------- Summary: end -------- 06:08:56 INFO - PROCESS | 1945 | 06:08:56 INFO - TEST-INFO | 1945: exit 0 06:08:56 INFO - TEST-OK | dromaeo_css | took 1112738ms 06:08:56 INFO - TEST-START | kraken 06:08:56 INFO - operating with platform_type : mac_ 06:08:56 INFO - Initialising browser for kraken test... 06:08:56 INFO - TEST-INFO | started process 1948 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/tmpNrzmXp/profile http://localhost:55855/getInfo.html) 06:08:58 INFO - PROCESS | 1948 | __metrics Screen width/height:1600/1200 06:08:58 INFO - PROCESS | 1948 | colorDepth:24 06:08:58 INFO - PROCESS | 1948 | Browser inner width/height: 1024/689 06:08:58 INFO - PROCESS | 1948 | __metrics 06:08:58 INFO - PROCESS | 1948 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 06:08:58 ERROR - PROCESS | 1948 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 06:08:59 INFO - TEST-INFO | 1948: exit 0 06:08:59 INFO - Browser initialized. 06:08:59 INFO - Running cycle 1/1 for kraken test... 06:08:59 INFO - TEST-INFO | started process 1951 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/tmpNrzmXp/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:09:11 INFO - PROCESS | 1951 | RSS: Main: 161968128 06:09:11 INFO - PROCESS | 1951 | 06:09:14 INFO - PROCESS | 1951 | Cycle 1(1): loaded http://localhost:55855/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55855/tests/kraken/driver.html?testName=audio-beat-detection) 06:09:14 INFO - PROCESS | 1951 | RSS: Main: 224100352 06:09:14 INFO - PROCESS | 1951 | 06:09:17 INFO - PROCESS | 1951 | Cycle 1(1): loaded http://localhost:55855/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55855/tests/kraken/driver.html?testName=audio-dft) 06:09:18 INFO - PROCESS | 1951 | RSS: Main: 241446912 06:09:18 INFO - PROCESS | 1951 | 06:09:21 INFO - PROCESS | 1951 | Cycle 1(1): loaded http://localhost:55855/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55855/tests/kraken/driver.html?testName=audio-fft) 06:09:22 INFO - PROCESS | 1951 | RSS: Main: 325935104 06:09:22 INFO - PROCESS | 1951 | 06:09:24 INFO - PROCESS | 1951 | Cycle 1(1): loaded http://localhost:55855/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55855/tests/kraken/driver.html?testName=audio-oscillator) 06:09:24 INFO - PROCESS | 1951 | RSS: Main: 231149568 06:09:24 INFO - PROCESS | 1951 | 06:09:26 INFO - PROCESS | 1951 | Cycle 1(1): loaded http://localhost:55855/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55855/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:09:27 INFO - PROCESS | 1951 | RSS: Main: 233119744 06:09:27 INFO - PROCESS | 1951 | 06:09:30 INFO - PROCESS | 1951 | Cycle 1(1): loaded http://localhost:55855/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55855/tests/kraken/driver.html?testName=imaging-darkroom) 06:09:30 INFO - PROCESS | 1951 | RSS: Main: 271716352 06:09:30 INFO - PROCESS | 1951 | 06:09:33 INFO - PROCESS | 1951 | Cycle 1(1): loaded http://localhost:55855/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55855/tests/kraken/driver.html?testName=imaging-desaturate) 06:09:34 INFO - PROCESS | 1951 | RSS: Main: 272044032 06:09:34 INFO - PROCESS | 1951 | 06:09:36 INFO - PROCESS | 1951 | Cycle 1(1): loaded http://localhost:55855/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55855/tests/kraken/driver.html?testName=json-parse-financial) 06:09:37 INFO - PROCESS | 1951 | RSS: Main: 268341248 06:09:37 INFO - PROCESS | 1951 | 06:09:39 INFO - PROCESS | 1951 | Cycle 1(1): loaded http://localhost:55855/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55855/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:09:39 INFO - PROCESS | 1951 | RSS: Main: 261234688 06:09:39 INFO - PROCESS | 1951 | 06:09:41 INFO - PROCESS | 1951 | Cycle 1(1): loaded http://localhost:55855/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55855/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:09:42 INFO - PROCESS | 1951 | RSS: Main: 268853248 06:09:42 INFO - PROCESS | 1951 | 06:09:44 INFO - PROCESS | 1951 | Cycle 1(1): loaded http://localhost:55855/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55855/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:09:44 INFO - PROCESS | 1951 | RSS: Main: 271577088 06:09:44 INFO - PROCESS | 1951 | 06:09:47 INFO - PROCESS | 1951 | Cycle 1(1): loaded http://localhost:55855/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55855/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:09:48 INFO - PROCESS | 1951 | RSS: Main: 279207936 06:09:48 INFO - PROCESS | 1951 | 06:09:51 INFO - PROCESS | 1951 | Cycle 1(1): loaded http://localhost:55855/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55855/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:09:51 INFO - PROCESS | 1951 | RSS: Main: 275378176 06:09:51 INFO - PROCESS | 1951 | 06:09:53 INFO - PROCESS | 1951 | Cycle 1(1): loaded http://localhost:55855/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55855/tests/kraken/driver.html?testName=ai-astar) 06:09:53 INFO - PROCESS | 1951 | RSS: Main: 336916480 06:09:53 INFO - PROCESS | 1951 | 06:09:53 INFO - PROCESS | 1951 | __start_tp_report 06:09:53 INFO - PROCESS | 1951 | _x_x_mozilla_page_load 06:09:53 INFO - PROCESS | 1951 | _x_x_mozilla_page_load_details 06:09:53 INFO - PROCESS | 1951 | |i|pagename|runs| 06:09:53 INFO - PROCESS | 1951 | |0;ai-astar;115;113;119;112;111;113;112;112;114;133 06:09:53 INFO - PROCESS | 1951 | |1;audio-beat-detection;160;149;130;196;144;171;158;119;167;117 06:09:53 INFO - PROCESS | 1951 | |2;audio-dft;188;185;183;188;186;185;185;186;185;184 06:09:53 INFO - PROCESS | 1951 | |3;audio-fft;69;77;73;154;53;56;56;64;130;58 06:09:53 INFO - PROCESS | 1951 | |4;audio-oscillator;91;92;143;79;77;90;125;79;77;127 06:09:53 INFO - PROCESS | 1951 | |5;imaging-gaussian-blur;90;86;88;87;89;86;91;87;89;85 06:09:53 INFO - PROCESS | 1951 | |6;imaging-darkroom;94;93;95;94;93;94;94;94;94;98 06:09:53 INFO - PROCESS | 1951 | |7;imaging-desaturate;86;83;85;83;85;83;83;82;83;101 06:09:53 INFO - PROCESS | 1951 | |8;json-parse-financial;59;61;62;62;61;63;63;79;56;56 06:09:53 INFO - PROCESS | 1951 | |9;json-stringify-tinderbox;60;62;68;73;73;68;64;66;64;67 06:09:53 INFO - PROCESS | 1951 | |10;stanford-crypto-aes;78;79;79;79;77;77;80;78;80;83 06:09:53 INFO - PROCESS | 1951 | |11;stanford-crypto-ccm;146;141;135;139;145;140;121;126;144;138 06:09:53 INFO - PROCESS | 1951 | |12;stanford-crypto-pbkdf2;201;138;201;214;213;162;158;165;160;162 06:09:53 INFO - PROCESS | 1951 | |13;stanford-crypto-sha256-iterative;67;67;65;66;64;65;67;67;65;65 06:09:53 INFO - PROCESS | 1951 | __end_tp_report 06:09:53 INFO - PROCESS | 1951 | __start_cc_report 06:09:53 INFO - PROCESS | 1951 | _x_x_mozilla_cycle_collect,1989 06:09:53 INFO - PROCESS | 1951 | __end_cc_report 06:09:53 INFO - PROCESS | 1951 | __startTimestamp1467032993774__endTimestamp 06:09:53 INFO - PROCESS | 1951 | 06:09:53 INFO - PROCESS | 1951 | ------- Summary: start ------- 06:09:53 INFO - PROCESS | 1951 | Number of tests: 14 06:09:53 INFO - PROCESS | 1951 | 06:09:53 INFO - PROCESS | 1951 | [#0] ai-astar Cycles:10 Average:115.40 Median:113.50 stddev:6.59 (5.8%) stddev-sans-first:6.98 06:09:53 INFO - PROCESS | 1951 | Values: 115.0 113.0 119.0 112.0 111.0 113.0 112.0 112.0 114.0 133.0 06:09:53 INFO - PROCESS | 1951 | 06:09:53 INFO - PROCESS | 1951 | [#1] audio-beat-detection Cycles:10 Average:151.10 Median:159.00 stddev:24.69 (15.5%) stddev-sans-first:25.97 06:09:53 INFO - PROCESS | 1951 | Values: 160.0 149.0 130.0 196.0 144.0 171.0 158.0 119.0 167.0 117.0 06:09:53 INFO - PROCESS | 1951 | 06:09:53 INFO - PROCESS | 1951 | [#2] audio-dft Cycles:10 Average:185.50 Median:185.50 stddev:1.58 (0.9%) stddev-sans-first:1.39 06:09:53 INFO - PROCESS | 1951 | Values: 188.0 185.0 183.0 188.0 186.0 185.0 185.0 186.0 185.0 184.0 06:09:53 INFO - PROCESS | 1951 | 06:09:53 INFO - PROCESS | 1951 | [#3] audio-fft Cycles:10 Average:79.00 Median:61.00 stddev:34.59 (56.7%) stddev-sans-first:36.49 06:09:53 INFO - PROCESS | 1951 | Values: 69.0 77.0 73.0 154.0 53.0 56.0 56.0 64.0 130.0 58.0 06:09:53 INFO - PROCESS | 1951 | 06:09:53 INFO - PROCESS | 1951 | [#4] audio-oscillator Cycles:10 Average:98.00 Median:79.00 stddev:24.38 (30.9%) stddev-sans-first:25.72 06:09:53 INFO - PROCESS | 1951 | Values: 91.0 92.0 143.0 79.0 77.0 90.0 125.0 79.0 77.0 127.0 06:09:53 INFO - PROCESS | 1951 | 06:09:53 INFO - PROCESS | 1951 | [#5] imaging-gaussian-blur Cycles:10 Average:87.80 Median:88.50 stddev:1.93 (2.2%) stddev-sans-first:1.88 06:09:53 INFO - PROCESS | 1951 | Values: 90.0 86.0 88.0 87.0 89.0 86.0 91.0 87.0 89.0 85.0 06:09:53 INFO - PROCESS | 1951 | 06:09:53 INFO - PROCESS | 1951 | [#6] imaging-darkroom Cycles:10 Average:94.30 Median:94.00 stddev:1.42 (1.5%) stddev-sans-first:1.50 06:09:53 INFO - PROCESS | 1951 | Values: 94.0 93.0 95.0 94.0 93.0 94.0 94.0 94.0 94.0 98.0 06:09:53 INFO - PROCESS | 1951 | 06:09:53 INFO - PROCESS | 1951 | [#7] imaging-desaturate Cycles:10 Average:85.40 Median:83.00 stddev:5.62 (6.8%) stddev-sans-first:5.96 06:09:53 INFO - PROCESS | 1951 | Values: 86.0 83.0 85.0 83.0 85.0 83.0 83.0 82.0 83.0 101.0 06:09:53 INFO - PROCESS | 1951 | 06:09:53 INFO - PROCESS | 1951 | [#8] json-parse-financial Cycles:10 Average:62.20 Median:62.00 stddev:6.44 (10.4%) stddev-sans-first:6.73 06:09:53 INFO - PROCESS | 1951 | Values: 59.0 61.0 62.0 62.0 61.0 63.0 63.0 79.0 56.0 56.0 06:09:53 INFO - PROCESS | 1951 | 06:09:53 INFO - PROCESS | 1951 | [#9] json-stringify-tinderbox Cycles:10 Average:66.50 Median:67.50 stddev:4.28 (6.3%) stddev-sans-first:3.83 06:09:53 INFO - PROCESS | 1951 | Values: 60.0 62.0 68.0 73.0 73.0 68.0 64.0 66.0 64.0 67.0 06:09:53 INFO - PROCESS | 1951 | 06:09:53 INFO - PROCESS | 1951 | [#10] stanford-crypto-aes Cycles:10 Average:79.00 Median:79.00 stddev:1.76 (2.2%) stddev-sans-first:1.83 06:09:53 INFO - PROCESS | 1951 | Values: 78.0 79.0 79.0 79.0 77.0 77.0 80.0 78.0 80.0 83.0 06:09:53 INFO - PROCESS | 1951 | 06:09:53 INFO - PROCESS | 1951 | [#11] stanford-crypto-ccm Cycles:10 Average:137.50 Median:140.50 stddev:8.18 (5.8%) stddev-sans-first:8.08 06:09:53 INFO - PROCESS | 1951 | Values: 146.0 141.0 135.0 139.0 145.0 140.0 121.0 126.0 144.0 138.0 06:09:53 INFO - PROCESS | 1951 | 06:09:53 INFO - PROCESS | 1951 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:177.40 Median:183.00 stddev:27.04 (14.8%) stddev-sans-first:27.30 06:09:53 INFO - PROCESS | 1951 | Values: 201.0 138.0 201.0 214.0 213.0 162.0 158.0 165.0 160.0 162.0 06:09:53 INFO - PROCESS | 1951 | 06:09:53 INFO - PROCESS | 1951 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.80 Median:66.50 stddev:1.14 (1.7%) stddev-sans-first:1.12 06:09:53 INFO - PROCESS | 1951 | Values: 67.0 67.0 65.0 66.0 64.0 65.0 67.0 67.0 65.0 65.0 06:09:53 INFO - PROCESS | 1951 | -------- Summary: end -------- 06:09:53 INFO - PROCESS | 1951 | 06:09:54 INFO - TEST-INFO | 1951: exit 0 06:09:54 INFO - TEST-OK | kraken | took 57838ms 06:09:54 INFO - SUITE-END | took 1170s 06:09:54 INFO - Completed test suite (00:19:30) 06:09:54 INFO - javascript benchmark 06:09:54 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3135.968640313597, 3631.818409079547, 3632.11013301741, 3632.9636703632955, 3725.813709314535, 5962.672053037081, 5985.4912332451795, 5997.164649974041, 6050.455459008688, 6074.574779765413, 5970.73131709073, 6001.129836173752, 6038.516918646509, 6040.969795151029, 6086.117512960629, 5330.973345133269, 5410.810621628244, 5465.207544905987, 5473.261109750172, 5529.225908372831, 5446.0, 5493.2034854946005, 5497.615166938316, 5499.560035197194, 5515.61390702649, 5435.972820135894, 5484.424135465779, 5493.23094766733, 5523.7790488380415, 5549.556035517169, 5486.341639003325, 5489.862753431156, 5493.093639549469, 5533.916991245134, 5598.58010649203, 4068.471098757172, 5347.41178470368, 5359.812406565751, 5410.3507579090765, 5452.454754524555, 5872.442117998826, 5918.40815918409, 5930.911036334458, 5967.1347654589845, 5992.820215393545, 6284.34014428483, 6289.867823791716, 6335.049742538656, 6340.682965851735, 6345.238571371418, 6275.560710750249, 6340.302566717657, 6424.26120996082, 6426.485881129498, 6430.16407866979, 6145.002874065946, 6158.353372895871, 6175.228096487939, 6186.041163619646, 6199.845003874939, 6546.607203567801, 6560.835979100465, 6565.507586930904, 6566.737330506822, 6581.605103693698, 6100.48145907594, 6153.753849846045, 6187.102870083812, 6205.5345849061505, 6291.339409362043, 6377.617342959437, 6391.488680905516, 6396.776112836028, 6401.615903045832, 6412.551121421456, 6243.25080990275, 6290.433860952537, 6304.275008374004, 6304.621722696653, 6316.2736285326855, 6212.72042758077, 6231.40801623845, 6275.435210831047, 6276.0, 6286.717097730521, 5102.285680004802, 5110.514501122388, 5113.897722045538, 5121.334226550524, 5124.871878203075, 4600.5169457207185, 4624.167649822997, 4636.4899861015265, 4647.18674232008, 4666.859994200179, 5977.402259774075, 6049.0, 6098.390160983955, 6101.725422356005, 6105.908411373833, 6376.553641245161, 6408.58344207625, 6417.679116044179, 6421.775237866652, 6432.0, 5952.553558483044, 6047.546434017467, 6075.726592303357, 6107.328193898667, 6126.540509461808, 5475.206095116186, 5541.722913854291, 5593.608447408724, 5599.188117722989, 5631.436856314336, 6655.267920528738, 6669.733210671713, 6680.832979175462, 6687.565308254948, 6694.564853284521, 6403.0, 6406.0, 6419.422251997343, 6430.324815894451, 6445.9033114504255, 6439.967800160969, 6462.386073323027, 6511.446527045254, 6553.0, 6638.402543771083, 6289.150964619717, 6319.715612797343, 6326.873462530815, 6328.208973878265, 6339.461145802658, 6379.425851673372, 6414.743410263537, 6433.935660643334, 6442.033694945796, 6447.290798012121, 6134.191681013941, 6200.782972595937, 6207.751689932352, 6242.781502647385, 6282.1519094921605, 6243.656598887105, 6251.343608920998, 6254.874902502015, 6257.78097766576, 6292.307846137013, 6137.570370074052, 6265.091561723616, 6275.780347687809, 6288.779892703734, 6296.0, 6168.845778855564, 6181.505479561534, 6201.317855036033, 6232.220972378453, 6284.371562843679, 6221.160143380585, 6225.31521532622, 6247.3440288769025, 6248.968755156195, 6293.118963345044], "value": 5917.051868555508, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [509.80882169186555, 518.0597216052864, 571.8770464350164, 598.0043228025338, 602.4939051196993, 28799.856000719992, 33295.00114996551, 40102.79691609253, 40558.59441405585, 40704.77885663427, 44370.55629443705, 44816.0, 44817.32774008392, 44841.65475035746, 44845.327320090226, 9788.951055244714, 10002.749931251741, 10004.19966402686, 10011.849822252672, 10024.54889529973, 9828.410295382264, 9940.453275069869, 9989.400635961865, 9993.500324983757, 9996.550155242996, 10132.392056476636, 10188.083072523472, 10206.948965255164, 10214.336068155546, 10219.335743176707, 8660.0, 10137.39175649456, 10144.340617859816, 10144.492775361203, 10149.035841595074, 9751.21990240779, 9843.655472058515, 9858.852117218248, 9862.40825550462, 9869.407835529892, 42224.366634500504, 42768.144637107085, 42825.78587107076, 42833.92915177145, 42858.78570607158, 3223.09753269085, 3354.4297469430257, 3408.062782734743, 3496.527968724215, 3808.8857334279737, 24630.753692463026, 28522.714772852214, 30118.698813011808, 30218.0, 31407.37185256282, 2751.931201719953, 2826.279298778819, 2833.546632538784, 2843.516602177635, 2886.2495751104652, 409100.0, 409315.0, 411035.0, 411184.0, 411814.0, 38830.0, 39486.80256598699, 70019.0, 70681.58636827234, 70695.9395609056, 38881.0, 38988.41517377242, 39069.218615628095, 39089.80455097706, 39636.40545391821, 16174.27215775293, 16355.672886542203, 16357.754633680504, 16370.427035053715, 16379.508614741577, 13581.592552223448, 13642.590722278348, 13646.044776865525, 13689.520866769815, 13690.726185476235, 8749.387542871938, 8857.202851743374, 8936.41913275635, 8946.463212207158, 8999.910000899907, 3581.6239294873662, 3630.1650620357464, 3643.5809881863397, 3648.8540458381367, 3661.8718344857803, 959.9616015359308, 1024.2369434771142, 1061.3950048472298, 1067.2976602319288, 1127.1827924754487, 31807.84096079505, 32687.34625307528, 32744.67255327464, 33311.46889286386, 33491.0, 1135.0975974100609, 1168.6735555144971, 1217.0567809947186, 1231.5197073141483, 1266.2149467330314, 15515.922420387826, 15594.688106238038, 15677.529674109795, 15901.761473577906, 15919.204039798195, 638728.0, 639376.0, 647584.0, 648797.0, 649563.0, 63845.361546383945, 64042.359576403636, 64127.679361602895, 64189.67905160444, 64297.67851160808, 1414.1373762005169, 1448.5509492057497, 1457.890658200639, 1496.5061529695174, 1593.768903509008, 30698.846505767327, 30902.690973089982, 31338.68661313449, 31926.201844954063, 32159.0, 54918.17622735582, 55439.72280138735, 56714.0, 57030.7148464255, 57143.857122856476, 474332.0, 479363.0, 487344.0, 488220.0, 488355.0, 38309.808450957564, 44218.89452763578, 45150.32274515819, 46049.76975115103, 49512.0, 48972.77568060827, 49169.0, 49984.75007624939, 50391.74804125956, 51234.0, 39212.60787392204, 39569.208615826945, 41325.79337103295, 41399.37900931428, 41683.7915810419, 39322.0, 39761.2047759049, 39809.20381592294, 39989.80005099956, 40373.0, 38785.61214387933, 39537.406938895365, 39718.80140599279, 40944.59055409408, 41145.97135071647, 34743.65256347404, 34795.82602086973, 35744.82127589345, 35774.284514309045, 37492.81253593715, 25931.0, 26603.0, 26644.733552664224, 26789.062382816508, 26815.597766033134], "value": 19617.01628638098, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [387.21202353211214, 412.95934245700835, 414.952280487744, 419.37722482114054, 426.6373582454914, 15660.765088523682, 20902.581948361025, 21323.0, 21529.46176345592, 21665.458363540918, 15387.461438849643, 16306.510804675878, 20997.47506312343, 21430.571388572218, 21462.89268553655, 5329.680219186852, 5682.147677848335, 5684.346300175471, 5689.089745640698, 5694.117411801178, 5581.10702287632, 5660.915086273709, 5661.179129026289, 5665.3768085510565, 5668.914966275509, 5924.940750592504, 6028.638281703112, 6171.413715697002, 6250.624962502242, 6258.061290806393, 5762.366139724627, 6183.165272688175, 6192.876142477147, 6211.503079753654, 6227.626342419447, 5334.626576139672, 5455.1271796512365, 5498.285222921035, 5508.14623733322, 5508.4491550845, 14620.780688289684, 14672.339744711513, 17607.911960440117, 27886.721132788818, 27950.881964721386, 2388.1402695029774, 2438.8414753041175, 2669.759721625063, 2682.852443115628, 2974.866131024109, 10393.324433911846, 10526.42104684242, 10584.629537966212, 10928.890711092867, 11009.119270458425, 1733.5926057376507, 1785.61609254011, 1916.0898573177628, 1920.3758778397078, 1933.690609502487, 121536.0, 124987.0, 126712.0, 127375.0, 127609.64112909278, 10019.899801001897, 11780.469878855301, 12042.277463352228, 12072.215306005082, 12077.214981026205, 16148.111853847917, 16226.675466490604, 16246.918765406097, 16283.104429256267, 16300.592485187728, 9115.134062264207, 9234.49210293427, 9248.907510924939, 9287.860682089775, 9369.0, 9258.537073146315, 9269.90730092704, 9270.44377337362, 9341.439513629068, 9344.859827102599, 4864.416270047617, 4975.701457912464, 4980.402351717745, 4983.352164218701, 5057.089723849669, 1996.6106609211065, 2057.2902348689677, 2062.3091264426585, 2062.5462398272357, 2063.494443861264, 888.8933328000552, 957.4398976598768, 964.4840010594298, 971.3928794503436, 981.6367943860818, 20837.0, 21819.01814418355, 21969.340919772432, 22065.227717029826, 22095.226667066574, 974.2595627323144, 984.8128855517572, 1011.6408674920444, 1016.5120742043861, 1058.4072919165292, 8956.596953137125, 9425.245980321557, 11090.334579925231, 11569.652910412533, 11610.419479026015, 625909.0, 628700.0, 637557.0, 637683.0, 642576.7871160707, 124917.37541312235, 128186.0, 128335.0, 128608.0, 136541.0, 929.2101713543569, 984.9901500985042, 998.9411224102474, 1019.8521214423866, 1025.29254814178, 19283.93938333405, 19309.324173653855, 19381.61236775285, 19408.902955485133, 19527.804721952598, 37668.62331376761, 42571.36142957796, 42944.0, 43443.782781085894, 55388.44611553994, 68617.65691171512, 69335.65332173307, 70578.0, 74663.0, 75931.0, 7783.299503044753, 8078.434509584273, 8241.95879020625, 8481.36389770782, 8575.31397488212, 12518.499260029861, 12745.235285882876, 12956.546520871725, 13031.413586388446, 13173.670658233621, 11113.0, 11153.944230279121, 11177.993980541465, 11490.310581365145, 11634.95285424282, 11043.668689939315, 11199.10407167441, 11286.435678215892, 11296.661100167008, 11476.885231147582, 11524.481398336928, 11675.241109328206, 11742.765144697229, 11970.880291196976, 12117.212381195193, 8464.068952415353, 8571.0, 8573.785655358666, 8615.827683446421, 8719.825603488021, 8686.565671716262, 10027.097561219234, 11316.321020738782, 11603.245789023686, 11858.466369013242], "value": 9731.879277939035, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1508.3287936868098, 1627.1620115640444, 1658.6765580711763, 1913.0817207740283, 2012.8188463038332, 8222.58887055647, 8910.821783564334, 9028.593713282902, 9040.0, 9059.954700226497, 7420.96289518553, 9058.864117038233, 9063.229625481825, 9076.63693452261, 9081.318901082412, 2520.193538067819, 2547.885345159463, 2550.311415917701, 2551.4386834896295, 2551.8596477193746, 2491.377155711072, 2532.556802559554, 2566.217303722364, 2567.063021996967, 2568.306557229547, 2513.522430738163, 2525.053105085593, 2567.281161274846, 2575.072973729456, 2578.948421031578, 2514.924552263435, 2549.464612431382, 2558.2836805694437, 2570.4216551276, 2575.9227223183334, 2506.7994560435122, 2557.4885022995477, 2558.0790915270486, 2563.474487730011, 2570.961435578468, 8839.381243312971, 9050.683226087056, 9148.039455857172, 9218.907810921872, 9232.861507077332, 5624.746886390122, 5870.20752198452, 5870.853228669274, 5874.265716785402, 5874.941250587525, 3666.6699997000132, 3722.7021838252876, 3789.5831458539537, 3811.6760075393627, 3813.0086177594026, 1030.2685093583564, 1038.0, 1053.3627155570846, 1067.4662668665667, 1089.0307626212677, 12329.630111096682, 12565.497380104785, 12582.0, 12592.559260425842, 12644.988400927996, 4806.351142595775, 4821.432140216215, 4821.807127714922, 4826.8793280168275, 4940.802367905316, 9726.076022777825, 9729.610815567297, 9736.41581505112, 9767.51162441875, 9777.266704997153, 5628.324601047901, 5628.549716022709, 5633.802816901471, 5636.492715655529, 5676.68778217202, 4604.884877878013, 4778.808847646124, 5004.549590536869, 5103.055934652101, 5229.921551176735, 3213.7268332192025, 4033.858814941463, 4102.958970410317, 4124.319487284564, 4127.050778321003, 1247.4324182496941, 1252.6179515247936, 1258.6098309524077, 1264.5574049082932, 1271.650296168561, 936.948467834262, 938.8450905600636, 963.6097380560884, 964.3249725192394, 990.0940639314946, 6112.847178820565, 6139.386061393825, 6160.722767475474, 6229.314775374705, 6269.498440124779, 423.9745615263094, 477.7578296429256, 489.3149590573155, 944.3483996042709, 1006.7634105985234, 4023.2154729827403, 4025.295573274665, 4049.595040495986, 4109.56849530795, 4114.115465175002, 10873.184511161695, 11353.54585816558, 11363.37501437429, 11372.829407558893, 11393.259438136494, 11116.777664446827, 11129.833052504218, 11144.554217831195, 11216.607418740305, 11268.887311126948, 6790.219124800711, 8499.320054395634, 8568.657253709782, 8613.052564217931, 8613.956930215434, 6031.939680603314, 6097.024476083805, 6140.5394595406415, 6181.072839074175, 6200.255969283535, 9728.978457261886, 9831.754206144618, 9861.161801246973, 10114.241431892784, 10133.949330253301, 10305.124064454305, 10403.791924161626, 10461.476926153815, 10707.089897358812, 10711.357318560911, 6015.87968240624, 6947.305269473214, 7004.124484439445, 7895.84208315842, 8047.0, 8637.654493820428, 8723.91276087231, 8747.650093996423, 8758.386912916034, 8759.868601970848, 7603.315701586884, 7665.3101220890385, 7668.693252269847, 7788.88316675239, 7799.220077992155, 7445.255474452511, 7529.472936894584, 7587.0, 7608.543487390774, 7673.923260767321, 7171.282871712787, 7173.24680908518, 7230.891536626849, 7237.312455316736, 7237.63811809418, 4892.608591312615, 4904.215325547895, 4996.7001979881325, 4998.850034498971, 5020.397552293748, 4436.713353127686, 4550.7712917512745, 4877.609791216765, 4963.057019166346, 5291.365036195682], "value": 4709.159628110387, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [332.54109329125805, 337.8310844577711, 340.2697284309288, 346.62564430415154, 348.4024897301128, 6596.076549283104, 6867.0, 6870.209925858521, 6873.621950792704, 6878.9312106878915, 6646.867062658744, 6652.135222421079, 6656.6671666416605, 6674.0, 6703.463722902168, 4745.59662428694, 4901.289313049606, 4905.852824415273, 4909.926351104737, 4911.729854857981, 4882.41411030675, 4926.778294976734, 4980.576650984653, 4997.4003119625695, 5049.091163590552, 4834.0, 4905.705657660552, 4924.138275801738, 4931.137051016076, 4941.777620007108, 4943.579795717368, 4944.406671199461, 4963.528464795839, 4965.131102057126, 4969.9751501242445, 4044.373122166069, 4129.710920235585, 4196.3705444183615, 4198.223328684203, 4231.449911511515, 6290.3709629037185, 6291.1192433059405, 6310.5898116622275, 6396.584222025554, 6425.811224923357, 5865.120231965197, 5865.912011319833, 5875.412458754133, 5881.14723365114, 5895.823125306205, 6765.05289259504, 7063.646817659096, 7068.505204635678, 7090.610016449094, 7124.073870396815, 3845.65389114981, 3845.7115716321387, 4755.9286610700865, 4756.976215118937, 4768.785404656799, 7135.928640713579, 7466.328030477337, 7522.360599349062, 7529.435292353095, 7555.093388793325, 4703.553162449562, 4707.646926480527, 4711.246200607886, 4720.268358404453, 4726.314684370747, 4773.570378665937, 4787.808487660524, 4800.783964721596, 4806.062817750505, 4819.59033482151, 5737.139429085671, 5755.740991655385, 5765.3946335634155, 5767.0, 5775.566832487496, 6831.146106736658, 7077.716891324392, 7120.394766444911, 7143.4999550031, 7166.068411106627, 1645.8189599144084, 1659.1952902842113, 1669.1070277401532, 1672.1555614414642, 1676.8993860368416, 1037.870266216723, 1048.2662136504478, 1064.3188359449957, 1065.7158124460007, 1067.6903697927514, 6480.31956644555, 6652.70062847173, 6723.731050758012, 6728.764493242811, 6741.696623651947, 7295.89056164158, 7397.593132377663, 7469.290417410337, 7505.737299194502, 7535.284148006041, 6797.082393876863, 6798.864022719518, 6807.795766127024, 6822.317768223138, 6826.385625293748, 3409.6760807723226, 3783.2622638585212, 3911.1786524830104, 3972.1261322509004, 3974.205158968218, 5955.37468565803, 7814.726484573012, 7882.369410447265, 7896.328812050925, 7900.051993760785, 7707.768766936889, 7753.728619498291, 7755.650995705207, 7772.494787838772, 7797.688092476237, 6287.308396076428, 7851.960740196262, 7853.450258481851, 7854.978852749106, 7872.33085187754, 7419.777406677808, 7429.777106686808, 7433.182349941394, 7450.8882366763455, 7474.850502990019, 7172.246914074156, 7330.780076597711, 7353.522021068614, 7396.445266605134, 7398.482106252511, 7803.414743894345, 7835.294823465915, 7876.251756083163, 7896.68413263486, 7897.802554936173, 4709.128811169944, 4761.500042495627, 4764.809407623657, 4766.666333356632, 4776.785044672929, 7475.2151024141685, 7481.17707052213, 7484.812879677834, 7495.362894154058, 7504.774856754306, 6131.264248290234, 6776.424003959719, 7236.638168091469, 7241.4206863449745, 7252.093488313961, 5826.388229235869, 7188.28117188277, 7233.457490688114, 7249.275072492708, 7255.129384473897, 7057.2237053925055, 7058.858822823412, 7063.223045464892, 7068.752593659197, 7072.186698529529, 5833.883322333445, 7213.963930180315, 7219.772638651547, 7231.8553628928175, 7237.023001894677, 6773.390394864486, 6830.282820303796, 7057.588482303458, 7090.822729431806, 7100.538464999759], "value": 5232.975839397033, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [676.8747781660393, 701.3512500936632, 758.6017340896029, 777.2577188784711, 791.6556298010364, 15205.011674241194, 15622.531324060283, 15673.373065077398, 15794.368225270975, 15864.841351586481, 12734.426950787214, 14466.493672721457, 14471.638209044779, 14488.492902748407, 14514.782278265835, 935.303199116659, 965.6330594374128, 966.1980556138424, 966.9661561845337, 968.3802366485455, 939.0421769794805, 958.1185309515263, 958.8897276813151, 959.6545243712258, 963.9807203855919, 1045.3623289793259, 1045.6497073480393, 1047.287844265899, 1048.5805677728931, 1050.1703654113242, 1040.3653771199563, 1040.8646875906122, 1041.9374837509774, 1042.3224903812545, 1044.597829835515, 771.3019717155983, 773.1186447449911, 773.234497847133, 773.4856320546829, 777.1218523068952, 15675.686486270211, 15711.528654140395, 15717.0, 15741.449049283334, 15802.841971580252, 12849.164804287691, 13013.60959171217, 13030.478780848754, 13077.803832942513, 13319.667008324772, 10359.896401035969, 10361.222908281834, 10463.424511651856, 10737.24839261252, 10802.243842930999, 3559.697425718817, 3569.1790888095625, 3604.3499742974172, 3610.277944411102, 3812.3137835189655, 67125.0, 78091.82862257071, 78402.21597784063, 80133.59933200413, 82215.42276617917, 9724.854127188099, 9753.414795112316, 9893.851592226123, 10265.178785697126, 10420.218483613759, 21674.34976950694, 21679.891600541898, 21680.132794688037, 21706.240281590384, 21744.673829892563, 7650.770476885702, 7683.6926522939575, 7812.218778122256, 7944.761657150295, 8007.359411247086, 4173.791310434466, 4209.305464598368, 4264.936025959551, 4283.678724095706, 4336.50130235027, 3272.4927636216426, 3736.5516138063062, 3817.3701339279264, 3817.809109544567, 3822.9235415292096, 607.471499795181, 665.7769647168253, 686.3513979289623, 688.6281408039703, 692.4252870117891, 597.5130268830889, 602.4246844263718, 604.597942368329, 615.1725928625991, 628.4281304013326, 8320.292775114061, 8436.282915952213, 8510.106438823834, 8566.91433085661, 8842.46945183291, 522.6368319861703, 566.3996164066103, 582.790195529609, 605.449041372349, 624.1979056911847, 3927.7250592458254, 3928.783916884599, 4017.276890159741, 4024.4969378827645, 4136.896577585584, 91752.5412372934, 93771.53114234385, 94688.0, 94730.52634736782, 94803.0, 68702.0, 76216.23783762203, 76424.23575764282, 78887.60556197182, 79883.0, 54318.91362172734, 68000.3199967994, 68787.31212687909, 70804.0, 71378.64310678413, 8652.610632521426, 8750.431221970552, 8885.777855553662, 8953.776155596162, 9126.0, 48344.75827620839, 49277.07229277187, 49512.0, 49896.0, 51548.64933779292, 67503.0, 70367.64816175886, 70508.64745676238, 71030.0, 71368.92946605702, 10615.522301496605, 10844.024037836632, 11061.949114834079, 11149.108071354434, 11393.886061139283, 11824.0, 12005.75988480243, 12061.095417843522, 12270.938645306716, 12490.75018499643, 11496.597619083292, 11599.014083802971, 11614.825777613512, 11709.765804683688, 11791.410429478321, 11178.329300242012, 11350.432478375884, 11561.653150405502, 11638.836116388293, 12061.457234424297, 11143.2199746017, 11204.551817927191, 11320.320780753182, 11503.137264705349, 12077.456514457046, 9424.0, 9731.951340243253, 9743.171830394496, 9827.950860245654, 9971.900280997097, 8760.60577274037, 9755.365901216399, 9790.216782657228, 9823.557939892866, 9863.358881672668], "value": 7114.590505256006, "unit": "score"}], "name": "dromaeo_css", "value": 7634.876813099586, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 113.0, 119.0, 112.0, 111.0, 113.0, 112.0, 112.0, 114.0, 133.0], "value": 115.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 149.0, 130.0, 196.0, 144.0, 171.0, 158.0, 119.0, 167.0, 117.0], "value": 151.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [188.0, 185.0, 183.0, 188.0, 186.0, 185.0, 185.0, 186.0, 185.0, 184.0], "value": 185.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 77.0, 73.0, 154.0, 53.0, 56.0, 56.0, 64.0, 130.0, 58.0], "value": 79.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 92.0, 143.0, 79.0, 77.0, 90.0, 125.0, 79.0, 77.0, 127.0], "value": 98.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 86.0, 88.0, 87.0, 89.0, 86.0, 91.0, 87.0, 89.0, 85.0], "value": 87.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 93.0, 95.0, 94.0, 93.0, 94.0, 94.0, 94.0, 94.0, 98.0], "value": 94.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 83.0, 85.0, 83.0, 85.0, 83.0, 83.0, 82.0, 83.0, 101.0], "value": 85.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 61.0, 62.0, 62.0, 61.0, 63.0, 63.0, 79.0, 56.0, 56.0], "value": 62.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 62.0, 68.0, 73.0, 73.0, 68.0, 64.0, 66.0, 64.0, 67.0], "value": 66.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 79.0, 79.0, 79.0, 77.0, 77.0, 80.0, 78.0, 80.0, 83.0], "value": 79.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 141.0, 135.0, 139.0, 145.0, 140.0, 121.0, 126.0, 144.0, 138.0], "value": 137.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [201.0, 138.0, 201.0, 214.0, 213.0, 162.0, 158.0, 165.0, 160.0, 162.0], "value": 177.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 65.0, 66.0, 64.0, 65.0, 67.0, 67.0, 65.0, 65.0], "value": 65.8, "unit": "score"}], "name": "kraken", "value": 1484.8999999999999, "alertThreshold": 2.0}]} 06:09:55 INFO - Return code: 0 06:09:55 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 06:09:55 ERROR - # TBPL SUCCESS # 06:09:55 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 06:09:55 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 06:09:55 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 06:09:55 INFO - 2016-06-27 06:09:55.097 screenresolution[1955:21755] starting screenresolution argv=screenresolution get 06:09:55 INFO - 2016-06-27 06:09:55.100 screenresolution[1955:21755] Display 0: 1600x1200x32@60 06:09:55 INFO - 2016-06-27 06:09:55.106 screenresolution[1956:21759] starting screenresolution argv=screenresolution list 06:09:55 INFO - Available Modes on Display 0 06:09:55 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 06:09:55 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 06:09:55 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 06:09:55 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 06:09:55 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 06:09:55 INFO - Intel Iris: 06:09:55 INFO - Chipset Model: Intel Iris 06:09:55 INFO - Type: GPU 06:09:55 INFO - Bus: Built-In 06:09:55 INFO - VRAM (Dynamic, Max): 1536 MB 06:09:55 INFO - Vendor: Intel (0x8086) 06:09:55 INFO - Device ID: 0x0a2e 06:09:55 INFO - Revision ID: 0x0009 06:09:55 INFO - Displays: 06:09:55 INFO - Display: 06:09:55 INFO - Resolution: 1600 x 1200 @ 60 Hz 06:09:55 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 06:09:55 INFO - Display Serial Number: 1600x1200 60 06:09:55 INFO - Main Display: Yes 06:09:55 INFO - Mirror: Off 06:09:55 INFO - Online: Yes 06:09:55 INFO - Rotation: Supported 06:09:55 INFO - Return code: 0 06:09:55 INFO - Running post-action listener: _resource_record_post_action 06:09:55 INFO - Running post-run listener: _resource_record_post_run 06:09:56 INFO - Total resource usage - Wall time: 1195s; CPU: 52.0%; Read bytes: 397312; Write bytes: 495036416; Read time: 5; Write time: 1876 06:09:56 INFO - install - Wall time: 23s; CPU: 54.0%; Read bytes: 186900992; Write bytes: 184758272; Read time: 17567; Write time: 363 06:09:56 INFO - run-tests - Wall time: 1173s; CPU: 52.0%; Read bytes: 397312; Write bytes: 298222080; Read time: 5; Write time: 1442 06:09:56 INFO - Running post-run listener: _upload_blobber_files 06:09:56 INFO - Blob upload gear active. 06:09:56 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:09:56 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 06:09:56 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'] 06:09:56 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 06:09:56 INFO - (blobuploader) - INFO - Open directory for files ... 06:09:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:09:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:09:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:09:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:09:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:09:57 INFO - (blobuploader) - INFO - Done attempting. 06:09:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 06:09:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:09:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:09:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:09:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:09:58 INFO - (blobuploader) - INFO - Done attempting. 06:09:58 INFO - (blobuploader) - INFO - Iteration through files over. 06:09:58 INFO - Return code: 0 06:09:58 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:09:58 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:09:58 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/71935995ce6184e1c5505b5547a62173a02b47297c6ba94fafe341214172256b76350f616d1f5056350c9f79fce8681baf3ee2ed6ed8302b444480d04b9971e7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/55e4f2a4efc58bea41d6fddc454c180771394d7d5faa90241e1b48997e79c4e107b9a7571837cc79169aa59ef97340d437695367611e7176fa7ab5685f4172a1"} 06:09:58 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:09:58 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:09:58 INFO - Contents: 06:09:58 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/71935995ce6184e1c5505b5547a62173a02b47297c6ba94fafe341214172256b76350f616d1f5056350c9f79fce8681baf3ee2ed6ed8302b444480d04b9971e7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/55e4f2a4efc58bea41d6fddc454c180771394d7d5faa90241e1b48997e79c4e107b9a7571837cc79169aa59ef97340d437695367611e7176fa7ab5685f4172a1"} 06:09:58 INFO - Running post-run listener: copy_logs_to_upload_dir 06:09:58 INFO - Copying logs to upload dir... 06:09:58 INFO - mkdir: /builds/slave/test/build/upload/logs 06:09:58 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1279.924078 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 19 secs) (at 2016-06-27 06:09:58.978204) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-27 06:09:58.981495) ========= 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.y36R0E9T3F/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.YR2tEHnXOg/Listeners TMPDIR=/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/71935995ce6184e1c5505b5547a62173a02b47297c6ba94fafe341214172256b76350f616d1f5056350c9f79fce8681baf3ee2ed6ed8302b444480d04b9971e7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/55e4f2a4efc58bea41d6fddc454c180771394d7d5faa90241e1b48997e79c4e107b9a7571837cc79169aa59ef97340d437695367611e7176fa7ab5685f4172a1"} build_url:https://queue.taskcluster.net/v1/task/HNf6UujUQ5mnMECPR4aaTg/artifacts/public/build/firefox-48.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010953 build_url: 'https://queue.taskcluster.net/v1/task/HNf6UujUQ5mnMECPR4aaTg/artifacts/public/build/firefox-48.0.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/71935995ce6184e1c5505b5547a62173a02b47297c6ba94fafe341214172256b76350f616d1f5056350c9f79fce8681baf3ee2ed6ed8302b444480d04b9971e7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/55e4f2a4efc58bea41d6fddc454c180771394d7d5faa90241e1b48997e79c4e107b9a7571837cc79169aa59ef97340d437695367611e7176fa7ab5685f4172a1"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-27 06:09:59.014627) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 06:09:59.014955) ========= 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.y36R0E9T3F/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.YR2tEHnXOg/Listeners TMPDIR=/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/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.005178 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 06:09:59.065662) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-27 06:09:59.066148) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-27 06:09:59.066510) ========= ========= Total master_lag: 0.18 =========