builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0382 starttime: 1468228302.9 results: success (0) buildid: 20160711002426 builduid: dc082868e971485687f91975c5c4a044 revision: e0770c0fbc7b7bbcb6be3d4d063f3d4a0ffdb7a2 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-11 02:11:42.903683) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-11 02:11:42.904359) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-11 02:11:42.904770) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-11 02:11:43.071292) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-11 02:11:43.071724) ========= 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.lNKEEBfguE/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.BYspLJTwOg/Listeners TMPDIR=/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-07-11 02:11:43-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 66.9M=0s 2016-07-11 02:11:43 (66.9 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.498863 ========= master_lag: 0.08 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-11 02:11:43.650285) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-11 02:11:43.650688) ========= 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.lNKEEBfguE/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.BYspLJTwOg/Listeners TMPDIR=/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/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.040733 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-11 02:11:43.715635) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-11 02:11:43.716033) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev e0770c0fbc7b7bbcb6be3d4d063f3d4a0ffdb7a2 --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 e0770c0fbc7b7bbcb6be3d4d063f3d4a0ffdb7a2 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.lNKEEBfguE/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.BYspLJTwOg/Listeners TMPDIR=/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-07-11 02:11:43,797 truncating revision to first 12 chars 2016-07-11 02:11:43,797 Setting DEBUG logging. 2016-07-11 02:11:43,797 attempt 1/10 2016-07-11 02:11:43,797 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/e0770c0fbc7b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-11 02:11:44,930 unpacking tar archive at: mozilla-beta-e0770c0fbc7b/testing/mozharness/ program finished with exit code 0 elapsedTime=1.418171 ========= master_lag: 0.49 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-11 02:11:45.619511) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-11 02:11:45.619792) ========= script_repo_revision: e0770c0fbc7b7bbcb6be3d4d063f3d4a0ffdb7a2 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-11 02:11:45.620719) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-11 02:11:45.620992) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-11 02:11:45.683465) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 28 secs) (at 2016-07-11 02:11:45.683763) ========= /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.lNKEEBfguE/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.BYspLJTwOg/Listeners TMPDIR=/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 02:11:45 INFO - MultiFileLogger online at 20160711 02:11:45 in /builds/slave/test 02:11:45 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 02:11:45 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:11:45 INFO - {'append_to_log': False, 02:11:45 INFO - 'base_work_dir': '/builds/slave/test', 02:11:45 INFO - 'blob_upload_branch': 'Mozilla-Beta', 02:11:45 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:11:45 INFO - 'branch': 'Mozilla-Beta', 02:11:45 INFO - 'buildbot_json_path': 'buildprops.json', 02:11:45 INFO - 'config_files': ('talos/mac_config.py',), 02:11:45 INFO - 'default_actions': ('clobber', 02:11:45 INFO - 'read-buildbot-config', 02:11:45 INFO - 'download-and-extract', 02:11:45 INFO - 'populate-webroot', 02:11:45 INFO - 'create-virtualenv', 02:11:45 INFO - 'install', 02:11:45 INFO - 'run-tests'), 02:11:45 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:11:45 INFO - 'download_minidump_stackwalk': True, 02:11:45 INFO - 'download_symbols': 'ondemand', 02:11:45 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:11:45 INFO - 'tooltool.py': '/tools/tooltool.py', 02:11:45 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:11:45 INFO - '/tools/misc-python/virtualenv.py')}, 02:11:45 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:11:45 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:11:45 INFO - 'installer_path': 'installer.exe', 02:11:45 INFO - 'log_level': 'info', 02:11:45 INFO - 'log_name': 'talos', 02:11:45 INFO - 'log_to_console': True, 02:11:45 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 02:11:45 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 02:11:45 INFO - 'opt_config_files': (), 02:11:45 INFO - 'pip_index': False, 02:11:45 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:11:45 INFO - 'cmd': ('bash', 02:11:45 INFO - '-c', 02:11:45 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:11:45 INFO - 'enabled': True, 02:11:45 INFO - 'halt_on_failure': False, 02:11:45 INFO - 'name': 'check_screen_resolution'},), 02:11:45 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:11:45 INFO - 'cmd': ('bash', 02:11:45 INFO - '-c', 02:11:45 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:11:45 INFO - 'enabled': True, 02:11:45 INFO - 'halt_on_failure': False, 02:11:45 INFO - 'name': 'check_screen_resolution'},), 02:11:45 INFO - 'run_cmd_checks_enabled': True, 02:11:45 INFO - 'sps_profile': False, 02:11:45 INFO - 'sps_profile_interval': 0, 02:11:45 INFO - 'suite': 'dromaeojs', 02:11:45 INFO - 'system_bits': '32', 02:11:45 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:11:45 INFO - 'title': 't-yosemite-r7-0382', 02:11:45 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:11:45 INFO - 'use_talos_json': True, 02:11:45 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:11:45 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:11:45 INFO - 'work_dir': 'build'} 02:11:45 INFO - ##### 02:11:45 INFO - ##### Running clobber step. 02:11:45 INFO - ##### 02:11:45 INFO - Running pre-action listener: _resource_record_pre_action 02:11:45 INFO - Running main action method: clobber 02:11:45 INFO - rmtree: /builds/slave/test/build 02:11:45 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:11:47 INFO - Running post-action listener: _resource_record_post_action 02:11:47 INFO - ##### 02:11:47 INFO - ##### Running read-buildbot-config step. 02:11:47 INFO - ##### 02:11:47 INFO - Running pre-action listener: _resource_record_pre_action 02:11:47 INFO - Running main action method: read_buildbot_config 02:11:47 INFO - Using buildbot properties: 02:11:47 INFO - { 02:11:47 INFO - "project": "", 02:11:47 INFO - "product": "firefox", 02:11:47 INFO - "script_repo_revision": "production", 02:11:47 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 02:11:47 INFO - "repository": "", 02:11:47 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 02:11:47 INFO - "buildid": "20160711002426", 02:11:47 INFO - "pgo_build": "False", 02:11:47 INFO - "basedir": "/builds/slave/test", 02:11:47 INFO - "buildnumber": 32, 02:11:47 INFO - "slavename": "t-yosemite-r7-0382", 02:11:47 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 02:11:47 INFO - "platform": "yosemite_r7", 02:11:47 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 02:11:47 INFO - "branch": "mozilla-beta", 02:11:47 INFO - "repo_path": "releases/mozilla-beta", 02:11:47 INFO - "revision": "e0770c0fbc7b7bbcb6be3d4d063f3d4a0ffdb7a2", 02:11:47 INFO - "stage_platform": "macosx64", 02:11:47 INFO - "builduid": "dc082868e971485687f91975c5c4a044", 02:11:47 INFO - "slavebuilddir": "test" 02:11:47 INFO - } 02:11:47 INFO - Found installer url https://queue.taskcluster.net/v1/task/MsYJ-h_TQfKhwJ0FdpDiJA/artifacts/public/build/firefox-48.0.en-US.mac.dmg. 02:11:47 INFO - Running post-action listener: _resource_record_post_action 02:11:47 INFO - ##### 02:11:47 INFO - ##### Running download-and-extract step. 02:11:47 INFO - ##### 02:11:47 INFO - Running pre-action listener: _resource_record_pre_action 02:11:47 INFO - Running main action method: download_and_extract 02:11:47 INFO - mkdir: /builds/slave/test/build/tests 02:11:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:11:47 INFO - https://queue.taskcluster.net/v1/task/MsYJ-h_TQfKhwJ0FdpDiJA/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json matches https://queue.taskcluster.net 02:11:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MsYJ-h_TQfKhwJ0FdpDiJA/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json 02:11:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MsYJ-h_TQfKhwJ0FdpDiJA/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json 02:11:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MsYJ-h_TQfKhwJ0FdpDiJA/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 02:11:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MsYJ-h_TQfKhwJ0FdpDiJA/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 02:11:48 INFO - Downloaded 1165 bytes. 02:11:48 INFO - Reading from file /builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json 02:11:48 INFO - Using the following test package requirements: 02:11:48 INFO - {u'common': [u'firefox-48.0.en-US.mac.common.tests.zip'], 02:11:48 INFO - u'cppunittest': [u'firefox-48.0.en-US.mac.common.tests.zip', 02:11:48 INFO - u'firefox-48.0.en-US.mac.cppunittest.tests.zip'], 02:11:48 INFO - u'gtest': [u'firefox-48.0.en-US.mac.common.tests.zip', 02:11:48 INFO - u'firefox-48.0.en-US.mac.gtest.tests.zip'], 02:11:48 INFO - u'jittest': [u'firefox-48.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 02:11:48 INFO - u'mochitest': [u'firefox-48.0.en-US.mac.common.tests.zip', 02:11:48 INFO - u'firefox-48.0.en-US.mac.mochitest.tests.zip'], 02:11:48 INFO - u'mozbase': [u'firefox-48.0.en-US.mac.common.tests.zip'], 02:11:48 INFO - u'reftest': [u'firefox-48.0.en-US.mac.common.tests.zip', 02:11:48 INFO - u'firefox-48.0.en-US.mac.reftest.tests.zip'], 02:11:48 INFO - u'talos': [u'firefox-48.0.en-US.mac.common.tests.zip', 02:11:48 INFO - u'firefox-48.0.en-US.mac.talos.tests.zip'], 02:11:48 INFO - u'web-platform': [u'firefox-48.0.en-US.mac.common.tests.zip', 02:11:48 INFO - u'firefox-48.0.en-US.mac.web-platform.tests.zip'], 02:11:48 INFO - u'xpcshell': [u'firefox-48.0.en-US.mac.common.tests.zip', 02:11:48 INFO - u'firefox-48.0.en-US.mac.xpcshell.tests.zip']} 02:11:48 INFO - Downloading packages: [u'firefox-48.0.en-US.mac.common.tests.zip'] for test suite category: common 02:11:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:11:48 INFO - https://queue.taskcluster.net/v1/task/MsYJ-h_TQfKhwJ0FdpDiJA/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 02:11:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MsYJ-h_TQfKhwJ0FdpDiJA/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 02:11:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MsYJ-h_TQfKhwJ0FdpDiJA/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 02:11:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MsYJ-h_TQfKhwJ0FdpDiJA/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 02:11:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MsYJ-h_TQfKhwJ0FdpDiJA/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 02:11:49 INFO - Downloaded 18351516 bytes. 02:11:49 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'] 02:11:49 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 02:11:52 INFO - Return code: 0 02:11:52 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 02:11:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:11:52 INFO - https://queue.taskcluster.net/v1/task/MsYJ-h_TQfKhwJ0FdpDiJA/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 02:11:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MsYJ-h_TQfKhwJ0FdpDiJA/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 02:11:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MsYJ-h_TQfKhwJ0FdpDiJA/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 02:11:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MsYJ-h_TQfKhwJ0FdpDiJA/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 02:11:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MsYJ-h_TQfKhwJ0FdpDiJA/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 02:12:09 INFO - Downloaded 18351516 bytes. 02:12:09 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'] 02:12:09 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 02:12:13 INFO - Return code: 0 02:12:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:12:13 INFO - https://queue.taskcluster.net/v1/task/MsYJ-h_TQfKhwJ0FdpDiJA/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 02:12:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MsYJ-h_TQfKhwJ0FdpDiJA/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip 02:12:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MsYJ-h_TQfKhwJ0FdpDiJA/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip 02:12:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MsYJ-h_TQfKhwJ0FdpDiJA/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 02:12:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MsYJ-h_TQfKhwJ0FdpDiJA/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 02:12:15 INFO - Downloaded 10840145 bytes. 02:12:15 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'] 02:12:15 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 02:12:15 INFO - Return code: 0 02:12:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:12:15 INFO - https://queue.taskcluster.net/v1/task/MsYJ-h_TQfKhwJ0FdpDiJA/artifacts/public/build/firefox-48.0.en-US.mac.dmg matches https://queue.taskcluster.net 02:12:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MsYJ-h_TQfKhwJ0FdpDiJA/artifacts/public/build/firefox-48.0.en-US.mac.dmg 02:12:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MsYJ-h_TQfKhwJ0FdpDiJA/artifacts/public/build/firefox-48.0.en-US.mac.dmg 02:12:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MsYJ-h_TQfKhwJ0FdpDiJA/artifacts/public/build/firefox-48.0.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0.en-US.mac.dmg 02:12:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MsYJ-h_TQfKhwJ0FdpDiJA/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 02:12:36 INFO - Downloaded 86193007 bytes. 02:12:36 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/MsYJ-h_TQfKhwJ0FdpDiJA/artifacts/public/build/firefox-48.0.en-US.mac.dmg 02:12:36 INFO - mkdir: /builds/slave/test/properties 02:12:36 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:12:36 INFO - Writing to file /builds/slave/test/properties/build_url 02:12:36 INFO - Contents: 02:12:36 INFO - build_url:https://queue.taskcluster.net/v1/task/MsYJ-h_TQfKhwJ0FdpDiJA/artifacts/public/build/firefox-48.0.en-US.mac.dmg 02:12:37 INFO - Running post-action listener: _resource_record_post_action 02:12:37 INFO - Running post-action listener: set_extra_try_arguments 02:12:37 INFO - ##### 02:12:37 INFO - ##### Running populate-webroot step. 02:12:37 INFO - ##### 02:12:37 INFO - Running pre-action listener: _resource_record_pre_action 02:12:37 INFO - Running main action method: populate_webroot 02:12:37 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:12:37 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:12:37 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:12:37 INFO - '--tppagecycles', 02:12:37 INFO - '7'], 02:12:37 INFO - 'tests': ['tsvgm']}}, 02:12:37 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:12:37 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:12:37 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:12:37 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:12:37 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:12:37 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:12:37 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:12:37 INFO - 'talos_options': ['--disable-e10s'], 02:12:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:12:37 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:12:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:12:37 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:12:37 INFO - 'talos_options': ['--disable-e10s'], 02:12:37 INFO - 'tests': ['damp', 'tps']}, 02:12:37 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:12:37 INFO - 'tests': ['damp', 'tps']}, 02:12:37 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:12:37 INFO - 'tests': ['dromaeo_dom']}, 02:12:37 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:12:37 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:12:37 INFO - 'tests': ['a11yr', 02:12:37 INFO - 'ts_paint', 02:12:37 INFO - 'tpaint', 02:12:37 INFO - 'sessionrestore', 02:12:37 INFO - 'sessionrestore_no_auto_restore', 02:12:37 INFO - 'tabpaint']}, 02:12:37 INFO - 'other-e10s': {'tests': ['a11yr', 02:12:37 INFO - 'ts_paint', 02:12:37 INFO - 'tpaint', 02:12:37 INFO - 'sessionrestore', 02:12:37 INFO - 'sessionrestore_no_auto_restore', 02:12:37 INFO - 'tabpaint']}, 02:12:37 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:12:37 INFO - 'ts_paint', 02:12:37 INFO - 'tpaint', 02:12:37 INFO - 'sessionrestore', 02:12:37 INFO - 'sessionrestore_no_auto_restore', 02:12:37 INFO - 'tabpaint']}, 02:12:37 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:12:37 INFO - 'ts_paint', 02:12:37 INFO - 'tpaint', 02:12:37 INFO - 'sessionrestore', 02:12:37 INFO - 'sessionrestore_no_auto_restore', 02:12:37 INFO - 'tabpaint']}, 02:12:37 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:12:37 INFO - 'tests': ['a11yr', 02:12:37 INFO - 'ts_paint', 02:12:37 INFO - 'tpaint', 02:12:37 INFO - 'sessionrestore', 02:12:37 INFO - 'sessionrestore_no_auto_restore', 02:12:37 INFO - 'tabpaint']}, 02:12:37 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:12:37 INFO - 'tests': ['a11yr', 02:12:37 INFO - 'ts_paint', 02:12:37 INFO - 'tpaint', 02:12:37 INFO - 'sessionrestore', 02:12:37 INFO - 'sessionrestore_no_auto_restore', 02:12:37 INFO - 'tabpaint']}, 02:12:37 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:12:37 INFO - 'tests': ['tsvgx', 02:12:37 INFO - 'tsvgr_opacity', 02:12:37 INFO - 'tart', 02:12:37 INFO - 'tscrollx', 02:12:37 INFO - 'cart']}, 02:12:37 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:12:37 INFO - 'tsvgr_opacity', 02:12:37 INFO - 'tart', 02:12:37 INFO - 'tscrollx', 02:12:37 INFO - 'cart']}, 02:12:37 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:12:37 INFO - 'talos_options': ['--disable-e10s'], 02:12:37 INFO - 'tests': ['tp5o']}, 02:12:37 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:12:37 INFO - 'tests': ['tp5o']}, 02:12:37 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:12:37 INFO - 'talos_options': ['--disable-e10s', 02:12:37 INFO - '--xperf_path', 02:12:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:12:37 INFO - 'tests': ['tp5n']}, 02:12:37 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:12:37 INFO - 'talos_options': ['--xperf_path', 02:12:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:12:37 INFO - 'tests': ['tp5n']}}, 02:12:37 INFO - 'talos.zip': {'path': '', 02:12:37 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:12:37 INFO - Running post-action listener: _resource_record_post_action 02:12:37 INFO - ##### 02:12:37 INFO - ##### Running create-virtualenv step. 02:12:37 INFO - ##### 02:12:37 INFO - Running pre-action listener: _resource_record_pre_action 02:12:37 INFO - Running main action method: create_virtualenv 02:12:37 INFO - Creating virtualenv /builds/slave/test/build/venv 02:12:37 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 02:12:37 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:12:37 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:12:37 INFO - Using real prefix '/tools/python27' 02:12:37 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:12:38 INFO - Installing distribute.............................................................................................................................................................................................done. 02:12:41 INFO - Installing pip.................done. 02:12:41 INFO - Return code: 0 02:12:41 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:12: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')]} 02:12:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:12:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:12: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')]} 02:12:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:12:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:12:41 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 0x10c452a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c462420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faa20cd9820>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c2f1e00>, '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 0x10c15adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c2ecb20>, '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.lNKEEBfguE/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.BYspLJTwOg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:12:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 02:12:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 02:12:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lNKEEBfguE/Render', 02:12:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:12:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:12:41 INFO - 'HOME': '/Users/cltbld', 02:12:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:12:41 INFO - 'LOGNAME': 'cltbld', 02:12:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:12:41 INFO - 'MOZ_NO_REMOTE': '1', 02:12:41 INFO - 'NO_EM_RESTART': '1', 02:12:41 INFO - 'PAGER': '/bin/cat', 02:12:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:12:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:12:41 INFO - 'PWD': '/builds/slave/test', 02:12:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:12:41 INFO - 'SHELL': '/bin/bash', 02:12:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BYspLJTwOg/Listeners', 02:12:41 INFO - 'TMPDIR': '/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/', 02:12:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:12:41 INFO - 'USER': 'cltbld', 02:12:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:12:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:12:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:12:41 INFO - 'XPC_FLAGS': '0x0', 02:12:41 INFO - 'XPC_SERVICE_NAME': '0', 02:12:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:12:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:12:41 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 02:12:41 INFO - Cleaning up... 02:12:41 INFO - Return code: 0 02:12:41 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 02:12: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')]} 02:12:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:12:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:12: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')]} 02:12:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:12:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:12:41 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 0x10c452a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c462420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faa20cd9820>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c2f1e00>, '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 0x10c15adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c2ecb20>, '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.lNKEEBfguE/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.BYspLJTwOg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:12:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 02:12:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 02:12:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lNKEEBfguE/Render', 02:12:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:12:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:12:41 INFO - 'HOME': '/Users/cltbld', 02:12:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:12:41 INFO - 'LOGNAME': 'cltbld', 02:12:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:12:41 INFO - 'MOZ_NO_REMOTE': '1', 02:12:41 INFO - 'NO_EM_RESTART': '1', 02:12:41 INFO - 'PAGER': '/bin/cat', 02:12:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:12:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:12:41 INFO - 'PWD': '/builds/slave/test', 02:12:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:12:41 INFO - 'SHELL': '/bin/bash', 02:12:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BYspLJTwOg/Listeners', 02:12:41 INFO - 'TMPDIR': '/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/', 02:12:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:12:41 INFO - 'USER': 'cltbld', 02:12:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:12:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:12:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:12:41 INFO - 'XPC_FLAGS': '0x0', 02:12:41 INFO - 'XPC_SERVICE_NAME': '0', 02:12:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:12:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:12:41 INFO - Downloading/unpacking psutil>=0.7.1 02:12:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:12:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:12:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:12:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:12:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:12:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:12:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:12:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:12:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:12:45 INFO - Installing collected packages: psutil 02:12:45 INFO - Running setup.py install for psutil 02:12:45 INFO - building 'psutil._psutil_osx' extension 02:12:45 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 02:12:45 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 02:12:45 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 02:12:45 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 02:12:45 INFO - building 'psutil._psutil_posix' extension 02:12:45 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 02:12:46 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 02:12:46 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 02:12:46 INFO - ^ 02:12:46 INFO - 1 warning generated. 02:12:46 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 02:12:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:12:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:12:46 INFO - Successfully installed psutil 02:12:46 INFO - Cleaning up... 02:12:46 INFO - Return code: 0 02:12:46 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 02:12:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:12:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:12:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:12:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:12:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:12:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:12:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10c452a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c462420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faa20cd9820>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c2f1e00>, '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 0x10c15adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c2ecb20>, '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.lNKEEBfguE/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.BYspLJTwOg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:12:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 02:12:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 02:12:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lNKEEBfguE/Render', 02:12:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:12:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:12:46 INFO - 'HOME': '/Users/cltbld', 02:12:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:12:46 INFO - 'LOGNAME': 'cltbld', 02:12:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:12:46 INFO - 'MOZ_NO_REMOTE': '1', 02:12:46 INFO - 'NO_EM_RESTART': '1', 02:12:46 INFO - 'PAGER': '/bin/cat', 02:12:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:12:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:12:46 INFO - 'PWD': '/builds/slave/test', 02:12:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:12:46 INFO - 'SHELL': '/bin/bash', 02:12:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BYspLJTwOg/Listeners', 02:12:46 INFO - 'TMPDIR': '/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/', 02:12:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:12:46 INFO - 'USER': 'cltbld', 02:12:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:12:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:12:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:12:46 INFO - 'XPC_FLAGS': '0x0', 02:12:46 INFO - 'XPC_SERVICE_NAME': '0', 02:12:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:12:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:12:46 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 02:12:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:12:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:12:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:12:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:12:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:12:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:12:49 INFO - Downloading mozsystemmonitor-0.0.tar.gz 02:12:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:12:49 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 02:12:49 INFO - Installing collected packages: mozsystemmonitor 02:12:49 INFO - Running setup.py install for mozsystemmonitor 02:12:49 INFO - Successfully installed mozsystemmonitor 02:12:49 INFO - Cleaning up... 02:12:49 INFO - Return code: 0 02:12:49 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:12:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:12:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:12:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:12:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:12:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:12:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:12:49 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 0x10c452a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c462420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faa20cd9820>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c2f1e00>, '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 0x10c15adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c2ecb20>, '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.lNKEEBfguE/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.BYspLJTwOg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:12:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 02:12:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 02:12:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lNKEEBfguE/Render', 02:12:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:12:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:12:49 INFO - 'HOME': '/Users/cltbld', 02:12:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:12:49 INFO - 'LOGNAME': 'cltbld', 02:12:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:12:49 INFO - 'MOZ_NO_REMOTE': '1', 02:12:49 INFO - 'NO_EM_RESTART': '1', 02:12:49 INFO - 'PAGER': '/bin/cat', 02:12:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:12:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:12:49 INFO - 'PWD': '/builds/slave/test', 02:12:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:12:49 INFO - 'SHELL': '/bin/bash', 02:12:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BYspLJTwOg/Listeners', 02:12:49 INFO - 'TMPDIR': '/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/', 02:12:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:12:49 INFO - 'USER': 'cltbld', 02:12:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:12:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:12:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:12:49 INFO - 'XPC_FLAGS': '0x0', 02:12:49 INFO - 'XPC_SERVICE_NAME': '0', 02:12:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:12:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:12:49 INFO - Downloading/unpacking blobuploader==1.2.4 02:12:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:12:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:12:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:12:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:12:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:12:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:12:52 INFO - Downloading blobuploader-1.2.4.tar.gz 02:12:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:12:52 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:12: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 02:12: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 02:12: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 02:12: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 02:12: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 02:12: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 02:12:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:12:53 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:12:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:12:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:12:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:12:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:12:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:12:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:12:53 INFO - Downloading docopt-0.6.1.tar.gz 02:12:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:12:53 INFO - Installing collected packages: blobuploader, requests, docopt 02:12:53 INFO - Running setup.py install for blobuploader 02:12:53 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:12:53 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:12:53 INFO - Running setup.py install for requests 02:12:54 INFO - Running setup.py install for docopt 02:12:54 INFO - Successfully installed blobuploader requests docopt 02:12:54 INFO - Cleaning up... 02:12:54 INFO - Return code: 0 02:12:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:12:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:12:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:12:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:12:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:12:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:12:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:12:54 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 0x10c452a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c462420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faa20cd9820>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c2f1e00>, '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 0x10c15adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c2ecb20>, '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.lNKEEBfguE/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.BYspLJTwOg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:12:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 02:12:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:12:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lNKEEBfguE/Render', 02:12:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:12:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:12:54 INFO - 'HOME': '/Users/cltbld', 02:12:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:12:54 INFO - 'LOGNAME': 'cltbld', 02:12:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:12:54 INFO - 'MOZ_NO_REMOTE': '1', 02:12:54 INFO - 'NO_EM_RESTART': '1', 02:12:54 INFO - 'PAGER': '/bin/cat', 02:12:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:12:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:12:54 INFO - 'PWD': '/builds/slave/test', 02:12:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:12:54 INFO - 'SHELL': '/bin/bash', 02:12:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BYspLJTwOg/Listeners', 02:12:54 INFO - 'TMPDIR': '/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/', 02:12:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:12:54 INFO - 'USER': 'cltbld', 02:12:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:12:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:12:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:12:54 INFO - 'XPC_FLAGS': '0x0', 02:12:54 INFO - 'XPC_SERVICE_NAME': '0', 02:12:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:12:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:12:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:12:54 INFO - Running setup.py (path:/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/pip-UfuQaz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:12:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:12:54 INFO - Running setup.py (path:/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/pip-bvUpfl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:12:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:12:54 INFO - Running setup.py (path:/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/pip-bYcHzP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:12:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:12:54 INFO - Running setup.py (path:/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/pip-a9C89o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:12:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:12:55 INFO - Running setup.py (path:/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/pip-HrTeX0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:12:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:12:55 INFO - Running setup.py (path:/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/pip-uSxA5e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:12:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:12:55 INFO - Running setup.py (path:/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/pip-y3nnl8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:12:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:12:55 INFO - Running setup.py (path:/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/pip-UFs3b3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:12:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:12:55 INFO - Running setup.py (path:/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/pip-VtDQZY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:12:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:12:55 INFO - Running setup.py (path:/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/pip-atIdKw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:12:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:12:55 INFO - Running setup.py (path:/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/pip-KIaYHR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:12:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:12:55 INFO - Running setup.py (path:/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/pip-NjE_Hj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:12:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:12:55 INFO - Running setup.py (path:/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/pip-sWkSwA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:12:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:12:55 INFO - Running setup.py (path:/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/pip-7MWkQY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:12:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:12:56 INFO - Running setup.py (path:/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/pip-_xgknE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:12:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:12:56 INFO - Running setup.py (path:/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/pip-1rpTFr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:12:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:12:56 INFO - Running setup.py (path:/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/pip-v_1fL1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:12:56 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:12:56 INFO - Running setup.py install for manifestparser 02:12:56 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:12:56 INFO - Running setup.py install for mozcrash 02:12:56 INFO - Running setup.py install for mozdebug 02:12:56 INFO - Running setup.py install for mozdevice 02:12:56 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:12:56 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:12:56 INFO - Running setup.py install for mozfile 02:12:57 INFO - Running setup.py install for mozhttpd 02:12:57 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:12:57 INFO - Running setup.py install for mozinfo 02:12:57 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:12:57 INFO - Running setup.py install for mozInstall 02:12:57 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:12:57 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:12:57 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:12:57 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:12:57 INFO - Running setup.py install for mozleak 02:12:57 INFO - Running setup.py install for mozlog 02:12:57 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:12:57 INFO - Running setup.py install for moznetwork 02:12:58 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:12:58 INFO - Running setup.py install for mozprocess 02:12:58 INFO - Running setup.py install for mozprofile 02:12:58 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:12:58 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:12:58 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:12:58 INFO - Running setup.py install for mozrunner 02:12:58 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:12:58 INFO - Running setup.py install for mozscreenshot 02:12:58 INFO - Running setup.py install for moztest 02:12:58 INFO - Running setup.py install for mozversion 02:12:58 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:12:58 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:12:58 INFO - Cleaning up... 02:12:58 INFO - Return code: 0 02:12:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:12:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:12:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:12:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:12:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:12:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:12:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:12:58 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 0x10c452a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c462420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faa20cd9820>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c2f1e00>, '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 0x10c15adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c2ecb20>, '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.lNKEEBfguE/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.BYspLJTwOg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:12:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 02:12:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:12:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lNKEEBfguE/Render', 02:12:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:12:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:12:58 INFO - 'HOME': '/Users/cltbld', 02:12:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:12:58 INFO - 'LOGNAME': 'cltbld', 02:12:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:12:58 INFO - 'MOZ_NO_REMOTE': '1', 02:12:58 INFO - 'NO_EM_RESTART': '1', 02:12:58 INFO - 'PAGER': '/bin/cat', 02:12:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:12:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:12:58 INFO - 'PWD': '/builds/slave/test', 02:12:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:12:58 INFO - 'SHELL': '/bin/bash', 02:12:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BYspLJTwOg/Listeners', 02:12:58 INFO - 'TMPDIR': '/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/', 02:12:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:12:58 INFO - 'USER': 'cltbld', 02:12:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:12:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:12:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:12:58 INFO - 'XPC_FLAGS': '0x0', 02:12:58 INFO - 'XPC_SERVICE_NAME': '0', 02:12:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:12:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:12:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:12:59 INFO - Running setup.py (path:/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/pip-ANLsr4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:12:59 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 02:12:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:12:59 INFO - Running setup.py (path:/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/pip-hQ6AHz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:12:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:12:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:12:59 INFO - Running setup.py (path:/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/pip-ve5vpT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:12:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 02:12:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:12:59 INFO - Running setup.py (path:/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/pip-qYl77U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:12:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:12:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:12:59 INFO - Running setup.py (path:/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/pip-HSOK_L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:12:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 02:12:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:12:59 INFO - Running setup.py (path:/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/pip-MyNROE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:12:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 02:12:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:12:59 INFO - Running setup.py (path:/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/pip-tuXiNf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:12:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 02:12:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:12:59 INFO - Running setup.py (path:/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/pip-LH2fKn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:13:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 02:13:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:13:00 INFO - Running setup.py (path:/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/pip-AMdFzm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:13:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 02:13:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:13:00 INFO - Running setup.py (path:/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/pip-v2wMyV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:13:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:13:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:13:00 INFO - Running setup.py (path:/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/pip-VFVcsC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:13:00 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 02:13:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:13:00 INFO - Running setup.py (path:/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/pip-d5Mtst-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:13:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 02:13:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:13:00 INFO - Running setup.py (path:/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/pip-EExhSa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:13:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 02:13:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:13:00 INFO - Running setup.py (path:/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/pip-NA6yPr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:13:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 02:13:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:13:00 INFO - Running setup.py (path:/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/pip-RB1TAj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:13:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 02:13:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:13:00 INFO - Running setup.py (path:/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/pip-B4Lvdx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:13:00 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 02:13:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:13:00 INFO - Running setup.py (path:/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/pip-bEmtCQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:13:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 02:13:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:13:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:13:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 02:13:01 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:13:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:13:01 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:13:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:13:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:13:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:13:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:13:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:13:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:13:03 INFO - Downloading blessings-1.6.tar.gz 02:13:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:13:04 INFO - Installing collected packages: blessings 02:13:04 INFO - Running setup.py install for blessings 02:13:04 INFO - Successfully installed blessings 02:13:04 INFO - Cleaning up... 02:13:04 INFO - Return code: 0 02:13:04 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:13:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:13:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:13:04 INFO - Reading from file tmpfile_stdout 02:13:04 INFO - Current package versions: 02:13:04 INFO - blessings == 1.6 02:13:04 INFO - blobuploader == 1.2.4 02:13:04 INFO - docopt == 0.6.1 02:13:04 INFO - manifestparser == 1.1 02:13:04 INFO - mozInstall == 1.12 02:13:04 INFO - mozcrash == 0.17 02:13:04 INFO - mozdebug == 0.1 02:13:04 INFO - mozdevice == 0.48 02:13:04 INFO - mozfile == 1.2 02:13:04 INFO - mozhttpd == 0.7 02:13:04 INFO - mozinfo == 0.9 02:13:04 INFO - mozleak == 0.1 02:13:04 INFO - mozlog == 3.1 02:13:04 INFO - moznetwork == 0.27 02:13:04 INFO - mozprocess == 0.22 02:13:04 INFO - mozprofile == 0.28 02:13:04 INFO - mozrunner == 6.11 02:13:04 INFO - mozscreenshot == 0.1 02:13:04 INFO - mozsystemmonitor == 0.0 02:13:04 INFO - moztest == 0.7 02:13:04 INFO - mozversion == 1.4 02:13:04 INFO - psutil == 3.1.1 02:13:04 INFO - requests == 1.2.3 02:13:04 INFO - wsgiref == 0.1.2 02:13:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:13:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:13:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:13:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:13:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:13:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:13:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:13:04 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 0x10c452a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c462420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faa20cd9820>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c2f1e00>, '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 0x10c15adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c2ecb20>, '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.lNKEEBfguE/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.BYspLJTwOg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:13:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 02:13:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:13:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lNKEEBfguE/Render', 02:13:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:13:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:13:04 INFO - 'HOME': '/Users/cltbld', 02:13:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:13:04 INFO - 'LOGNAME': 'cltbld', 02:13:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:13:04 INFO - 'MOZ_NO_REMOTE': '1', 02:13:04 INFO - 'NO_EM_RESTART': '1', 02:13:04 INFO - 'PAGER': '/bin/cat', 02:13:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:13:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:13:04 INFO - 'PWD': '/builds/slave/test', 02:13:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:13:04 INFO - 'SHELL': '/bin/bash', 02:13:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BYspLJTwOg/Listeners', 02:13:04 INFO - 'TMPDIR': '/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/', 02:13:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:13:04 INFO - 'USER': 'cltbld', 02:13:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:13:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:13:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:13:04 INFO - 'XPC_FLAGS': '0x0', 02:13:04 INFO - 'XPC_SERVICE_NAME': '0', 02:13:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:13:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:13:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 02:13:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 02:13:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 02:13:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 02:13:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 02:13:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 02:13:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 02:13:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 02:13:04 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 02:13:04 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 02:13:04 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 02:13:04 INFO - Cleaning up... 02:13:04 INFO - Return code: 0 02:13:04 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:13:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:13:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:13:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:13:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:13:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:13:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:13:04 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 0x10c452a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c462420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faa20cd9820>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c2f1e00>, '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 0x10c15adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c2ecb20>, '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.lNKEEBfguE/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.BYspLJTwOg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:13:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 02:13:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 02:13:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lNKEEBfguE/Render', 02:13:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:13:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:13:04 INFO - 'HOME': '/Users/cltbld', 02:13:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:13:04 INFO - 'LOGNAME': 'cltbld', 02:13:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:13:04 INFO - 'MOZ_NO_REMOTE': '1', 02:13:04 INFO - 'NO_EM_RESTART': '1', 02:13:04 INFO - 'PAGER': '/bin/cat', 02:13:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:13:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:13:04 INFO - 'PWD': '/builds/slave/test', 02:13:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:13:04 INFO - 'SHELL': '/bin/bash', 02:13:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BYspLJTwOg/Listeners', 02:13:04 INFO - 'TMPDIR': '/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/', 02:13:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:13:04 INFO - 'USER': 'cltbld', 02:13:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:13:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:13:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:13:04 INFO - 'XPC_FLAGS': '0x0', 02:13:04 INFO - 'XPC_SERVICE_NAME': '0', 02:13:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:13:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:13:05 INFO - Downloading/unpacking jsonschema 02:13:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:13:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:13:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:13:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:13:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:13:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:13:07 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:13:07 INFO - Downloading/unpacking functools32 (from jsonschema) 02:13:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:13:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:13:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:13:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:13:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:13:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:13:08 INFO - Downloading functools32-3.2.3-2.tar.gz 02:13:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:13:08 INFO - warning: no files found matching '*.txt' 02:13:08 INFO - no previously-included directories found matching 'build' 02:13:08 INFO - no previously-included directories found matching 'dist' 02:13:08 INFO - no previously-included directories found matching '.git*' 02:13:08 INFO - Installing collected packages: jsonschema, functools32 02:13:08 INFO - Running setup.py install for functools32 02:13:08 INFO - warning: no files found matching '*.txt' 02:13:08 INFO - no previously-included directories found matching 'build' 02:13:08 INFO - no previously-included directories found matching 'dist' 02:13:08 INFO - no previously-included directories found matching '.git*' 02:13:08 INFO - Successfully installed jsonschema functools32 02:13:08 INFO - Cleaning up... 02:13:08 INFO - Return code: 0 02:13:08 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 02:13:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:13:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:13:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:13:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:13:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:13:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:13:08 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 0x10c452a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c462420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faa20cd9820>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c2f1e00>, '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 0x10c15adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c2ecb20>, '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.lNKEEBfguE/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.BYspLJTwOg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:13:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 02:13:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 02:13:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lNKEEBfguE/Render', 02:13:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:13:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:13:08 INFO - 'HOME': '/Users/cltbld', 02:13:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:13:08 INFO - 'LOGNAME': 'cltbld', 02:13:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:13:08 INFO - 'MOZ_NO_REMOTE': '1', 02:13:08 INFO - 'NO_EM_RESTART': '1', 02:13:08 INFO - 'PAGER': '/bin/cat', 02:13:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:13:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:13:08 INFO - 'PWD': '/builds/slave/test', 02:13:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:13:08 INFO - 'SHELL': '/bin/bash', 02:13:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BYspLJTwOg/Listeners', 02:13:08 INFO - 'TMPDIR': '/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/', 02:13:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:13:08 INFO - 'USER': 'cltbld', 02:13:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:13:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:13:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:13:08 INFO - 'XPC_FLAGS': '0x0', 02:13:08 INFO - 'XPC_SERVICE_NAME': '0', 02:13:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:13:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:13:09 INFO - Downloading/unpacking flake8 02:13:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:13:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:13:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:13:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:13:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:13:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:13:12 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 02:13:12 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 02:13:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:13:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:13:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:13:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:13:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:13:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:13:13 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 02:13:13 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 02:13:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:13:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:13:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:13:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:13:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:13:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:13:13 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 02:13:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:13:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:13:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:13:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:13:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:13:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:13:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 02:13:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:13:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:13:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:13:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:13:14 INFO - no previously-included directories found matching 'docs/_build' 02:13:14 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 02:13:14 INFO - Running setup.py install for pep8 02:13:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:13:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:13:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:13:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:13:14 INFO - no previously-included directories found matching 'docs/_build' 02:13:14 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 02:13:14 INFO - Successfully installed flake8 mccabe pyflakes pep8 02:13:14 INFO - Cleaning up... 02:13:14 INFO - Return code: 0 02:13:14 INFO - Running post-action listener: _resource_record_post_action 02:13:14 INFO - Running post-action listener: _start_resource_monitoring 02:13:14 INFO - Starting resource monitoring. 02:13:14 INFO - ##### 02:13:14 INFO - ##### Running install step. 02:13:14 INFO - ##### 02:13:14 INFO - Running pre-action listener: _resource_record_pre_action 02:13:14 INFO - Running main action method: install 02:13:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:13:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:13:15 INFO - Reading from file tmpfile_stdout 02:13:15 INFO - Detecting whether we're running mozinstall >=1.0... 02:13:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:13:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:13:15 INFO - Reading from file tmpfile_stdout 02:13:15 INFO - Output received: 02:13:15 INFO - Usage: mozinstall [options] installer 02:13:15 INFO - Options: 02:13:15 INFO - -h, --help show this help message and exit 02:13:15 INFO - -d DEST, --destination=DEST 02:13:15 INFO - Directory to install application into. [default: 02:13:15 INFO - "/builds/slave/test"] 02:13:15 INFO - --app=APP Application being installed. [default: firefox] 02:13:15 INFO - mkdir: /builds/slave/test/build/application 02:13:15 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'] 02:13:15 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 02:13:37 INFO - Reading from file tmpfile_stdout 02:13:37 INFO - Output received: 02:13:37 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 02:13:37 INFO - Running post-action listener: _resource_record_post_action 02:13:37 INFO - ##### 02:13:37 INFO - ##### Running run-tests step. 02:13:37 INFO - ##### 02:13:37 INFO - Running pre-action listener: _resource_record_pre_action 02:13:37 INFO - Running main action method: run_tests 02:13:37 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:13:37 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:13:37 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:13:37 INFO - 2016-07-11 02:13:37.186 screenresolution[1670:9443] starting screenresolution argv=screenresolution get 02:13:37 INFO - 2016-07-11 02:13:37.189 screenresolution[1670:9443] Display 0: 1600x1200x32@60 02:13:37 INFO - 2016-07-11 02:13:37.194 screenresolution[1671:9446] starting screenresolution argv=screenresolution list 02:13:37 INFO - Available Modes on Display 0 02:13:37 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:13:37 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:13:37 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:13:37 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:13:37 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:13:37 INFO - Intel Iris: 02:13:37 INFO - Chipset Model: Intel Iris 02:13:37 INFO - Type: GPU 02:13:37 INFO - Bus: Built-In 02:13:37 INFO - VRAM (Dynamic, Max): 1536 MB 02:13:37 INFO - Vendor: Intel (0x8086) 02:13:37 INFO - Device ID: 0x0a2e 02:13:37 INFO - Revision ID: 0x0009 02:13:37 INFO - Displays: 02:13:37 INFO - Display: 02:13:37 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:13:37 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:13:37 INFO - Display Serial Number: 1600x1200 60 02:13:37 INFO - Main Display: Yes 02:13:37 INFO - Mirror: Off 02:13:37 INFO - Online: Yes 02:13:37 INFO - Rotation: Supported 02:13:37 INFO - Return code: 0 02:13:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:13:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:13:37 INFO - Python 2.7.3 02:13:37 INFO - Return code: 0 02:13:37 INFO - grabbing minidump binary from tooltool 02:13:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:13:37 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 0x10c2f1e00>, '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 0x10c15adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c2ecb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:13:37 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 02:13:37 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 02:13:37 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:13:37 INFO - Return code: 0 02:13:37 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 02:13:37 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:13:37 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:13:37 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 02:13:37 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:13:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 02:13:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 02:13:38 INFO - Return code: 0 02:13:38 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/MsYJ-h_TQfKhwJ0FdpDiJA/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0382', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 02:13:38 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/MsYJ-h_TQfKhwJ0FdpDiJA/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0382 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 02:13:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lNKEEBfguE/Render', 02:13:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:13:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:13:38 INFO - 'HOME': '/Users/cltbld', 02:13:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:13:38 INFO - 'LOGNAME': 'cltbld', 02:13:38 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:13:38 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 02:13:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:13:38 INFO - 'MOZ_NO_REMOTE': '1', 02:13:38 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:13:38 INFO - 'NO_EM_RESTART': '1', 02:13:38 INFO - 'PAGER': '/bin/cat', 02:13:38 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:13:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:13:38 INFO - 'PWD': '/builds/slave/test', 02:13:38 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:13:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:13:38 INFO - 'SHELL': '/bin/bash', 02:13:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BYspLJTwOg/Listeners', 02:13:38 INFO - 'TMPDIR': '/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/', 02:13:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:13:38 INFO - 'USER': 'cltbld', 02:13:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:13:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:13:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:13:38 INFO - 'XPC_FLAGS': '0x0', 02:13:38 INFO - 'XPC_SERVICE_NAME': '0', 02:13:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:13:38 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/MsYJ-h_TQfKhwJ0FdpDiJA/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0382', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 02:13:38 INFO - mozversion application_buildid: 20160711002426 02:13:38 INFO - mozversion application_changeset: e0770c0fbc7b7bbcb6be3d4d063f3d4a0ffdb7a2 02:13:38 INFO - mozversion application_display_name: Firefox 02:13:38 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:13:38 INFO - mozversion application_name: Firefox 02:13:38 INFO - mozversion application_remotingname: firefox 02:13:38 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 02:13:38 INFO - mozversion application_vendor: Mozilla 02:13:38 INFO - mozversion application_version: 48.0 02:13:38 INFO - mozversion platform_buildid: 20160711002426 02:13:38 INFO - mozversion platform_changeset: e0770c0fbc7b7bbcb6be3d4d063f3d4a0ffdb7a2 02:13:38 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 02:13:38 INFO - mozversion platform_version: 48.0 02:13:38 INFO - using testdate: 1468228418 02:13:38 INFO - actual date: 1468228418 02:13:38 INFO - starting webserver on 'localhost:49277' 02:13:38 INFO - SUITE-START | Running 2 tests 02:13:38 INFO - TEST-START | dromaeo_css 02:13:38 INFO - operating with platform_type : mac_ 02:13:38 INFO - Initialising browser for dromaeo_css test... 02:13:38 INFO - TEST-INFO | started process 1689 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/tmpHVHwxE/profile http://localhost:49277/getInfo.html) 02:13:41 INFO - PROCESS | 1689 | __metrics Screen width/height:1600/1200 02:13:41 INFO - PROCESS | 1689 | colorDepth:24 02:13:41 INFO - PROCESS | 1689 | Browser inner width/height: 1024/689 02:13:41 INFO - PROCESS | 1689 | __metrics 02:13:41 INFO - PROCESS | 1689 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 02:13:41 ERROR - PROCESS | 1689 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 02:13:41 INFO - TEST-INFO | 1689: exit 0 02:13:41 INFO - Browser initialized. 02:13:41 INFO - Running cycle 1/1 for dromaeo_css test... 02:13:41 INFO - TEST-INFO | started process 1692 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/tmpHVHwxE/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:13:53 INFO - PROCESS | 1692 | RSS: Main: 161685504 02:13:53 INFO - PROCESS | 1692 | 02:14:45 INFO - PROCESS | 1692 | 1468228485069 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 02:16:55 INFO - PROCESS | 1692 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49277/tests/dromaeo/cssquery-ext.html) 02:16:56 INFO - PROCESS | 1692 | RSS: Main: 326553600 02:16:56 INFO - PROCESS | 1692 | 02:19:59 INFO - PROCESS | 1692 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-ext.html (next: http://localhost:49277/tests/dromaeo/cssquery-jquery.html) 02:20:00 INFO - PROCESS | 1692 | RSS: Main: 305561600 02:20:00 INFO - PROCESS | 1692 | 02:23:02 INFO - PROCESS | 1692 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49277/tests/dromaeo/cssquery-mootools.html) 02:23:02 INFO - PROCESS | 1692 | RSS: Main: 310665216 02:23:02 INFO - PROCESS | 1692 | 02:26:04 INFO - PROCESS | 1692 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49277/tests/dromaeo/cssquery-prototype.html) 02:26:05 INFO - PROCESS | 1692 | RSS: Main: 310091776 02:26:05 INFO - PROCESS | 1692 | 02:29:08 INFO - PROCESS | 1692 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49277/tests/dromaeo/cssquery-yui.html) 02:29:09 INFO - PROCESS | 1692 | RSS: Main: 276185088 02:29:09 INFO - PROCESS | 1692 | 02:32:11 INFO - PROCESS | 1692 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-yui.html (next: http://localhost:49277/tests/dromaeo/cssquery-dojo.html) 02:32:12 INFO - PROCESS | 1692 | RSS: Main: 313507840 02:32:12 INFO - PROCESS | 1692 | 02:32:12 INFO - PROCESS | 1692 | __start_tp_report 02:32:12 INFO - PROCESS | 1692 | _x_x_mozilla_page_load 02:32:12 INFO - PROCESS | 1692 | _x_x_mozilla_page_load_details 02:32:12 INFO - PROCESS | 1692 | |i|pagename|runs| 02:32:12 INFO - PROCESS | 1692 | |0;dojo.html;3271.165852707559;3594.0655429588332;3603.837827297771;3605.83773730182;3694.5566532016164;5929.792457263997;5947.821565353041;5949.464548190662;5952.672603006833;5986.730597123129;5872.471477567018;5898.085796701507;5936.376680448545;5939.198208241886;5941.197938278331;5108.259302401149;5229.424763276036;5293.073712100377;5373.167159090328;5419.403865574784;5351.839444816642;5400.567954563626;5409.972950135244;5414.35027796663;5432.185172224158;5327.920081198785;5343.759530821103;5368.46315368462;5391.487808658171;5408.215808707735;5385.407605163448;5402.108652072403;5411.540019098381;5421.674699518042;5485.807996720136;5195.168772996302;5327.067763141435;5330.9733451332495;5356.91964620531;5357.116075847481;5707.77168913243;5743.5118014968775;5774.162746401748;5806.796762113306;5879.412058794129;6315.273743519509;6319.399657032574;6322;6339.175907132089;6348.746050157988;6228.096925945712;6262.3111457739615;6315.147455093595;6326.588771729823;6326.841828954313;5950.761969521214;6016.879662406727;6025.126356678257;6031.125486804389;6053.576249662526;6328.272248691459;6366.013267943476;6367.554271200971;6389.105525226472;6393.200849893763;6102.084687296941;6177.073438984098;6332.936670633235;6333.240011198685;6337.207849018872;6258.499320054385;6277.466415354746;6310.211223597051;6327.810165695037;6366.331535188831;6287.993920972623;6297.338779428094;6328.177336946167;6328.620282782956;6330.968345158245;6270.874582508324;6296.5592408530965;6317.052442133717;6319.905201421982;6347.143135676624;4939.135651261086;4972.129877271463;5002.549770520671;5011.724355160428;5073.518015788494;4522.276435770326;4536.750478723702;4543.409356783597;4559.54404559548;4574.771261436915;5943.049112142036;5949.881002379928;5953.910691339634;5965.224520812353;5972.223610930638;6164.506839452833;6283.403076707706;6299.874002520016;6300.432961033529;6316.30520642729;5918.348981612019;5946.554008449383;5950.4049595041015;5951.821445356646;5971.313298970674;5512.33851937762;5561.555075593943;5572;5587.888242235133;5588.580856435784;6461.160049193575;6461.321561236003;6477.805665830033;6478.060681201294;6498.155239818888;6244.375562443901;6256.843578910381;6265.028920517327;6309.968450157719;6321.020241862519;6407.10300557913;6488.70800813974;6489.059086432535;6489.156409666902;6496.837579060561;5261.842144735664;6283.528735344776;6310.148130002574;6325.936740632535;6331.96834015827;6240.53196010292;6266.749330026748;6305.464035556845;6312.274088479883;6324.209473815773;6118.847028824315;6245.156903817927;6305.274893387319;6310.968445157745;6311.431971122621;6284.748610055546;6285.025820997753;6286.245650521967;6287.2140982377205;6297.653629050446;6036.124761909411;6103.664298463449;6132.263729246545;6156.969215153896;6158.32258451561;6189.938100618936;6206.224221972254;6244.843878902882;6254.249490061222;6341.239051313872;6115.392460733998;6184.010558310649;6197.938020619736;6198.6280823150755;6204.410580994799 02:32:12 INFO - PROCESS | 1692 | |1;ext.html;529.0820426559918;543.9827522532867;546.7075114813575;596.624126800116;629.3329071184542;32466.350672986526;33056.66943330566;33103.834480827565;33174.66825331746;33178.50232246518;32727;33023;33071.00786976388;42287.365689514685;43027;9578.760530986729;9722.562484688171;9746.415215087081;9755.024497550223;9756.219502439822;9669.75825604362;9802.656907008257;9809.50952452378;9813.460259685715;9831.852522212173;9245.07549245077;9419.952900235488;9427;9434.009429009959;9763.414195148278;11892.643220703392;12078.27530348182;12098.879011209863;12100.334481603508;12119.151659383846;11585.246958947642;11725.765484690259;11726.882731172664;11738.237014594024;11741;40567.39148912769;40802;40942.590574094174;40993.38509922354;41049.794751026355;3218;3425.743069269815;3863.942040869389;3880.767153970771;3931.8034098295257;29527;29960;30625.540616890765;30629;30926.381472370653;2367.337145599235;2748.8213266137636;2771;2771.016289217319;2801.8739156737997;461586;463081;463565;464668;466087.9999999966;38125.85622431276;69913.65043174854;70561.64719176371;70634.9404758929;70839;37238;37368;37414.62585374166;37419.25161496755;37535.436968445494;17012.744808827876;17170.914145429444;17206.225719842638;17227.741583876254;17239.310427582757;12695.809562856564;14531.200783956772;14705.26473676312;14710.264486775619;14740.631484212767;8584.184502472255;8617.138286171332;8629.611667474854;8689.695860644848;8691.478511289217;3289.884854030145;3358.1623528118703;3425.2293234022145;3439.638837922032;3495.580530336325;992.8907820139779;1009.2985375164191;1056.6513050693252;1072.8390741388855;1079.2822772855964;27043.053493127645;30838.69161308403;31985.360292794016;33359.99920002404;34668.82665586656;1117.6242274658916;1156.2484385149553;1165.7668466306773;1202.2185579373477;1277.6294874486296;15927.840721592636;16077.196140192944;16149.59626009359;16526.338946442007;16611.66776664484;632984;637699.8115009395;637877;637975;640666;63658;64305.678471607345;64324.356756432775;64373;64377.678111609144;1418.212891845036;1475.9188244646648;1492.037635724973;1538.476917847937;1610.9919450402674;30655.233619158807;30786.38427231398;30953.845230773702;31799.841000794848;31819.840900796273;53126.734366327924;53997.46002540082;54047.729761352515;54142.99999999842;54177;484582;486930;490225;490369;491832;35551.82224088863;44705;45402.31896521621;45440.54559454363;45584;45381.09237815159;46094.61716148521;46205;47025.529744702115;47140.7642961783;34292.142696431794;36516.26967460583;37533.43699844559;40302;40541.79729101453;37394;38564.42153367758;38601.6139838598;39146.608533914296;39421.408678869266;37715.86852394432;38348.61651383562;38355.04112397212;38366.616333837424;38882.416763749134;32803.50794738129;33610.159746006546;34168.82915585406;34185.145371365914;34349.484757728154;25402.083250189597;25416.491670166863;25425.49149017046;25785.839637216744;25855.612165817904 02:32:12 INFO - PROCESS | 1692 | |2;jquery.html;405.3352501896889;412.6142057176542;412.6410023279747;416.11707025708665;424.60935938936194;16066.518004459856;20920.26779062733;21565;21630.675539866916;21694.674579881274;21081.26215582455;21317.253896113638;22514.54970900581;22550;22564.323070307877;5610.887782244353;6063.727132279036;6072.726727297282;6075.544334174932;6076.331603523631;6003.459688628022;6007.429294217042;6065.666388348639;6068.908966365508;6076.574639775217;4321.956780432202;5006.97496512517;6608.041833934077;6610.471162307004;6616.371444712745;6510.544261901621;6559.540832141728;6581.5721978071515;6587.50593705474;6592.143021407211;5601;5730.6275092119295;5750.108733146369;5761.366249712528;5762.711864406763;25747.841347139423;26117.869410652824;26602.935882564674;26826.86586567055;26885.731142688714;2020.0808632072371;2095.5913596848623;2168.3386567097027;2421.782039616425;2434.6974368712654;10336.586536538605;10656.254062215648;11155.553777848876;11655.533778648844;15639.452619158388;1743.076169630098;1820.472063101699;1827.1412436154985;1875.3436297295837;1897.5351038995395;123812;126187;128529;129193;129290.41419171658;11842.644720658394;12075.215111017756;12075.3358565278;12096.274223546616;12258.816117758062;14098.365573549216;14626.049306795025;14678.045927014924;15880.602984925239;15923.601909952344;6509.316521765241;7580.317771400601;8547.230749232598;9356.532173391302;9387;9262.351635385457;9281.628734850665;9305.25557955362;9395.248380129573;9400.294977876687;4761.40482439695;4838.443578988391;4844.467108618049;4851.369321988119;4876.561109500162;1699.7960244770459;1726;2066.4833791552114;2093.4033800366824;2098.6432306507627;919.5080631861922;936.513013233115;940.1115945431638;988.2489308125732;1007.8236308645958;19658.311959081362;20368.879711616002;20702.378928632166;20769.792302076785;20819;965.5124162298135;967.8161149381735;971.5190980464715;985.935914165577;1039.7556574205055;8955.686550970684;9453.574589143505;11153.275037122561;11161.386123763108;11193.66419007431;634010.8299458566;645633.8813594818;658187;659978;661736;124138;127244;129821;134828.65171348356;138115;1051.8842927277992;1064.4890452582804;1083.3283364314018;1087.6628245243999;1090.6564432203832;18455.261789528267;18899.622007559497;19094.618107637492;19169.904150479157;19430.931298778138;51770.74114629403;52048.69878253074;55647.72176139093;56511.43488565062;58646.533836654424;72313.6384318075;73622.63188684022;73773.26226737878;75698;75898.86151707618;8213.38399620019;8313.459625124347;8351.624176912175;8455.704050358208;8660.571005783975;8621.267192288726;12149.331786751813;13201.405936733063;13488.12327198729;13531.391087400894;11374.715632109264;11669.35818529989;11917.34454605005;11968.880311196777;11998.40007999614;11408.942955285502;11449.885501144881;11579.768404631692;11734.765304694029;11857.881421186023;11773.17587768848;11847.407629618658;11915.82126268124;12154.878451215374;12168.2699038058;7348.448866335153;8682.218600326001;8698.130186981505;8732.956335218283;8833.823323533365;11465.885341146815;11507.539698412305;11665.941670291595;11964.92315691592;12040.277583345027 02:32:12 INFO - PROCESS | 1692 | |3;mootools.html;1488.0699562773266;1618.878584106192;1649.9917500412496;1913.3398977352817;2017.727606773086;8357.582120893954;8856.601452934618;8995.100489951;9004.414713043656;9005.50469724165;8851.778705532364;8936.64253429862;9015.143561361676;9020.052894446088;9026.323025773061;2528.6333481645197;2542.5931850903858;2550.1711943618307;2554.131595257612;2558.8592627405487;2490.5018996200833;2551.655526503926;2553.3488960315094;2556.4887022595462;2569.409035921739;2532.987335063322;2558.0918773835206;2568.7431256874256;2572.0740533407957;2575.5364034473787;2515.9874200629065;2549.2097449790626;2552.8978840846344;2554.3869471326934;2562.1929092335854;2179.422453049943;2507.9591969332705;2522;2522.6972763268527;2552.2470871092887;8937.776555586097;9191.908080919173;9224.215941644969;9247.49138797366;9261.72214833556;5636.549076073904;5732.914006289909;5744.770209191627;5763.106718458645;5786.913196302059;3620.3845346291196;3689.7786132831848;3740.8503659853573;3753.8498460061564;3773.433984902259;949.7815502434479;1067.0769784136744;1090.7600327927844;1093.4751319366749;1113.4098927568402;12327.198732082476;12394.504219831286;12400.627981160489;12411.813822792756;12439.626811195589;3983.721139520264;4690.554397332248;4785.59322457588;4843.07981483517;4854.83008094715;9632.27757918145;9643.566039528238;9653.324267301363;9658.227341812639;9661.32370734056;5503.669779813224;5530.2810634618045;5540.833774986757;5542.168674698747;5544.889102217933;4662.044280922402;4759.976605029935;5124.410692770379;5163.922541161885;5190.714510701872;3436.9828150859084;3994.820233089518;4027.778472184058;4119.649829764504;4120.361343991686;1244.0607341457323;1256.8617452080264;1258.6790368456168;1259.030546479224;1274.6112435707014;882.594006756899;933.9813203735887;944.1361303324791;962.9855552166723;986.5856340337076;6029.638221706711;6077.1491991121275;6173.876522469525;6199.132121502993;6309.62142271456;466.4682262221071;472.8817795551112;485.3738677106493;487.16451286044605;493.5582653525075;3737.7009839212797;4034.1931613677384;4082.510098788164;4085.836566537365;4145.751254924714;11104.111671066295;11466.54133834654;11478.827817582744;11503.539858405737;11514.654560363202;10906.781864362669;11245.381504017358;11254.662360129209;11343.489542970587;11396.316221026766;8698.739037828875;8702.47785132894;8719.47683139001;8889.599968001456;8894.777630559158;5111.514406131411;5938.317093534126;5950.018246989372;5953.315368732651;6069.119977603311;10009.949950250202;10142.847857282295;10221.795564088528;10243.975602439696;10301.536430860479;10050.195984321383;10335.22485813552;10448.164146868385;10657.040866322068;10657.93420657928;7089.255628158969;7330.780076597711;7359.337659610661;7368.59472729005;7373.668184931798;8556.315494760529;8601.096884827002;8638.78403039929;8648.264897483532;8648.394612377073;7463.6641351140415;7609.353204977418;7615.5430674159725;7705.267999540035;7902.762917112495;7402.222766609644;7458.47790654649;7468.253174682488;7588.620568971419;7624.961875190588;7195.640217989185;7215.386692131227;7231.457640676865;7247.311505406978;7262.273772622907;4282.63597594208;4801.423829140525;4868.294097355934;5007.84976450707;5017.0216807722145;4513.984353520432;5037.19404895215;5042.067217564762;5049.116404629101;5092.210707340369 02:32:12 INFO - PROCESS | 1692 | |4;prototype.html;333.01593790349517;337.2025160495429;343.97495463518703;345.48350216426445;347.5950517646941;5508.944910550893;6793.048973143764;6804.3876051155385;6804.591724496534;6807.455403567715;6668.366505182012;6751.2911144329755;6760.323967603237;6787.72849086036;6793.218779840307;4797.90404191916;4900.411950565937;4910.975445122769;4963.25551167326;4966.701997880121;4935.235038569028;4996.4503904570465;5002.424721157059;5011.123053465647;5011.198208286675;4921.458639549646;4925.162722337193;4936.827211047614;4939.25911113334;4975.776090075937;4746.952530474703;4823.300621409893;4953.678010929314;4962.578180854632;4976.950230497721;3909.2963266612;4249.745015299092;4255.702100852942;4256.553061928484;4269.188854117708;5486.670799752028;6463.450606698436;6523.086767852505;6528.08606795049;6554.147960765118;5839.620424672383;5880.323762767293;5889.79385721502;5898.557608179403;5916.881662366729;6884.242733299383;7183.928160718378;7188.5327453715345;7193.964030179868;7204.963975180143;4635.559621835921;4653.348531205634;4660;4665.113628410591;4666.416697912761;7484.663190156456;7581.507202031906;7596;7612;7615.504992175491;4706.647001474835;4709.058188362341;4728.716277023321;4729.172394830891;4732.479427263067;4264.722793018444;4678.760128565933;4797.784099715521;4815.590674792682;4827.986122914227;4433.246348120827;4828.8792780180775;5737.885242295214;5752.942470575241;5770.942290577041;6979.162500499972;7218.60297683622;7265.854682906418;7298;7344.265573442613;1639;1675.8156602773686;1676.8239334869663;1683.4781217822515;1685.7302831546895;1000.9549570269355;1011.3982180602529;1039.745262410699;1044.7074819050679;1073.9785204296027;6654.334566543307;6737.595744255263;6747.561408508432;6771.255161932184;6884.862302753917;7460;7470.215627359049;7493.66278517468;7522.435817313723;7607.201243869314;6909.585424874524;6922.5154239203775;6935.826604334831;6958.095447591781;7053.294670533009;3854.3447613905705;3972.7020473464604;4004.6796256299426;4010.598940106024;4019.3569028955812;7854.175311592315;7861.646225919847;7880.2513761192595;7901.130875603679;7905.960470197612;7796.454248202572;7798.947142135739;7826.2173782621285;7833.412494062968;7838.176991415933;7940.6029698515995;7944.483608565425;7954.880676789853;7960.2039796019935;7969.880451793228;7267.963660181877;7479.513831600929;7498;7560.773176804704;7571.46999710015;7388.084315312893;7435.665395057127;7443.516171448839;7443.888341674771;7458.552486850806;7925.603719814101;7941.444098913021;7943.44395892282;7945.920540794749;7946.364290856834;4732.834350797705;4766.666333356632;4780.713157210578;4782.713037217778;4794.520547945178;7327.303906128909;7535.623218839146;7590;7623.504472209289;7650.540967541965;7278.308560686726;7297;7298.708051677873;7309.488335816654;7314.195438501867;7310.122785265802;7317.524360916524;7326.3406293433845;7328.193898671036;7335.376492998155;5845.678487683048;7156.499045067004;7157.463190260647;7158.713651453883;7172.748953786592;7008.824779380352;7261.056062711814;7265.600391978492;7291.781246562611;7295.97856300129;6828.965855170891;6945.895811562729;6948.826279342855;6951.270116637883;6969.58182509051 02:32:12 INFO - PROCESS | 1692 | |5;yui.html;673.6160388578512;721.8195451137216;762.3824701991384;797.3581267080002;830.0869044051542;15353.385864565418;15505.302261398236;15544.06735595865;15546.844531554681;15633.843661563382;14576.052556583814;14662.780058299135;14667.853321466782;15497.69004619907;16597.751033734505;958.3195930889077;965.4641673870999;977.9608815647366;977.9755506112333;980.5734505490135;965.1410244882061;969.9903000970006;970.5389939778584;973.255459573427;973.274910191908;1027.126942099217;1028.5834237133972;1030.067788651268;1031.5461197073264;1031.5925209542227;1019.0013786489282;1020.117598277492;1020.9030142136522;1021.6985989133224;1022.161827301613;758.7989182866545;760.0385512326911;760.1448370583093;760.7109298466603;761.2387612387612;14821.184834834079;14826.33281502335;14861.479848205261;14875.553733388017;15956.281967311383;12285.447154878051;12320.81518777219;12358.505659773598;12585.056120790978;13417.798733018915;8414.78963025923;9927.305088643798;9992.600295988224;10361.171106311476;10733.892661073445;3441.5009823575692;3499.142710036032;3525.065857547752;3527.382708026111;3610.8916732497805;69878;72168;73263.53472930565;77913.22086779174;78585.82121268129;9473.431594104375;9512.571934262975;9612.567434465465;10016.599336026477;10194.745131371626;21507.247246346302;21558.353249402542;21953.012114454887;22203.44491387696;22237.444063898532;7724.0731112266885;7794;8035;8085.716999904975;8135.7152499662225;4200.4539409876525;4281.507626622978;4292.871213863589;4370.519242883281;4409.536998615164;3082.676318986519;3717.9628203717616;3762.360398732222;3768.2275133597545;3779.281936432069;669.1835960128635;672.5561129654404;677.7593954146306;691.2499937567795;698.4307789151825;508.79648140743257;571.245955338957;590.5954421221477;603.3604379357807;623.0933991043022;8034.758957231293;8155.836883262302;8290.212429819157;8294;8630.09384014682;596.0701305962712;605.4460168945453;605.6003037994902;610.5451438678214;610.8869859076085;3692.095436618046;3722.4230244312175;3866.8839934802;3923.4507168996365;4017.89053267715;87517.56241218753;88427;88856;92947.53526232326;93639.53180234191;61168;71598.56802863913;77505;78747.21252787513;79226.6038669803;65431.67284163549;68726.9690954636;69330.65334673395;69788;70021.2997870025;7901.881471777813;8122.781582762633;8428.367872409717;8481.745547633582;8608.61261243258;38394.616053839105;47191.05617887692;47967.520324797704;49547.752261238464;50705.62908627084;60872.69563652154;66282;66441;67758.66120669563;67777.66111169412;10815.945920270664;10933.945330273298;11060.115190784878;11152.16358773079;11547.249428787101;11841.714364936244;11867.762644746885;12063.40077639669;12103.455344509342;12302.261864288172;11324.943375283401;11367.033802126913;11402.885971140182;11477.827832582685;11732.002779763474;11241.60654377093;11319.320840749251;11621;11765.647030589096;11881;11101.333919964827;11216.158788090763;11335.206535542762;11416.200865939305;12246.816297755362;9637.42175469474;9781.706548803548;9819.312648114848;9962.352730546207;9994.100530951959;9398.67104651334;9671.758206044906;9688.75778105553;9869.062439068277;9935.610847748809 02:32:12 INFO - PROCESS | 1692 | __end_tp_report 02:32:12 INFO - PROCESS | 1692 | __start_cc_report 02:32:12 INFO - PROCESS | 1692 | _x_x_mozilla_cycle_collect,1497 02:32:12 INFO - PROCESS | 1692 | __end_cc_report 02:32:12 INFO - PROCESS | 1692 | __startTimestamp1468229532083__endTimestamp 02:32:12 INFO - PROCESS | 1692 | 02:32:12 INFO - PROCESS | 1692 | ------- Summary: start ------- 02:32:12 INFO - PROCESS | 1692 | Number of tests: 6 02:32:12 INFO - PROCESS | 1692 | 02:32:12 INFO - PROCESS | 1692 | [#0] dojo.html Cycles:165 Average:5884.62 Median:6156.97 stddev:626.63 (10.2%) stddev-sans-first:594.07 02:32:12 INFO - PROCESS | 1692 | Values: 3271.2 3594.1 3603.8 3605.8 3694.6 5929.8 5947.8 5949.5 5952.7 5986.7 5872.5 5898.1 5936.4 5939.2 5941.2 5108.3 5229.4 5293.1 5373.2 5419.4 5351.8 5400.6 5410.0 5414.4 5432.2 5327.9 5343.8 5368.5 5391.5 5408.2 5385.4 5402.1 5411.5 5421.7 5485.8 5195.2 5327.1 5331.0 5356.9 5357.1 5707.8 5743.5 5774.2 5806.8 5879.4 6315.3 6319.4 6322.0 6339.2 6348.7 6228.1 6262.3 6315.1 6326.6 6326.8 5950.8 6016.9 6025.1 6031.1 6053.6 6328.3 6366.0 6367.6 6389.1 6393.2 6102.1 6177.1 6332.9 6333.2 6337.2 6258.5 6277.5 6310.2 6327.8 6366.3 6288.0 6297.3 6328.2 6328.6 6331.0 6270.9 6296.6 6317.1 6319.9 6347.1 4939.1 4972.1 5002.5 5011.7 5073.5 4522.3 4536.8 4543.4 4559.5 4574.8 5943.0 5949.9 5953.9 5965.2 5972.2 6164.5 6283.4 6299.9 6300.4 6316.3 5918.3 5946.6 5950.4 5951.8 5971.3 5512.3 5561.6 5572.0 5587.9 5588.6 6461.2 6461.3 6477.8 6478.1 6498.2 6244.4 6256.8 6265.0 6310.0 6321.0 6407.1 6488.7 6489.1 6489.2 6496.8 5261.8 6283.5 6310.1 6325.9 6332.0 6240.5 6266.7 6305.5 6312.3 6324.2 6118.8 6245.2 6305.3 6311.0 6311.4 6284.7 6285.0 6286.2 6287.2 6297.7 6036.1 6103.7 6132.3 6157.0 6158.3 6189.9 6206.2 6244.8 6254.2 6341.2 6115.4 6184.0 6197.9 6198.6 6204.4 02:32:12 INFO - PROCESS | 1692 | 02:32:12 INFO - PROCESS | 1692 | [#1] ext.html Cycles:180 Average:66677.23 Median:37416.94 stddev:142965.83 (382.1%) stddev-sans-first:143280.62 02:32:12 INFO - PROCESS | 1692 | Values: 529.1 544.0 546.7 596.6 629.3 32466.4 33056.7 33103.8 33174.7 33178.5 32727.0 33023.0 33071.0 42287.4 43027.0 9578.8 9722.6 9746.4 9755.0 9756.2 9669.8 9802.7 9809.5 9813.5 9831.9 9245.1 9420.0 9427.0 9434.0 9763.4 11892.6 12078.3 12098.9 12100.3 12119.2 11585.2 11725.8 11726.9 11738.2 11741.0 40567.4 40802.0 40942.6 40993.4 41049.8 3218.0 3425.7 3863.9 3880.8 3931.8 29527.0 29960.0 30625.5 30629.0 30926.4 2367.3 2748.8 2771.0 2771.0 2801.9 461586.0 463081.0 463565.0 464668.0 466088.0 38125.9 69913.7 70561.6 70634.9 70839.0 37238.0 37368.0 37414.6 37419.3 37535.4 17012.7 17170.9 17206.2 17227.7 17239.3 12695.8 14531.2 14705.3 14710.3 14740.6 8584.2 8617.1 8629.6 8689.7 8691.5 3289.9 3358.2 3425.2 3439.6 3495.6 992.9 1009.3 1056.7 1072.8 1079.3 27043.1 30838.7 31985.4 33360.0 34668.8 1117.6 1156.2 1165.8 1202.2 1277.6 15927.8 16077.2 16149.6 16526.3 16611.7 632984.0 637699.8 637877.0 637975.0 640666.0 63658.0 64305.7 64324.4 64373.0 64377.7 1418.2 1475.9 1492.0 1538.5 1611.0 30655.2 30786.4 30953.8 31799.8 31819.8 53126.7 53997.5 54047.7 54143.0 54177.0 484582.0 486930.0 490225.0 490369.0 491832.0 35551.8 44705.0 45402.3 45440.5 45584.0 45381.1 46094.6 46205.0 47025.5 47140.8 34292.1 36516.3 37533.4 40302.0 40541.8 37394.0 38564.4 38601.6 39146.6 39421.4 37715.9 38348.6 38355.0 38366.6 38882.4 32803.5 33610.2 34168.8 34185.1 34349.5 25402.1 25416.5 25425.5 25785.8 25855.6 02:32:12 INFO - PROCESS | 1692 | 02:32:12 INFO - PROCESS | 1692 | [#2] jquery.html Cycles:180 Average:37087.95 Median:22557.16 stddev:108537.19 (481.2%) stddev-sans-first:108806.71 02:32:12 INFO - PROCESS | 1692 | Values: 405.3 412.6 412.6 416.1 424.6 16066.5 20920.3 21565.0 21630.7 21694.7 21081.3 21317.3 22514.5 22550.0 22564.3 5610.9 6063.7 6072.7 6075.5 6076.3 6003.5 6007.4 6065.7 6068.9 6076.6 4322.0 5007.0 6608.0 6610.5 6616.4 6510.5 6559.5 6581.6 6587.5 6592.1 5601.0 5730.6 5750.1 5761.4 5762.7 25747.8 26117.9 26602.9 26826.9 26885.7 2020.1 2095.6 2168.3 2421.8 2434.7 10336.6 10656.3 11155.6 11655.5 15639.5 1743.1 1820.5 1827.1 1875.3 1897.5 123812.0 126187.0 128529.0 129193.0 129290.4 11842.6 12075.2 12075.3 12096.3 12258.8 14098.4 14626.0 14678.0 15880.6 15923.6 6509.3 7580.3 8547.2 9356.5 9387.0 9262.4 9281.6 9305.3 9395.2 9400.3 4761.4 4838.4 4844.5 4851.4 4876.6 1699.8 1726.0 2066.5 2093.4 2098.6 919.5 936.5 940.1 988.2 1007.8 19658.3 20368.9 20702.4 20769.8 20819.0 965.5 967.8 971.5 985.9 1039.8 8955.7 9453.6 11153.3 11161.4 11193.7 634010.8 645633.9 658187.0 659978.0 661736.0 124138.0 127244.0 129821.0 134828.7 138115.0 1051.9 1064.5 1083.3 1087.7 1090.7 18455.3 18899.6 19094.6 19169.9 19430.9 51770.7 52048.7 55647.7 56511.4 58646.5 72313.6 73622.6 73773.3 75698.0 75898.9 8213.4 8313.5 8351.6 8455.7 8660.6 8621.3 12149.3 13201.4 13488.1 13531.4 11374.7 11669.4 11917.3 11968.9 11998.4 11408.9 11449.9 11579.8 11734.8 11857.9 11773.2 11847.4 11915.8 12154.9 12168.3 7348.4 8682.2 8698.1 8733.0 8833.8 11465.9 11507.5 11665.9 11964.9 12040.3 02:32:12 INFO - PROCESS | 1692 | 02:32:12 INFO - PROCESS | 1692 | [#3] mootools.html Cycles:180 Average:5882.86 Median:2670.10 stddev:3336.67 (125.0%) stddev-sans-first:3329.68 02:32:12 INFO - PROCESS | 1692 | Values: 1488.1 1618.9 1650.0 1913.3 2017.7 8357.6 8856.6 8995.1 9004.4 9005.5 8851.8 8936.6 9015.1 9020.1 9026.3 2528.6 2542.6 2550.2 2554.1 2558.9 2490.5 2551.7 2553.3 2556.5 2569.4 2533.0 2558.1 2568.7 2572.1 2575.5 2516.0 2549.2 2552.9 2554.4 2562.2 2179.4 2508.0 2522.0 2522.7 2552.2 8937.8 9191.9 9224.2 9247.5 9261.7 5636.5 5732.9 5744.8 5763.1 5786.9 3620.4 3689.8 3740.9 3753.8 3773.4 949.8 1067.1 1090.8 1093.5 1113.4 12327.2 12394.5 12400.6 12411.8 12439.6 3983.7 4690.6 4785.6 4843.1 4854.8 9632.3 9643.6 9653.3 9658.2 9661.3 5503.7 5530.3 5540.8 5542.2 5544.9 4662.0 4760.0 5124.4 5163.9 5190.7 3437.0 3994.8 4027.8 4119.6 4120.4 1244.1 1256.9 1258.7 1259.0 1274.6 882.6 934.0 944.1 963.0 986.6 6029.6 6077.1 6173.9 6199.1 6309.6 466.5 472.9 485.4 487.2 493.6 3737.7 4034.2 4082.5 4085.8 4145.8 11104.1 11466.5 11478.8 11503.5 11514.7 10906.8 11245.4 11254.7 11343.5 11396.3 8698.7 8702.5 8719.5 8889.6 8894.8 5111.5 5938.3 5950.0 5953.3 6069.1 10009.9 10142.8 10221.8 10244.0 10301.5 10050.2 10335.2 10448.2 10657.0 10657.9 7089.3 7330.8 7359.3 7368.6 7373.7 8556.3 8601.1 8638.8 8648.3 8648.4 7463.7 7609.4 7615.5 7705.3 7902.8 7402.2 7458.5 7468.3 7588.6 7625.0 7195.6 7215.4 7231.5 7247.3 7262.3 4282.6 4801.4 4868.3 5007.8 5017.0 4514.0 5037.2 5042.1 5049.1 5092.2 02:32:12 INFO - PROCESS | 1692 | 02:32:12 INFO - PROCESS | 1692 | [#4] prototype.html Cycles:180 Average:5928.94 Median:6793.13 stddev:1929.17 (28.4%) stddev-sans-first:1888.31 02:32:12 INFO - PROCESS | 1692 | Values: 333.0 337.2 344.0 345.5 347.6 5508.9 6793.0 6804.4 6804.6 6807.5 6668.4 6751.3 6760.3 6787.7 6793.2 4797.9 4900.4 4911.0 4963.3 4966.7 4935.2 4996.5 5002.4 5011.1 5011.2 4921.5 4925.2 4936.8 4939.3 4975.8 4747.0 4823.3 4953.7 4962.6 4977.0 3909.3 4249.7 4255.7 4256.6 4269.2 5486.7 6463.5 6523.1 6528.1 6554.1 5839.6 5880.3 5889.8 5898.6 5916.9 6884.2 7183.9 7188.5 7194.0 7205.0 4635.6 4653.3 4660.0 4665.1 4666.4 7484.7 7581.5 7596.0 7612.0 7615.5 4706.6 4709.1 4728.7 4729.2 4732.5 4264.7 4678.8 4797.8 4815.6 4828.0 4433.2 4828.9 5737.9 5752.9 5770.9 6979.2 7218.6 7265.9 7298.0 7344.3 1639.0 1675.8 1676.8 1683.5 1685.7 1001.0 1011.4 1039.7 1044.7 1074.0 6654.3 6737.6 6747.6 6771.3 6884.9 7460.0 7470.2 7493.7 7522.4 7607.2 6909.6 6922.5 6935.8 6958.1 7053.3 3854.3 3972.7 4004.7 4010.6 4019.4 7854.2 7861.6 7880.3 7901.1 7906.0 7796.5 7798.9 7826.2 7833.4 7838.2 7940.6 7944.5 7954.9 7960.2 7969.9 7268.0 7479.5 7498.0 7560.8 7571.5 7388.1 7435.7 7443.5 7443.9 7458.6 7925.6 7941.4 7943.4 7945.9 7946.4 4732.8 4766.7 4780.7 4782.7 4794.5 7327.3 7535.6 7590.0 7623.5 7650.5 7278.3 7297.0 7298.7 7309.5 7314.2 7310.1 7317.5 7326.3 7328.2 7335.4 5845.7 7156.5 7157.5 7158.7 7172.7 7008.8 7261.1 7265.6 7291.8 7296.0 6829.0 6945.9 6948.8 6951.3 6969.6 02:32:12 INFO - PROCESS | 1692 | 02:32:12 INFO - PROCESS | 1692 | [#5] yui.html Cycles:180 Average:17884.83 Median:580.92 stddev:24545.54 (4225.3%) stddev-sans-first:24580.38 02:32:12 INFO - PROCESS | 1692 | Values: 673.6 721.8 762.4 797.4 830.1 15353.4 15505.3 15544.1 15546.8 15633.8 14576.1 14662.8 14667.9 15497.7 16597.8 958.3 965.5 978.0 978.0 980.6 965.1 970.0 970.5 973.3 973.3 1027.1 1028.6 1030.1 1031.5 1031.6 1019.0 1020.1 1020.9 1021.7 1022.2 758.8 760.0 760.1 760.7 761.2 14821.2 14826.3 14861.5 14875.6 15956.3 12285.4 12320.8 12358.5 12585.1 13417.8 8414.8 9927.3 9992.6 10361.2 10733.9 3441.5 3499.1 3525.1 3527.4 3610.9 69878.0 72168.0 73263.5 77913.2 78585.8 9473.4 9512.6 9612.6 10016.6 10194.7 21507.2 21558.4 21953.0 22203.4 22237.4 7724.1 7794.0 8035.0 8085.7 8135.7 4200.5 4281.5 4292.9 4370.5 4409.5 3082.7 3718.0 3762.4 3768.2 3779.3 669.2 672.6 677.8 691.2 698.4 508.8 571.2 590.6 603.4 623.1 8034.8 8155.8 8290.2 8294.0 8630.1 596.1 605.4 605.6 610.5 610.9 3692.1 3722.4 3866.9 3923.5 4017.9 87517.6 88427.0 88856.0 92947.5 93639.5 61168.0 71598.6 77505.0 78747.2 79226.6 65431.7 68727.0 69330.7 69788.0 70021.3 7901.9 8122.8 8428.4 8481.7 8608.6 38394.6 47191.1 47967.5 49547.8 50705.6 60872.7 66282.0 66441.0 67758.7 67777.7 10815.9 10933.9 11060.1 11152.2 11547.2 11841.7 11867.8 12063.4 12103.5 12302.3 11324.9 11367.0 11402.9 11477.8 11732.0 11241.6 11319.3 11621.0 11765.6 11881.0 11101.3 11216.2 11335.2 11416.2 12246.8 9637.4 9781.7 9819.3 9962.4 9994.1 9398.7 9671.8 9688.8 9869.1 9935.6 02:32:12 INFO - PROCESS | 1692 | -------- Summary: end -------- 02:32:12 INFO - PROCESS | 1692 | 02:32:12 INFO - TEST-INFO | 1692: exit 0 02:32:12 INFO - TEST-OK | dromaeo_css | took 1113775ms 02:32:12 INFO - TEST-START | kraken 02:32:12 INFO - operating with platform_type : mac_ 02:32:12 INFO - Initialising browser for kraken test... 02:32:12 INFO - TEST-INFO | started process 1698 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/tmpNbJn7c/profile http://localhost:49277/getInfo.html) 02:32:14 INFO - PROCESS | 1698 | __metrics Screen width/height:1600/1200 02:32:14 INFO - PROCESS | 1698 | colorDepth:24 02:32:14 INFO - PROCESS | 1698 | Browser inner width/height: 1024/689 02:32:14 INFO - PROCESS | 1698 | __metrics 02:32:14 INFO - PROCESS | 1698 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 02:32:14 ERROR - PROCESS | 1698 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 02:32:15 INFO - TEST-INFO | 1698: exit 0 02:32:15 INFO - Browser initialized. 02:32:15 INFO - Running cycle 1/1 for kraken test... 02:32:15 INFO - TEST-INFO | started process 1701 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/tmpNbJn7c/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:32:27 INFO - PROCESS | 1701 | RSS: Main: 162172928 02:32:27 INFO - PROCESS | 1701 | 02:32:29 INFO - PROCESS | 1701 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49277/tests/kraken/driver.html?testName=audio-beat-detection) 02:32:30 INFO - PROCESS | 1701 | RSS: Main: 223535104 02:32:30 INFO - PROCESS | 1701 | 02:32:33 INFO - PROCESS | 1701 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49277/tests/kraken/driver.html?testName=audio-dft) 02:32:34 INFO - PROCESS | 1701 | RSS: Main: 239403008 02:32:34 INFO - PROCESS | 1701 | 02:32:37 INFO - PROCESS | 1701 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49277/tests/kraken/driver.html?testName=audio-fft) 02:32:37 INFO - PROCESS | 1701 | RSS: Main: 325804032 02:32:37 INFO - PROCESS | 1701 | 02:32:40 INFO - PROCESS | 1701 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49277/tests/kraken/driver.html?testName=audio-oscillator) 02:32:40 INFO - PROCESS | 1701 | RSS: Main: 230338560 02:32:40 INFO - PROCESS | 1701 | 02:32:42 INFO - PROCESS | 1701 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49277/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:32:43 INFO - PROCESS | 1701 | RSS: Main: 230023168 02:32:43 INFO - PROCESS | 1701 | 02:32:46 INFO - PROCESS | 1701 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49277/tests/kraken/driver.html?testName=imaging-darkroom) 02:32:46 INFO - PROCESS | 1701 | RSS: Main: 268816384 02:32:46 INFO - PROCESS | 1701 | 02:32:49 INFO - PROCESS | 1701 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49277/tests/kraken/driver.html?testName=imaging-desaturate) 02:32:50 INFO - PROCESS | 1701 | RSS: Main: 269283328 02:32:50 INFO - PROCESS | 1701 | 02:32:52 INFO - PROCESS | 1701 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49277/tests/kraken/driver.html?testName=json-parse-financial) 02:32:53 INFO - PROCESS | 1701 | RSS: Main: 269123584 02:32:53 INFO - PROCESS | 1701 | 02:32:55 INFO - PROCESS | 1701 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49277/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:32:55 INFO - PROCESS | 1701 | RSS: Main: 260575232 02:32:55 INFO - PROCESS | 1701 | 02:32:57 INFO - PROCESS | 1701 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:32:58 INFO - PROCESS | 1701 | RSS: Main: 267517952 02:32:58 INFO - PROCESS | 1701 | 02:33:00 INFO - PROCESS | 1701 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:33:00 INFO - PROCESS | 1701 | RSS: Main: 270946304 02:33:00 INFO - PROCESS | 1701 | 02:33:03 INFO - PROCESS | 1701 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:33:04 INFO - PROCESS | 1701 | RSS: Main: 278073344 02:33:04 INFO - PROCESS | 1701 | 02:33:07 INFO - PROCESS | 1701 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:33:07 INFO - PROCESS | 1701 | RSS: Main: 274923520 02:33:07 INFO - PROCESS | 1701 | 02:33:09 INFO - PROCESS | 1701 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49277/tests/kraken/driver.html?testName=ai-astar) 02:33:09 INFO - PROCESS | 1701 | RSS: Main: 335998976 02:33:09 INFO - PROCESS | 1701 | 02:33:09 INFO - PROCESS | 1701 | __start_tp_report 02:33:09 INFO - PROCESS | 1701 | _x_x_mozilla_page_load 02:33:09 INFO - PROCESS | 1701 | _x_x_mozilla_page_load_details 02:33:09 INFO - PROCESS | 1701 | |i|pagename|runs| 02:33:09 INFO - PROCESS | 1701 | |0;ai-astar;114;115;120;114;113;113;115;114;113;136 02:33:09 INFO - PROCESS | 1701 | |1;audio-beat-detection;168;121;142;163;118;139;129;149;156;115 02:33:09 INFO - PROCESS | 1701 | |2;audio-dft;186;187;186;184;184;188;184;184;186;187 02:33:09 INFO - PROCESS | 1701 | |3;audio-fft;68;84;99;144;75;74;79;91;140;55 02:33:09 INFO - PROCESS | 1701 | |4;audio-oscillator;90;90;137;78;82;93;121;79;78;125 02:33:09 INFO - PROCESS | 1701 | |5;imaging-gaussian-blur;89;85;120;86;88;85;90;87;87;85 02:33:09 INFO - PROCESS | 1701 | |6;imaging-darkroom;93;99;93;94;93;94;93;125;93;94 02:33:09 INFO - PROCESS | 1701 | |7;imaging-desaturate;84;84;85;86;85;86;84;86;86;83 02:33:09 INFO - PROCESS | 1701 | |8;json-parse-financial;59;63;63;63;63;63;63;82;60;58 02:33:09 INFO - PROCESS | 1701 | |9;json-stringify-tinderbox;60;65;61;73;74;72;66;66;67;67 02:33:09 INFO - PROCESS | 1701 | |10;stanford-crypto-aes;80;81;78;80;78;79;80;78;81;96 02:33:09 INFO - PROCESS | 1701 | |11;stanford-crypto-ccm;146;144;142;136;123;123;125;140;149;170 02:33:09 INFO - PROCESS | 1701 | |12;stanford-crypto-pbkdf2;176;164;163;170;159;162;166;175;160;161 02:33:09 INFO - PROCESS | 1701 | |13;stanford-crypto-sha256-iterative;67;67;69;67;66;69;69;68;67;66 02:33:09 INFO - PROCESS | 1701 | __end_tp_report 02:33:09 INFO - PROCESS | 1701 | __start_cc_report 02:33:09 INFO - PROCESS | 1701 | _x_x_mozilla_cycle_collect,2021 02:33:09 INFO - PROCESS | 1701 | __end_cc_report 02:33:09 INFO - PROCESS | 1701 | __startTimestamp1468229589720__endTimestamp 02:33:09 INFO - PROCESS | 1701 | 02:33:09 INFO - PROCESS | 1701 | ------- Summary: start ------- 02:33:09 INFO - PROCESS | 1701 | Number of tests: 14 02:33:09 INFO - PROCESS | 1701 | 02:33:09 INFO - PROCESS | 1701 | [#0] ai-astar Cycles:10 Average:116.70 Median:114.50 stddev:7.09 (6.2%) stddev-sans-first:7.45 02:33:09 INFO - PROCESS | 1701 | Values: 114.0 115.0 120.0 114.0 113.0 113.0 115.0 114.0 113.0 136.0 02:33:09 INFO - PROCESS | 1701 | 02:33:09 INFO - PROCESS | 1701 | [#1] audio-beat-detection Cycles:10 Average:140.00 Median:145.50 stddev:18.99 (13.1%) stddev-sans-first:17.23 02:33:09 INFO - PROCESS | 1701 | Values: 168.0 121.0 142.0 163.0 118.0 139.0 129.0 149.0 156.0 115.0 02:33:09 INFO - PROCESS | 1701 | 02:33:09 INFO - PROCESS | 1701 | [#2] audio-dft Cycles:10 Average:185.60 Median:186.00 stddev:1.51 (0.8%) stddev-sans-first:1.59 02:33:09 INFO - PROCESS | 1701 | Values: 186.0 187.0 186.0 184.0 184.0 188.0 184.0 184.0 186.0 187.0 02:33:09 INFO - PROCESS | 1701 | 02:33:09 INFO - PROCESS | 1701 | [#3] audio-fft Cycles:10 Average:90.90 Median:77.00 stddev:29.51 (38.3%) stddev-sans-first:30.11 02:33:09 INFO - PROCESS | 1701 | Values: 68.0 84.0 99.0 144.0 75.0 74.0 79.0 91.0 140.0 55.0 02:33:09 INFO - PROCESS | 1701 | 02:33:09 INFO - PROCESS | 1701 | [#4] audio-oscillator Cycles:10 Average:97.30 Median:80.50 stddev:21.97 (27.3%) stddev-sans-first:23.14 02:33:09 INFO - PROCESS | 1701 | Values: 90.0 90.0 137.0 78.0 82.0 93.0 121.0 79.0 78.0 125.0 02:33:09 INFO - PROCESS | 1701 | 02:33:09 INFO - PROCESS | 1701 | [#5] imaging-gaussian-blur Cycles:10 Average:90.20 Median:87.00 stddev:10.61 (12.2%) stddev-sans-first:11.25 02:33:09 INFO - PROCESS | 1701 | Values: 89.0 85.0 120.0 86.0 88.0 85.0 90.0 87.0 87.0 85.0 02:33:09 INFO - PROCESS | 1701 | 02:33:09 INFO - PROCESS | 1701 | [#6] imaging-darkroom Cycles:10 Average:97.10 Median:93.50 stddev:9.97 (10.7%) stddev-sans-first:10.47 02:33:09 INFO - PROCESS | 1701 | Values: 93.0 99.0 93.0 94.0 93.0 94.0 93.0 125.0 93.0 94.0 02:33:09 INFO - PROCESS | 1701 | 02:33:09 INFO - PROCESS | 1701 | [#7] imaging-desaturate Cycles:10 Average:84.90 Median:85.50 stddev:1.10 (1.3%) stddev-sans-first:1.12 02:33:09 INFO - PROCESS | 1701 | Values: 84.0 84.0 85.0 86.0 85.0 86.0 84.0 86.0 86.0 83.0 02:33:09 INFO - PROCESS | 1701 | 02:33:09 INFO - PROCESS | 1701 | [#8] json-parse-financial Cycles:10 Average:63.70 Median:63.00 stddev:6.72 (10.7%) stddev-sans-first:6.91 02:33:09 INFO - PROCESS | 1701 | Values: 59.0 63.0 63.0 63.0 63.0 63.0 63.0 82.0 60.0 58.0 02:33:09 INFO - PROCESS | 1701 | 02:33:09 INFO - PROCESS | 1701 | [#9] json-stringify-tinderbox Cycles:10 Average:67.10 Median:67.00 stddev:4.72 (7.1%) stddev-sans-first:4.26 02:33:09 INFO - PROCESS | 1701 | Values: 60.0 65.0 61.0 73.0 74.0 72.0 66.0 66.0 67.0 67.0 02:33:09 INFO - PROCESS | 1701 | 02:33:09 INFO - PROCESS | 1701 | [#10] stanford-crypto-aes Cycles:10 Average:81.10 Median:80.00 stddev:5.36 (6.7%) stddev-sans-first:5.67 02:33:09 INFO - PROCESS | 1701 | Values: 80.0 81.0 78.0 80.0 78.0 79.0 80.0 78.0 81.0 96.0 02:33:09 INFO - PROCESS | 1701 | 02:33:09 INFO - PROCESS | 1701 | [#11] stanford-crypto-ccm Cycles:10 Average:139.80 Median:143.00 stddev:14.36 (10.0%) stddev-sans-first:15.05 02:33:09 INFO - PROCESS | 1701 | Values: 146.0 144.0 142.0 136.0 123.0 123.0 125.0 140.0 149.0 170.0 02:33:09 INFO - PROCESS | 1701 | 02:33:09 INFO - PROCESS | 1701 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:165.60 Median:165.00 stddev:6.10 (3.7%) stddev-sans-first:5.17 02:33:09 INFO - PROCESS | 1701 | Values: 176.0 164.0 163.0 170.0 159.0 162.0 166.0 175.0 160.0 161.0 02:33:09 INFO - PROCESS | 1701 | 02:33:09 INFO - PROCESS | 1701 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.50 Median:67.50 stddev:1.18 (1.7%) stddev-sans-first:1.24 02:33:09 INFO - PROCESS | 1701 | Values: 67.0 67.0 69.0 67.0 66.0 69.0 69.0 68.0 67.0 66.0 02:33:09 INFO - PROCESS | 1701 | -------- Summary: end -------- 02:33:09 INFO - PROCESS | 1701 | 02:33:10 INFO - TEST-INFO | 1701: exit 0 02:33:10 INFO - TEST-OK | kraken | took 57884ms 02:33:10 INFO - SUITE-END | took 1171s 02:33:10 INFO - Completed test suite (00:19:32) 02:33:10 INFO - javascript benchmark 02:33:10 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3271.165852707559, 3594.0655429588332, 3603.837827297771, 3605.83773730182, 3694.5566532016164, 5929.792457263997, 5947.821565353041, 5949.464548190662, 5952.672603006833, 5986.730597123129, 5872.471477567018, 5898.085796701507, 5936.376680448545, 5939.198208241886, 5941.197938278331, 5108.259302401149, 5229.424763276036, 5293.073712100377, 5373.167159090328, 5419.403865574784, 5351.839444816642, 5400.567954563626, 5409.972950135244, 5414.35027796663, 5432.185172224158, 5327.920081198785, 5343.759530821103, 5368.46315368462, 5391.487808658171, 5408.215808707735, 5385.407605163448, 5402.108652072403, 5411.540019098381, 5421.674699518042, 5485.807996720136, 5195.168772996302, 5327.067763141435, 5330.9733451332495, 5356.91964620531, 5357.116075847481, 5707.77168913243, 5743.5118014968775, 5774.162746401748, 5806.796762113306, 5879.412058794129, 6315.273743519509, 6319.399657032574, 6322.0, 6339.175907132089, 6348.746050157988, 6228.096925945712, 6262.3111457739615, 6315.147455093595, 6326.588771729823, 6326.841828954313, 5950.761969521214, 6016.879662406727, 6025.126356678257, 6031.125486804389, 6053.576249662526, 6328.272248691459, 6366.013267943476, 6367.554271200971, 6389.105525226472, 6393.200849893763, 6102.084687296941, 6177.073438984098, 6332.936670633235, 6333.240011198685, 6337.207849018872, 6258.499320054385, 6277.466415354746, 6310.211223597051, 6327.810165695037, 6366.331535188831, 6287.993920972623, 6297.338779428094, 6328.177336946167, 6328.620282782956, 6330.968345158245, 6270.874582508324, 6296.5592408530965, 6317.052442133717, 6319.905201421982, 6347.143135676624, 4939.135651261086, 4972.129877271463, 5002.549770520671, 5011.724355160428, 5073.518015788494, 4522.276435770326, 4536.750478723702, 4543.409356783597, 4559.54404559548, 4574.771261436915, 5943.049112142036, 5949.881002379928, 5953.910691339634, 5965.224520812353, 5972.223610930638, 6164.506839452833, 6283.403076707706, 6299.874002520016, 6300.432961033529, 6316.30520642729, 5918.348981612019, 5946.554008449383, 5950.4049595041015, 5951.821445356646, 5971.313298970674, 5512.33851937762, 5561.555075593943, 5572.0, 5587.888242235133, 5588.580856435784, 6461.160049193575, 6461.321561236003, 6477.805665830033, 6478.060681201294, 6498.155239818888, 6244.375562443901, 6256.843578910381, 6265.028920517327, 6309.968450157719, 6321.020241862519, 6407.10300557913, 6488.70800813974, 6489.059086432535, 6489.156409666902, 6496.837579060561, 5261.842144735664, 6283.528735344776, 6310.148130002574, 6325.936740632535, 6331.96834015827, 6240.53196010292, 6266.749330026748, 6305.464035556845, 6312.274088479883, 6324.209473815773, 6118.847028824315, 6245.156903817927, 6305.274893387319, 6310.968445157745, 6311.431971122621, 6284.748610055546, 6285.025820997753, 6286.245650521967, 6287.2140982377205, 6297.653629050446, 6036.124761909411, 6103.664298463449, 6132.263729246545, 6156.969215153896, 6158.32258451561, 6189.938100618936, 6206.224221972254, 6244.843878902882, 6254.249490061222, 6341.239051313872, 6115.392460733998, 6184.010558310649, 6197.938020619736, 6198.6280823150755, 6204.410580994799], "value": 5846.009778615298, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [529.0820426559918, 543.9827522532867, 546.7075114813575, 596.624126800116, 629.3329071184542, 32466.350672986526, 33056.66943330566, 33103.834480827565, 33174.66825331746, 33178.50232246518, 32727.0, 33023.0, 33071.00786976388, 42287.365689514685, 43027.0, 9578.760530986729, 9722.562484688171, 9746.415215087081, 9755.024497550223, 9756.219502439822, 9669.75825604362, 9802.656907008257, 9809.50952452378, 9813.460259685715, 9831.852522212173, 9245.07549245077, 9419.952900235488, 9427.0, 9434.009429009959, 9763.414195148278, 11892.643220703392, 12078.27530348182, 12098.879011209863, 12100.334481603508, 12119.151659383846, 11585.246958947642, 11725.765484690259, 11726.882731172664, 11738.237014594024, 11741.0, 40567.39148912769, 40802.0, 40942.590574094174, 40993.38509922354, 41049.794751026355, 3218.0, 3425.743069269815, 3863.942040869389, 3880.767153970771, 3931.8034098295257, 29527.0, 29960.0, 30625.540616890765, 30629.0, 30926.381472370653, 2367.337145599235, 2748.8213266137636, 2771.0, 2771.016289217319, 2801.8739156737997, 461586.0, 463081.0, 463565.0, 464668.0, 466087.9999999966, 38125.85622431276, 69913.65043174854, 70561.64719176371, 70634.9404758929, 70839.0, 37238.0, 37368.0, 37414.62585374166, 37419.25161496755, 37535.436968445494, 17012.744808827876, 17170.914145429444, 17206.225719842638, 17227.741583876254, 17239.310427582757, 12695.809562856564, 14531.200783956772, 14705.26473676312, 14710.264486775619, 14740.631484212767, 8584.184502472255, 8617.138286171332, 8629.611667474854, 8689.695860644848, 8691.478511289217, 3289.884854030145, 3358.1623528118703, 3425.2293234022145, 3439.638837922032, 3495.580530336325, 992.8907820139779, 1009.2985375164191, 1056.6513050693252, 1072.8390741388855, 1079.2822772855964, 27043.053493127645, 30838.69161308403, 31985.360292794016, 33359.99920002404, 34668.82665586656, 1117.6242274658916, 1156.2484385149553, 1165.7668466306773, 1202.2185579373477, 1277.6294874486296, 15927.840721592636, 16077.196140192944, 16149.59626009359, 16526.338946442007, 16611.66776664484, 632984.0, 637699.8115009395, 637877.0, 637975.0, 640666.0, 63658.0, 64305.678471607345, 64324.356756432775, 64373.0, 64377.678111609144, 1418.212891845036, 1475.9188244646648, 1492.037635724973, 1538.476917847937, 1610.9919450402674, 30655.233619158807, 30786.38427231398, 30953.845230773702, 31799.841000794848, 31819.840900796273, 53126.734366327924, 53997.46002540082, 54047.729761352515, 54142.99999999842, 54177.0, 484582.0, 486930.0, 490225.0, 490369.0, 491832.0, 35551.82224088863, 44705.0, 45402.31896521621, 45440.54559454363, 45584.0, 45381.09237815159, 46094.61716148521, 46205.0, 47025.529744702115, 47140.7642961783, 34292.142696431794, 36516.26967460583, 37533.43699844559, 40302.0, 40541.79729101453, 37394.0, 38564.42153367758, 38601.6139838598, 39146.608533914296, 39421.408678869266, 37715.86852394432, 38348.61651383562, 38355.04112397212, 38366.616333837424, 38882.416763749134, 32803.50794738129, 33610.159746006546, 34168.82915585406, 34185.145371365914, 34349.484757728154, 25402.083250189597, 25416.491670166863, 25425.49149017046, 25785.839637216744, 25855.612165817904], "value": 19487.219615698603, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [405.3352501896889, 412.6142057176542, 412.6410023279747, 416.11707025708665, 424.60935938936194, 16066.518004459856, 20920.26779062733, 21565.0, 21630.675539866916, 21694.674579881274, 21081.26215582455, 21317.253896113638, 22514.54970900581, 22550.0, 22564.323070307877, 5610.887782244353, 6063.727132279036, 6072.726727297282, 6075.544334174932, 6076.331603523631, 6003.459688628022, 6007.429294217042, 6065.666388348639, 6068.908966365508, 6076.574639775217, 4321.956780432202, 5006.97496512517, 6608.041833934077, 6610.471162307004, 6616.371444712745, 6510.544261901621, 6559.540832141728, 6581.5721978071515, 6587.50593705474, 6592.143021407211, 5601.0, 5730.6275092119295, 5750.108733146369, 5761.366249712528, 5762.711864406763, 25747.841347139423, 26117.869410652824, 26602.935882564674, 26826.86586567055, 26885.731142688714, 2020.0808632072371, 2095.5913596848623, 2168.3386567097027, 2421.782039616425, 2434.6974368712654, 10336.586536538605, 10656.254062215648, 11155.553777848876, 11655.533778648844, 15639.452619158388, 1743.076169630098, 1820.472063101699, 1827.1412436154985, 1875.3436297295837, 1897.5351038995395, 123812.0, 126187.0, 128529.0, 129193.0, 129290.41419171658, 11842.644720658394, 12075.215111017756, 12075.3358565278, 12096.274223546616, 12258.816117758062, 14098.365573549216, 14626.049306795025, 14678.045927014924, 15880.602984925239, 15923.601909952344, 6509.316521765241, 7580.317771400601, 8547.230749232598, 9356.532173391302, 9387.0, 9262.351635385457, 9281.628734850665, 9305.25557955362, 9395.248380129573, 9400.294977876687, 4761.40482439695, 4838.443578988391, 4844.467108618049, 4851.369321988119, 4876.561109500162, 1699.7960244770459, 1726.0, 2066.4833791552114, 2093.4033800366824, 2098.6432306507627, 919.5080631861922, 936.513013233115, 940.1115945431638, 988.2489308125732, 1007.8236308645958, 19658.311959081362, 20368.879711616002, 20702.378928632166, 20769.792302076785, 20819.0, 965.5124162298135, 967.8161149381735, 971.5190980464715, 985.935914165577, 1039.7556574205055, 8955.686550970684, 9453.574589143505, 11153.275037122561, 11161.386123763108, 11193.66419007431, 634010.8299458566, 645633.8813594818, 658187.0, 659978.0, 661736.0, 124138.0, 127244.0, 129821.0, 134828.65171348356, 138115.0, 1051.8842927277992, 1064.4890452582804, 1083.3283364314018, 1087.6628245243999, 1090.6564432203832, 18455.261789528267, 18899.622007559497, 19094.618107637492, 19169.904150479157, 19430.931298778138, 51770.74114629403, 52048.69878253074, 55647.72176139093, 56511.43488565062, 58646.533836654424, 72313.6384318075, 73622.63188684022, 73773.26226737878, 75698.0, 75898.86151707618, 8213.38399620019, 8313.459625124347, 8351.624176912175, 8455.704050358208, 8660.571005783975, 8621.267192288726, 12149.331786751813, 13201.405936733063, 13488.12327198729, 13531.391087400894, 11374.715632109264, 11669.35818529989, 11917.34454605005, 11968.880311196777, 11998.40007999614, 11408.942955285502, 11449.885501144881, 11579.768404631692, 11734.765304694029, 11857.881421186023, 11773.17587768848, 11847.407629618658, 11915.82126268124, 12154.878451215374, 12168.2699038058, 7348.448866335153, 8682.218600326001, 8698.130186981505, 8732.956335218283, 8833.823323533365, 11465.885341146815, 11507.539698412305, 11665.941670291595, 11964.92315691592, 12040.277583345027], "value": 9922.261102811357, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1488.0699562773266, 1618.878584106192, 1649.9917500412496, 1913.3398977352817, 2017.727606773086, 8357.582120893954, 8856.601452934618, 8995.100489951, 9004.414713043656, 9005.50469724165, 8851.778705532364, 8936.64253429862, 9015.143561361676, 9020.052894446088, 9026.323025773061, 2528.6333481645197, 2542.5931850903858, 2550.1711943618307, 2554.131595257612, 2558.8592627405487, 2490.5018996200833, 2551.655526503926, 2553.3488960315094, 2556.4887022595462, 2569.409035921739, 2532.987335063322, 2558.0918773835206, 2568.7431256874256, 2572.0740533407957, 2575.5364034473787, 2515.9874200629065, 2549.2097449790626, 2552.8978840846344, 2554.3869471326934, 2562.1929092335854, 2179.422453049943, 2507.9591969332705, 2522.0, 2522.6972763268527, 2552.2470871092887, 8937.776555586097, 9191.908080919173, 9224.215941644969, 9247.49138797366, 9261.72214833556, 5636.549076073904, 5732.914006289909, 5744.770209191627, 5763.106718458645, 5786.913196302059, 3620.3845346291196, 3689.7786132831848, 3740.8503659853573, 3753.8498460061564, 3773.433984902259, 949.7815502434479, 1067.0769784136744, 1090.7600327927844, 1093.4751319366749, 1113.4098927568402, 12327.198732082476, 12394.504219831286, 12400.627981160489, 12411.813822792756, 12439.626811195589, 3983.721139520264, 4690.554397332248, 4785.59322457588, 4843.07981483517, 4854.83008094715, 9632.27757918145, 9643.566039528238, 9653.324267301363, 9658.227341812639, 9661.32370734056, 5503.669779813224, 5530.2810634618045, 5540.833774986757, 5542.168674698747, 5544.889102217933, 4662.044280922402, 4759.976605029935, 5124.410692770379, 5163.922541161885, 5190.714510701872, 3436.9828150859084, 3994.820233089518, 4027.778472184058, 4119.649829764504, 4120.361343991686, 1244.0607341457323, 1256.8617452080264, 1258.6790368456168, 1259.030546479224, 1274.6112435707014, 882.594006756899, 933.9813203735887, 944.1361303324791, 962.9855552166723, 986.5856340337076, 6029.638221706711, 6077.1491991121275, 6173.876522469525, 6199.132121502993, 6309.62142271456, 466.4682262221071, 472.8817795551112, 485.3738677106493, 487.16451286044605, 493.5582653525075, 3737.7009839212797, 4034.1931613677384, 4082.510098788164, 4085.836566537365, 4145.751254924714, 11104.111671066295, 11466.54133834654, 11478.827817582744, 11503.539858405737, 11514.654560363202, 10906.781864362669, 11245.381504017358, 11254.662360129209, 11343.489542970587, 11396.316221026766, 8698.739037828875, 8702.47785132894, 8719.47683139001, 8889.599968001456, 8894.777630559158, 5111.514406131411, 5938.317093534126, 5950.018246989372, 5953.315368732651, 6069.119977603311, 10009.949950250202, 10142.847857282295, 10221.795564088528, 10243.975602439696, 10301.536430860479, 10050.195984321383, 10335.22485813552, 10448.164146868385, 10657.040866322068, 10657.93420657928, 7089.255628158969, 7330.780076597711, 7359.337659610661, 7368.59472729005, 7373.668184931798, 8556.315494760529, 8601.096884827002, 8638.78403039929, 8648.264897483532, 8648.394612377073, 7463.6641351140415, 7609.353204977418, 7615.5430674159725, 7705.267999540035, 7902.762917112495, 7402.222766609644, 7458.47790654649, 7468.253174682488, 7588.620568971419, 7624.961875190588, 7195.640217989185, 7215.386692131227, 7231.457640676865, 7247.311505406978, 7262.273772622907, 4282.63597594208, 4801.423829140525, 4868.294097355934, 5007.84976450707, 5017.0216807722145, 4513.984353520432, 5037.19404895215, 5042.067217564762, 5049.116404629101, 5092.210707340369], "value": 4652.843521783813, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [333.01593790349517, 337.2025160495429, 343.97495463518703, 345.48350216426445, 347.5950517646941, 5508.944910550893, 6793.048973143764, 6804.3876051155385, 6804.591724496534, 6807.455403567715, 6668.366505182012, 6751.2911144329755, 6760.323967603237, 6787.72849086036, 6793.218779840307, 4797.90404191916, 4900.411950565937, 4910.975445122769, 4963.25551167326, 4966.701997880121, 4935.235038569028, 4996.4503904570465, 5002.424721157059, 5011.123053465647, 5011.198208286675, 4921.458639549646, 4925.162722337193, 4936.827211047614, 4939.25911113334, 4975.776090075937, 4746.952530474703, 4823.300621409893, 4953.678010929314, 4962.578180854632, 4976.950230497721, 3909.2963266612, 4249.745015299092, 4255.702100852942, 4256.553061928484, 4269.188854117708, 5486.670799752028, 6463.450606698436, 6523.086767852505, 6528.08606795049, 6554.147960765118, 5839.620424672383, 5880.323762767293, 5889.79385721502, 5898.557608179403, 5916.881662366729, 6884.242733299383, 7183.928160718378, 7188.5327453715345, 7193.964030179868, 7204.963975180143, 4635.559621835921, 4653.348531205634, 4660.0, 4665.113628410591, 4666.416697912761, 7484.663190156456, 7581.507202031906, 7596.0, 7612.0, 7615.504992175491, 4706.647001474835, 4709.058188362341, 4728.716277023321, 4729.172394830891, 4732.479427263067, 4264.722793018444, 4678.760128565933, 4797.784099715521, 4815.590674792682, 4827.986122914227, 4433.246348120827, 4828.8792780180775, 5737.885242295214, 5752.942470575241, 5770.942290577041, 6979.162500499972, 7218.60297683622, 7265.854682906418, 7298.0, 7344.265573442613, 1639.0, 1675.8156602773686, 1676.8239334869663, 1683.4781217822515, 1685.7302831546895, 1000.9549570269355, 1011.3982180602529, 1039.745262410699, 1044.7074819050679, 1073.9785204296027, 6654.334566543307, 6737.595744255263, 6747.561408508432, 6771.255161932184, 6884.862302753917, 7460.0, 7470.215627359049, 7493.66278517468, 7522.435817313723, 7607.201243869314, 6909.585424874524, 6922.5154239203775, 6935.826604334831, 6958.095447591781, 7053.294670533009, 3854.3447613905705, 3972.7020473464604, 4004.6796256299426, 4010.598940106024, 4019.3569028955812, 7854.175311592315, 7861.646225919847, 7880.2513761192595, 7901.130875603679, 7905.960470197612, 7796.454248202572, 7798.947142135739, 7826.2173782621285, 7833.412494062968, 7838.176991415933, 7940.6029698515995, 7944.483608565425, 7954.880676789853, 7960.2039796019935, 7969.880451793228, 7267.963660181877, 7479.513831600929, 7498.0, 7560.773176804704, 7571.46999710015, 7388.084315312893, 7435.665395057127, 7443.516171448839, 7443.888341674771, 7458.552486850806, 7925.603719814101, 7941.444098913021, 7943.44395892282, 7945.920540794749, 7946.364290856834, 4732.834350797705, 4766.666333356632, 4780.713157210578, 4782.713037217778, 4794.520547945178, 7327.303906128909, 7535.623218839146, 7590.0, 7623.504472209289, 7650.540967541965, 7278.308560686726, 7297.0, 7298.708051677873, 7309.488335816654, 7314.195438501867, 7310.122785265802, 7317.524360916524, 7326.3406293433845, 7328.193898671036, 7335.376492998155, 5845.678487683048, 7156.499045067004, 7157.463190260647, 7158.713651453883, 7172.748953786592, 7008.824779380352, 7261.056062711814, 7265.600391978492, 7291.781246562611, 7295.97856300129, 6828.965855170891, 6945.895811562729, 6948.826279342855, 6951.270116637883, 6969.58182509051], "value": 5279.918523892831, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [673.6160388578512, 721.8195451137216, 762.3824701991384, 797.3581267080002, 830.0869044051542, 15353.385864565418, 15505.302261398236, 15544.06735595865, 15546.844531554681, 15633.843661563382, 14576.052556583814, 14662.780058299135, 14667.853321466782, 15497.69004619907, 16597.751033734505, 958.3195930889077, 965.4641673870999, 977.9608815647366, 977.9755506112333, 980.5734505490135, 965.1410244882061, 969.9903000970006, 970.5389939778584, 973.255459573427, 973.274910191908, 1027.126942099217, 1028.5834237133972, 1030.067788651268, 1031.5461197073264, 1031.5925209542227, 1019.0013786489282, 1020.117598277492, 1020.9030142136522, 1021.6985989133224, 1022.161827301613, 758.7989182866545, 760.0385512326911, 760.1448370583093, 760.7109298466603, 761.2387612387612, 14821.184834834079, 14826.33281502335, 14861.479848205261, 14875.553733388017, 15956.281967311383, 12285.447154878051, 12320.81518777219, 12358.505659773598, 12585.056120790978, 13417.798733018915, 8414.78963025923, 9927.305088643798, 9992.600295988224, 10361.171106311476, 10733.892661073445, 3441.5009823575692, 3499.142710036032, 3525.065857547752, 3527.382708026111, 3610.8916732497805, 69878.0, 72168.0, 73263.53472930565, 77913.22086779174, 78585.82121268129, 9473.431594104375, 9512.571934262975, 9612.567434465465, 10016.599336026477, 10194.745131371626, 21507.247246346302, 21558.353249402542, 21953.012114454887, 22203.44491387696, 22237.444063898532, 7724.0731112266885, 7794.0, 8035.0, 8085.716999904975, 8135.7152499662225, 4200.4539409876525, 4281.507626622978, 4292.871213863589, 4370.519242883281, 4409.536998615164, 3082.676318986519, 3717.9628203717616, 3762.360398732222, 3768.2275133597545, 3779.281936432069, 669.1835960128635, 672.5561129654404, 677.7593954146306, 691.2499937567795, 698.4307789151825, 508.79648140743257, 571.245955338957, 590.5954421221477, 603.3604379357807, 623.0933991043022, 8034.758957231293, 8155.836883262302, 8290.212429819157, 8294.0, 8630.09384014682, 596.0701305962712, 605.4460168945453, 605.6003037994902, 610.5451438678214, 610.8869859076085, 3692.095436618046, 3722.4230244312175, 3866.8839934802, 3923.4507168996365, 4017.89053267715, 87517.56241218753, 88427.0, 88856.0, 92947.53526232326, 93639.53180234191, 61168.0, 71598.56802863913, 77505.0, 78747.21252787513, 79226.6038669803, 65431.67284163549, 68726.9690954636, 69330.65334673395, 69788.0, 70021.2997870025, 7901.881471777813, 8122.781582762633, 8428.367872409717, 8481.745547633582, 8608.61261243258, 38394.616053839105, 47191.05617887692, 47967.520324797704, 49547.752261238464, 50705.62908627084, 60872.69563652154, 66282.0, 66441.0, 67758.66120669563, 67777.66111169412, 10815.945920270664, 10933.945330273298, 11060.115190784878, 11152.16358773079, 11547.249428787101, 11841.714364936244, 11867.762644746885, 12063.40077639669, 12103.455344509342, 12302.261864288172, 11324.943375283401, 11367.033802126913, 11402.885971140182, 11477.827832582685, 11732.002779763474, 11241.60654377093, 11319.320840749251, 11621.0, 11765.647030589096, 11881.0, 11101.333919964827, 11216.158788090763, 11335.206535542762, 11416.200865939305, 12246.816297755362, 9637.42175469474, 9781.706548803548, 9819.312648114848, 9962.352730546207, 9994.100530951959, 9398.67104651334, 9671.758206044906, 9688.75778105553, 9869.062439068277, 9935.610847748809], "value": 7027.648173256025, "unit": "score"}], "name": "dromaeo_css", "value": 7616.14533664125, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 115.0, 120.0, 114.0, 113.0, 113.0, 115.0, 114.0, 113.0, 136.0], "value": 116.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 121.0, 142.0, 163.0, 118.0, 139.0, 129.0, 149.0, 156.0, 115.0], "value": 140.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [186.0, 187.0, 186.0, 184.0, 184.0, 188.0, 184.0, 184.0, 186.0, 187.0], "value": 185.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 84.0, 99.0, 144.0, 75.0, 74.0, 79.0, 91.0, 140.0, 55.0], "value": 90.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 90.0, 137.0, 78.0, 82.0, 93.0, 121.0, 79.0, 78.0, 125.0], "value": 97.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 85.0, 120.0, 86.0, 88.0, 85.0, 90.0, 87.0, 87.0, 85.0], "value": 90.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 99.0, 93.0, 94.0, 93.0, 94.0, 93.0, 125.0, 93.0, 94.0], "value": 97.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 85.0, 86.0, 85.0, 86.0, 84.0, 86.0, 86.0, 83.0], "value": 84.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 63.0, 63.0, 63.0, 63.0, 63.0, 63.0, 82.0, 60.0, 58.0], "value": 63.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 65.0, 61.0, 73.0, 74.0, 72.0, 66.0, 66.0, 67.0, 67.0], "value": 67.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 81.0, 78.0, 80.0, 78.0, 79.0, 80.0, 78.0, 81.0, 96.0], "value": 81.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 144.0, 142.0, 136.0, 123.0, 123.0, 125.0, 140.0, 149.0, 170.0], "value": 139.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [176.0, 164.0, 163.0, 170.0, 159.0, 162.0, 166.0, 175.0, 160.0, 161.0], "value": 165.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 69.0, 67.0, 66.0, 69.0, 69.0, 68.0, 67.0, 66.0], "value": 67.5, "unit": "score"}], "name": "kraken", "value": 1487.4999999999998, "alertThreshold": 2.0}]} 02:33:10 INFO - Return code: 0 02:33:11 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 02:33:11 ERROR - # TBPL SUCCESS # 02:33:11 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:33:11 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:33:11 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:33:11 INFO - 2016-07-11 02:33:11.044 screenresolution[1705:11559] starting screenresolution argv=screenresolution get 02:33:11 INFO - 2016-07-11 02:33:11.046 screenresolution[1705:11559] Display 0: 1600x1200x32@60 02:33:11 INFO - 2016-07-11 02:33:11.052 screenresolution[1706:11562] starting screenresolution argv=screenresolution list 02:33:11 INFO - Available Modes on Display 0 02:33:11 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:33:11 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:33:11 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:33:11 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:33:11 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:33:11 INFO - Intel Iris: 02:33:11 INFO - Chipset Model: Intel Iris 02:33:11 INFO - Type: GPU 02:33:11 INFO - Bus: Built-In 02:33:11 INFO - VRAM (Dynamic, Max): 1536 MB 02:33:11 INFO - Vendor: Intel (0x8086) 02:33:11 INFO - Device ID: 0x0a2e 02:33:11 INFO - Revision ID: 0x0009 02:33:11 INFO - Displays: 02:33:11 INFO - Display: 02:33:11 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:33:11 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:33:11 INFO - Display Serial Number: 1600x1200 60 02:33:11 INFO - Main Display: Yes 02:33:11 INFO - Mirror: Off 02:33:11 INFO - Online: Yes 02:33:11 INFO - Rotation: Supported 02:33:11 INFO - Return code: 0 02:33:11 INFO - Running post-action listener: _resource_record_post_action 02:33:11 INFO - Running post-run listener: _resource_record_post_run 02:33:12 INFO - Total resource usage - Wall time: 1195s; CPU: 53.0%; Read bytes: 31485440; Write bytes: 495419904; Read time: 197; Write time: 1528 02:33:12 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 191320576; Write bytes: 187602432; Read time: 17583; Write time: 406 02:33:12 INFO - run-tests - Wall time: 1174s; CPU: 53.0%; Read bytes: 29703680; Write bytes: 296975360; Read time: 182; Write time: 1085 02:33:12 INFO - Running post-run listener: _upload_blobber_files 02:33:12 INFO - Blob upload gear active. 02:33:12 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:33:12 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 02:33:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 02:33:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 02:33:12 INFO - (blobuploader) - INFO - Open directory for files ... 02:33:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 02:33:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:33:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:33:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 02:33:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:33:13 INFO - (blobuploader) - INFO - Done attempting. 02:33:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 02:33:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:33:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:33:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 02:33:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:33:14 INFO - (blobuploader) - INFO - Done attempting. 02:33:14 INFO - (blobuploader) - INFO - Iteration through files over. 02:33:14 INFO - Return code: 0 02:33:14 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:33:14 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:33:14 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/6bc5d0c9619a74cffdeee6f9e692faea032406b82bb0e40e9ba71aaa677086a1227fad518a80b9320083d23be7247c48f86d556b654c959151b3404e21d1bfaf", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/574914c25ebaa93b80a6ee5689e10de808c07345205f04395e164eb3bc13597ce2f349fddfdc61556c5764739741edcb877fd656d0cbb2a2f53dc1793eed079b"} 02:33:14 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:33:14 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:33:14 INFO - Contents: 02:33:14 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/6bc5d0c9619a74cffdeee6f9e692faea032406b82bb0e40e9ba71aaa677086a1227fad518a80b9320083d23be7247c48f86d556b654c959151b3404e21d1bfaf", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/574914c25ebaa93b80a6ee5689e10de808c07345205f04395e164eb3bc13597ce2f349fddfdc61556c5764739741edcb877fd656d0cbb2a2f53dc1793eed079b"} 02:33:14 INFO - Running post-run listener: copy_logs_to_upload_dir 02:33:14 INFO - Copying logs to upload dir... 02:33:14 INFO - mkdir: /builds/slave/test/build/upload/logs 02:33:14 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1288.724507 ========= master_lag: 0.17 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 28 secs) (at 2016-07-11 02:33:14.575568) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-11 02:33:14.579142) ========= 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.lNKEEBfguE/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.BYspLJTwOg/Listeners TMPDIR=/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/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/6bc5d0c9619a74cffdeee6f9e692faea032406b82bb0e40e9ba71aaa677086a1227fad518a80b9320083d23be7247c48f86d556b654c959151b3404e21d1bfaf", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/574914c25ebaa93b80a6ee5689e10de808c07345205f04395e164eb3bc13597ce2f349fddfdc61556c5764739741edcb877fd656d0cbb2a2f53dc1793eed079b"} build_url:https://queue.taskcluster.net/v1/task/MsYJ-h_TQfKhwJ0FdpDiJA/artifacts/public/build/firefox-48.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011018 build_url: 'https://queue.taskcluster.net/v1/task/MsYJ-h_TQfKhwJ0FdpDiJA/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/6bc5d0c9619a74cffdeee6f9e692faea032406b82bb0e40e9ba71aaa677086a1227fad518a80b9320083d23be7247c48f86d556b654c959151b3404e21d1bfaf", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/574914c25ebaa93b80a6ee5689e10de808c07345205f04395e164eb3bc13597ce2f349fddfdc61556c5764739741edcb877fd656d0cbb2a2f53dc1793eed079b"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-11 02:33:14.611615) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-11 02:33:14.611951) ========= 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.lNKEEBfguE/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.BYspLJTwOg/Listeners TMPDIR=/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/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.005286 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-11 02:33:14.660769) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-11 02:33:14.661080) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-11 02:33:14.661425) ========= ========= Total master_lag: 0.82 =========