builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0214 starttime: 1463145867.84 results: success (0) buildid: 20160513041937 builduid: 8cc8e7f6a55d4b3da4a46c0d62493492 revision: 3e9245c2bfaa9089cd3cc9e691159c091eb21e28 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-13 06:24:27.840389) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-13 06:24:27.840823) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-13 06:24:27.841107) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-13 06:24:27.910821) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-13 06:24:27.911099) ========= 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.ZRWZ7NMchd/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.JHDtPFup3Y/Listeners TMPDIR=/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-05-13 06:24:27-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 19.3M=0.001s 2016-05-13 06:24:28 (19.3 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.619453 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-13 06:24:28.548266) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-13 06:24:28.548677) ========= 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.ZRWZ7NMchd/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.JHDtPFup3Y/Listeners TMPDIR=/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/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.025223 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-13 06:24:28.598405) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-13 06:24:28.598706) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 3e9245c2bfaa9089cd3cc9e691159c091eb21e28 --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 3e9245c2bfaa9089cd3cc9e691159c091eb21e28 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.ZRWZ7NMchd/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.JHDtPFup3Y/Listeners TMPDIR=/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-05-13 06:24:28,661 truncating revision to first 12 chars 2016-05-13 06:24:28,661 Setting DEBUG logging. 2016-05-13 06:24:28,661 attempt 1/10 2016-05-13 06:24:28,662 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/3e9245c2bfaa?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-13 06:24:29,729 unpacking tar archive at: mozilla-beta-3e9245c2bfaa/testing/mozharness/ program finished with exit code 0 elapsedTime=1.323836 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-13 06:24:29.938928) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-13 06:24:29.939292) ========= script_repo_revision: 3e9245c2bfaa9089cd3cc9e691159c091eb21e28 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-13 06:24:29.939680) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-13 06:24:29.939937) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-13 06:24:29.953759) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 18 secs) (at 2016-05-13 06:24:29.954156) ========= /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.ZRWZ7NMchd/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.JHDtPFup3Y/Listeners TMPDIR=/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/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 06:24:30 INFO - MultiFileLogger online at 20160513 06:24:30 in /builds/slave/test 06:24:30 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 06:24:30 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:24:30 INFO - {'append_to_log': False, 06:24:30 INFO - 'base_work_dir': '/builds/slave/test', 06:24:30 INFO - 'blob_upload_branch': 'Mozilla-Beta', 06:24:30 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:24:30 INFO - 'branch': 'Mozilla-Beta', 06:24:30 INFO - 'buildbot_json_path': 'buildprops.json', 06:24:30 INFO - 'config_files': ('talos/mac_config.py',), 06:24:30 INFO - 'default_actions': ('clobber', 06:24:30 INFO - 'read-buildbot-config', 06:24:30 INFO - 'download-and-extract', 06:24:30 INFO - 'populate-webroot', 06:24:30 INFO - 'create-virtualenv', 06:24:30 INFO - 'install', 06:24:30 INFO - 'run-tests'), 06:24:30 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:24:30 INFO - 'download_minidump_stackwalk': True, 06:24:30 INFO - 'download_symbols': 'ondemand', 06:24:30 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:24:30 INFO - 'tooltool.py': '/tools/tooltool.py', 06:24:30 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:24:30 INFO - '/tools/misc-python/virtualenv.py')}, 06:24:30 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:24:30 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:24:30 INFO - 'installer_path': 'installer.exe', 06:24:30 INFO - 'log_level': 'info', 06:24:30 INFO - 'log_name': 'talos', 06:24:30 INFO - 'log_to_console': True, 06:24:30 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 06:24:30 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 06:24:30 INFO - 'opt_config_files': (), 06:24:30 INFO - 'pip_index': False, 06:24:30 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 06:24:30 INFO - 'cmd': ('bash', 06:24:30 INFO - '-c', 06:24:30 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 06:24:30 INFO - 'enabled': True, 06:24:30 INFO - 'halt_on_failure': False, 06:24:30 INFO - 'name': 'check_screen_resolution'},), 06:24:30 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 06:24:30 INFO - 'cmd': ('bash', 06:24:30 INFO - '-c', 06:24:30 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 06:24:30 INFO - 'enabled': True, 06:24:30 INFO - 'halt_on_failure': False, 06:24:30 INFO - 'name': 'check_screen_resolution'},), 06:24:30 INFO - 'run_cmd_checks_enabled': True, 06:24:30 INFO - 'sps_profile': False, 06:24:30 INFO - 'sps_profile_interval': 0, 06:24:30 INFO - 'suite': 'dromaeojs', 06:24:30 INFO - 'system_bits': '32', 06:24:30 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:24:30 INFO - 'title': 't-yosemite-r7-0214', 06:24:30 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:24:30 INFO - 'use_talos_json': True, 06:24:30 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:24:30 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:24:30 INFO - 'work_dir': 'build'} 06:24:30 INFO - ##### 06:24:30 INFO - ##### Running clobber step. 06:24:30 INFO - ##### 06:24:30 INFO - Running pre-action listener: _resource_record_pre_action 06:24:30 INFO - Running main action method: clobber 06:24:30 INFO - rmtree: /builds/slave/test/build 06:24:30 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:24:32 INFO - Running post-action listener: _resource_record_post_action 06:24:32 INFO - ##### 06:24:32 INFO - ##### Running read-buildbot-config step. 06:24:32 INFO - ##### 06:24:32 INFO - Running pre-action listener: _resource_record_pre_action 06:24:32 INFO - Running main action method: read_buildbot_config 06:24:32 INFO - Using buildbot properties: 06:24:32 INFO - { 06:24:32 INFO - "project": "", 06:24:32 INFO - "product": "firefox", 06:24:32 INFO - "script_repo_revision": "production", 06:24:32 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 06:24:32 INFO - "repository": "", 06:24:32 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 06:24:32 INFO - "buildid": "20160513041937", 06:24:32 INFO - "pgo_build": "False", 06:24:32 INFO - "basedir": "/builds/slave/test", 06:24:32 INFO - "buildnumber": 9, 06:24:32 INFO - "slavename": "t-yosemite-r7-0214", 06:24:32 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 06:24:32 INFO - "platform": "yosemite_r7", 06:24:32 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 06:24:32 INFO - "branch": "mozilla-beta", 06:24:32 INFO - "repo_path": "releases/mozilla-beta", 06:24:32 INFO - "revision": "3e9245c2bfaa9089cd3cc9e691159c091eb21e28", 06:24:32 INFO - "stage_platform": "macosx64", 06:24:32 INFO - "builduid": "8cc8e7f6a55d4b3da4a46c0d62493492", 06:24:32 INFO - "slavebuilddir": "test" 06:24:32 INFO - } 06:24:32 INFO - Found installer url https://queue.taskcluster.net/v1/task/D1q4ZZX2SdiPFfGmbKsf8A/artifacts/public/build/firefox-47.0.en-US.mac.dmg. 06:24:32 INFO - Running post-action listener: _resource_record_post_action 06:24:32 INFO - ##### 06:24:32 INFO - ##### Running download-and-extract step. 06:24:32 INFO - ##### 06:24:32 INFO - Running pre-action listener: _resource_record_pre_action 06:24:32 INFO - Running main action method: download_and_extract 06:24:32 INFO - mkdir: /builds/slave/test/build/tests 06:24:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:24:32 INFO - https://queue.taskcluster.net/v1/task/D1q4ZZX2SdiPFfGmbKsf8A/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json matches https://queue.taskcluster.net 06:24:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D1q4ZZX2SdiPFfGmbKsf8A/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json 06:24:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D1q4ZZX2SdiPFfGmbKsf8A/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json 06:24:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D1q4ZZX2SdiPFfGmbKsf8A/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-47.0.en-US.mac.test_packages.json 06:24:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D1q4ZZX2SdiPFfGmbKsf8A/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-47.0.en-US.mac.test_packages.json'}, attempt #1 06:24:33 INFO - Downloaded 1241 bytes. 06:24:33 INFO - Reading from file /builds/slave/test/build/firefox-47.0.en-US.mac.test_packages.json 06:24:33 INFO - Using the following test package requirements: 06:24:33 INFO - {u'common': [u'firefox-47.0.en-US.mac.common.tests.zip'], 06:24:33 INFO - u'cppunittest': [u'firefox-47.0.en-US.mac.common.tests.zip', 06:24:33 INFO - u'firefox-47.0.en-US.mac.cppunittest.tests.zip'], 06:24:33 INFO - u'gtest': [u'firefox-47.0.en-US.mac.common.tests.zip', 06:24:33 INFO - u'firefox-47.0.en-US.mac.gtest.tests.zip'], 06:24:33 INFO - u'jittest': [u'firefox-47.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 06:24:33 INFO - u'mochitest': [u'firefox-47.0.en-US.mac.common.tests.zip', 06:24:33 INFO - u'firefox-47.0.en-US.mac.mochitest.tests.zip'], 06:24:33 INFO - u'mozbase': [u'firefox-47.0.en-US.mac.common.tests.zip'], 06:24:33 INFO - u'reftest': [u'firefox-47.0.en-US.mac.common.tests.zip', 06:24:33 INFO - u'firefox-47.0.en-US.mac.reftest.tests.zip'], 06:24:33 INFO - u'talos': [u'firefox-47.0.en-US.mac.common.tests.zip', 06:24:33 INFO - u'firefox-47.0.en-US.mac.talos.tests.zip'], 06:24:33 INFO - u'web-platform': [u'firefox-47.0.en-US.mac.common.tests.zip', 06:24:33 INFO - u'firefox-47.0.en-US.mac.web-platform.tests.zip'], 06:24:33 INFO - u'webapprt': [u'firefox-47.0.en-US.mac.common.tests.zip'], 06:24:33 INFO - u'xpcshell': [u'firefox-47.0.en-US.mac.common.tests.zip', 06:24:33 INFO - u'firefox-47.0.en-US.mac.xpcshell.tests.zip']} 06:24:33 INFO - Downloading packages: [u'firefox-47.0.en-US.mac.common.tests.zip'] for test suite category: common 06:24:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:24:33 INFO - https://queue.taskcluster.net/v1/task/D1q4ZZX2SdiPFfGmbKsf8A/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 06:24:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D1q4ZZX2SdiPFfGmbKsf8A/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip 06:24:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D1q4ZZX2SdiPFfGmbKsf8A/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip 06:24:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D1q4ZZX2SdiPFfGmbKsf8A/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip 06:24:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D1q4ZZX2SdiPFfGmbKsf8A/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip'}, attempt #1 06:24:35 INFO - Downloaded 17747491 bytes. 06:24:35 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:24:35 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 06:24:38 INFO - Return code: 0 06:24:38 INFO - Downloading packages: [u'firefox-47.0.en-US.mac.common.tests.zip', u'firefox-47.0.en-US.mac.talos.tests.zip'] for test suite category: talos 06:24:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:24:38 INFO - https://queue.taskcluster.net/v1/task/D1q4ZZX2SdiPFfGmbKsf8A/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 06:24:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D1q4ZZX2SdiPFfGmbKsf8A/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip 06:24:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D1q4ZZX2SdiPFfGmbKsf8A/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip 06:24:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D1q4ZZX2SdiPFfGmbKsf8A/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip 06:24:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D1q4ZZX2SdiPFfGmbKsf8A/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip'}, attempt #1 06:25:00 INFO - Downloaded 17747491 bytes. 06:25:00 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:25:00 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 06:25:03 INFO - Return code: 0 06:25:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:25:03 INFO - https://queue.taskcluster.net/v1/task/D1q4ZZX2SdiPFfGmbKsf8A/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 06:25:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D1q4ZZX2SdiPFfGmbKsf8A/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip 06:25:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D1q4ZZX2SdiPFfGmbKsf8A/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip 06:25:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D1q4ZZX2SdiPFfGmbKsf8A/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-47.0.en-US.mac.talos.tests.zip 06:25:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D1q4ZZX2SdiPFfGmbKsf8A/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.en-US.mac.talos.tests.zip'}, attempt #1 06:25:04 INFO - Downloaded 10845194 bytes. 06:25:04 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:25:04 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 06:25:05 INFO - Return code: 0 06:25:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:25:05 INFO - https://queue.taskcluster.net/v1/task/D1q4ZZX2SdiPFfGmbKsf8A/artifacts/public/build/firefox-47.0.en-US.mac.dmg matches https://queue.taskcluster.net 06:25:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D1q4ZZX2SdiPFfGmbKsf8A/artifacts/public/build/firefox-47.0.en-US.mac.dmg 06:25:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D1q4ZZX2SdiPFfGmbKsf8A/artifacts/public/build/firefox-47.0.en-US.mac.dmg 06:25:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D1q4ZZX2SdiPFfGmbKsf8A/artifacts/public/build/firefox-47.0.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0.en-US.mac.dmg 06:25:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D1q4ZZX2SdiPFfGmbKsf8A/artifacts/public/build/firefox-47.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-47.0.en-US.mac.dmg'}, attempt #1 06:25:12 INFO - Downloaded 88270161 bytes. 06:25:12 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/D1q4ZZX2SdiPFfGmbKsf8A/artifacts/public/build/firefox-47.0.en-US.mac.dmg 06:25:12 INFO - mkdir: /builds/slave/test/properties 06:25:12 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:25:12 INFO - Writing to file /builds/slave/test/properties/build_url 06:25:12 INFO - Contents: 06:25:12 INFO - build_url:https://queue.taskcluster.net/v1/task/D1q4ZZX2SdiPFfGmbKsf8A/artifacts/public/build/firefox-47.0.en-US.mac.dmg 06:25:13 INFO - Running post-action listener: _resource_record_post_action 06:25:13 INFO - Running post-action listener: set_extra_try_arguments 06:25:13 INFO - ##### 06:25:13 INFO - ##### Running populate-webroot step. 06:25:13 INFO - ##### 06:25:13 INFO - Running pre-action listener: _resource_record_pre_action 06:25:13 INFO - Running main action method: populate_webroot 06:25:13 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:25:13 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:25:13 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:25:13 INFO - '--tppagecycles', 06:25:13 INFO - '7'], 06:25:13 INFO - 'tests': ['tsvgm']}}, 06:25:13 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 06:25:13 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 06:25:13 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:25:13 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 06:25:13 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 06:25:13 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:25:13 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:25:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:25:13 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:25:13 INFO - 'talos_options': ['--e10s'], 06:25:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:25:13 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:25:13 INFO - 'tests': ['damp', 'tps']}, 06:25:13 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:25:13 INFO - 'talos_options': ['--e10s'], 06:25:13 INFO - 'tests': ['damp', 'tps']}, 06:25:13 INFO - 'g3': {'tests': ['dromaeo_dom']}, 06:25:13 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:25:13 INFO - 'other': {'tests': ['a11yr', 06:25:13 INFO - 'ts_paint', 06:25:13 INFO - 'tpaint', 06:25:13 INFO - 'sessionrestore', 06:25:13 INFO - 'sessionrestore_no_auto_restore', 06:25:13 INFO - 'tabpaint']}, 06:25:13 INFO - 'other-e10s': {'talos_options': ['--e10s'], 06:25:13 INFO - 'tests': ['a11yr', 06:25:13 INFO - 'ts_paint', 06:25:13 INFO - 'tpaint', 06:25:13 INFO - 'sessionrestore', 06:25:13 INFO - 'sessionrestore_no_auto_restore', 06:25:13 INFO - 'tabpaint']}, 06:25:13 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 06:25:13 INFO - 'tests': ['a11yr', 06:25:13 INFO - 'ts_paint', 06:25:13 INFO - 'tpaint', 06:25:13 INFO - 'sessionrestore', 06:25:13 INFO - 'sessionrestore_no_auto_restore', 06:25:13 INFO - 'tabpaint']}, 06:25:13 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 06:25:13 INFO - 'tests': ['a11yr', 06:25:13 INFO - 'ts_paint', 06:25:13 INFO - 'tpaint', 06:25:13 INFO - 'sessionrestore', 06:25:13 INFO - 'sessionrestore_no_auto_restore', 06:25:13 INFO - 'tabpaint']}, 06:25:13 INFO - 'other_l64': {'tests': ['a11yr', 06:25:13 INFO - 'ts_paint', 06:25:13 INFO - 'tpaint', 06:25:13 INFO - 'sessionrestore', 06:25:13 INFO - 'sessionrestore_no_auto_restore', 06:25:13 INFO - 'tabpaint']}, 06:25:13 INFO - 'other_nol64': {'tests': ['a11yr', 06:25:13 INFO - 'ts_paint', 06:25:13 INFO - 'tpaint', 06:25:13 INFO - 'sessionrestore', 06:25:13 INFO - 'sessionrestore_no_auto_restore', 06:25:13 INFO - 'tabpaint']}, 06:25:13 INFO - 'svgr': {'tests': ['tsvgx', 06:25:13 INFO - 'tsvgr_opacity', 06:25:13 INFO - 'tart', 06:25:13 INFO - 'tscrollx', 06:25:13 INFO - 'cart']}, 06:25:13 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 06:25:13 INFO - 'tests': ['tsvgx', 06:25:13 INFO - 'tsvgr_opacity', 06:25:13 INFO - 'tart', 06:25:13 INFO - 'tscrollx', 06:25:13 INFO - 'cart']}, 06:25:13 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:25:13 INFO - 'tests': ['tp5o']}, 06:25:13 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:25:13 INFO - 'talos_options': ['--e10s'], 06:25:13 INFO - 'tests': ['tp5o']}, 06:25:13 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:25:13 INFO - 'talos_options': ['--xperf_path', 06:25:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:25:13 INFO - 'tests': ['tp5n']}, 06:25:13 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:25:13 INFO - 'talos_options': ['--e10s', 06:25:13 INFO - '--xperf_path', 06:25:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:25:13 INFO - 'tests': ['tp5n']}}, 06:25:13 INFO - 'talos.zip': {'path': '', 06:25:13 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:25:13 INFO - Running post-action listener: _resource_record_post_action 06:25:13 INFO - ##### 06:25:13 INFO - ##### Running create-virtualenv step. 06:25:13 INFO - ##### 06:25:13 INFO - Running pre-action listener: _resource_record_pre_action 06:25:13 INFO - Running main action method: create_virtualenv 06:25:13 INFO - Creating virtualenv /builds/slave/test/build/venv 06:25:13 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 06:25:13 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:25:13 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:25:13 INFO - Using real prefix '/tools/python27' 06:25:13 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:25:14 INFO - Installing distribute.............................................................................................................................................................................................done. 06:25:17 INFO - Installing pip.................done. 06:25:17 INFO - Return code: 0 06:25:17 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:25:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:25:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:25:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:25:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:25:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:25:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:25:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10a483a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a48a4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f90c2c79be0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a327d30>, '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 0x10a18bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a31eb20>, '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.ZRWZ7NMchd/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.JHDtPFup3Y/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/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 06:25:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 06:25:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 06:25:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZRWZ7NMchd/Render', 06:25:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:25:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:25:17 INFO - 'HOME': '/Users/cltbld', 06:25:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:25:17 INFO - 'LOGNAME': 'cltbld', 06:25:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:25:17 INFO - 'MOZ_NO_REMOTE': '1', 06:25:17 INFO - 'NO_EM_RESTART': '1', 06:25:17 INFO - 'PAGER': '/bin/cat', 06:25:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:25:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:25:17 INFO - 'PWD': '/builds/slave/test', 06:25:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:25:17 INFO - 'SHELL': '/bin/bash', 06:25:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JHDtPFup3Y/Listeners', 06:25:17 INFO - 'TMPDIR': '/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/', 06:25:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:25:17 INFO - 'USER': 'cltbld', 06:25:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:25:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:25:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:25:17 INFO - 'XPC_FLAGS': '0x0', 06:25:17 INFO - 'XPC_SERVICE_NAME': '0', 06:25:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:25:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:25:17 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 06:25:17 INFO - Cleaning up... 06:25:17 INFO - Return code: 0 06:25:17 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 06:25:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:25:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:25:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:25:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:25:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:25:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:25:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10a483a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a48a4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f90c2c79be0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a327d30>, '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 0x10a18bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a31eb20>, '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.ZRWZ7NMchd/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.JHDtPFup3Y/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/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 06:25:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 06:25:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 06:25:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZRWZ7NMchd/Render', 06:25:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:25:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:25:17 INFO - 'HOME': '/Users/cltbld', 06:25:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:25:17 INFO - 'LOGNAME': 'cltbld', 06:25:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:25:17 INFO - 'MOZ_NO_REMOTE': '1', 06:25:17 INFO - 'NO_EM_RESTART': '1', 06:25:17 INFO - 'PAGER': '/bin/cat', 06:25:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:25:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:25:17 INFO - 'PWD': '/builds/slave/test', 06:25:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:25:17 INFO - 'SHELL': '/bin/bash', 06:25:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JHDtPFup3Y/Listeners', 06:25:17 INFO - 'TMPDIR': '/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/', 06:25:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:25:17 INFO - 'USER': 'cltbld', 06:25:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:25:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:25:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:25:17 INFO - 'XPC_FLAGS': '0x0', 06:25:17 INFO - 'XPC_SERVICE_NAME': '0', 06:25:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:25:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:25:18 INFO - Downloading/unpacking psutil>=0.7.1 06:25:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:25:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:25:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:25:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:25:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:25:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:25:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:25:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:25:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:25:20 INFO - Installing collected packages: psutil 06:25:20 INFO - Running setup.py install for psutil 06:25:21 INFO - building 'psutil._psutil_osx' extension 06:25:21 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 06:25:21 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 06:25:21 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 06:25:21 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 06:25:21 INFO - building 'psutil._psutil_posix' extension 06:25:21 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 06:25:21 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 06:25:21 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 06:25:21 INFO - ^ 06:25:21 INFO - 1 warning generated. 06:25:21 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 06:25:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:25:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:25:22 INFO - Successfully installed psutil 06:25:22 INFO - Cleaning up... 06:25:22 INFO - Return code: 0 06:25:22 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 06:25:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:25:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:25:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:25:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:25:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:25:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:25:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10a483a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a48a4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f90c2c79be0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a327d30>, '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 0x10a18bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a31eb20>, '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.ZRWZ7NMchd/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.JHDtPFup3Y/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/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 06:25:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 06:25:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 06:25:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZRWZ7NMchd/Render', 06:25:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:25:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:25:22 INFO - 'HOME': '/Users/cltbld', 06:25:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:25:22 INFO - 'LOGNAME': 'cltbld', 06:25:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:25:22 INFO - 'MOZ_NO_REMOTE': '1', 06:25:22 INFO - 'NO_EM_RESTART': '1', 06:25:22 INFO - 'PAGER': '/bin/cat', 06:25:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:25:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:25:22 INFO - 'PWD': '/builds/slave/test', 06:25:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:25:22 INFO - 'SHELL': '/bin/bash', 06:25:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JHDtPFup3Y/Listeners', 06:25:22 INFO - 'TMPDIR': '/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/', 06:25:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:25:22 INFO - 'USER': 'cltbld', 06:25:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:25:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:25:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:25:22 INFO - 'XPC_FLAGS': '0x0', 06:25:22 INFO - 'XPC_SERVICE_NAME': '0', 06:25:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:25:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:25:22 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 06:25:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:25:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:25:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:25:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:25:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:25:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:25:24 INFO - Downloading mozsystemmonitor-0.0.tar.gz 06:25:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:25:24 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 06:25:24 INFO - Installing collected packages: mozsystemmonitor 06:25:24 INFO - Running setup.py install for mozsystemmonitor 06:25:25 INFO - Successfully installed mozsystemmonitor 06:25:25 INFO - Cleaning up... 06:25:25 INFO - Return code: 0 06:25:25 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:25:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:25:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:25:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:25:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:25:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:25:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:25:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10a483a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a48a4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f90c2c79be0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a327d30>, '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 0x10a18bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a31eb20>, '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.ZRWZ7NMchd/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.JHDtPFup3Y/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/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 06:25:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 06:25:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 06:25:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZRWZ7NMchd/Render', 06:25:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:25:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:25:25 INFO - 'HOME': '/Users/cltbld', 06:25:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:25:25 INFO - 'LOGNAME': 'cltbld', 06:25:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:25:25 INFO - 'MOZ_NO_REMOTE': '1', 06:25:25 INFO - 'NO_EM_RESTART': '1', 06:25:25 INFO - 'PAGER': '/bin/cat', 06:25:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:25:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:25:25 INFO - 'PWD': '/builds/slave/test', 06:25:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:25:25 INFO - 'SHELL': '/bin/bash', 06:25:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JHDtPFup3Y/Listeners', 06:25:25 INFO - 'TMPDIR': '/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/', 06:25:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:25:25 INFO - 'USER': 'cltbld', 06:25:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:25:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:25:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:25:25 INFO - 'XPC_FLAGS': '0x0', 06:25:25 INFO - 'XPC_SERVICE_NAME': '0', 06:25:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:25:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:25:25 INFO - Downloading/unpacking blobuploader==1.2.4 06:25:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:25:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:25:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:25:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:25:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:25:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:25:27 INFO - Downloading blobuploader-1.2.4.tar.gz 06:25:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:25:27 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:25:27 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 06:25:27 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 06:25:27 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 06:25:27 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 06:25:27 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 06:25:27 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 06:25:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:25:28 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:25:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:25:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:25:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:25:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:25:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:25:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:25:28 INFO - Downloading docopt-0.6.1.tar.gz 06:25:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:25:29 INFO - Installing collected packages: blobuploader, requests, docopt 06:25:29 INFO - Running setup.py install for blobuploader 06:25:29 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:25:29 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:25:29 INFO - Running setup.py install for requests 06:25:29 INFO - Running setup.py install for docopt 06:25:29 INFO - Successfully installed blobuploader requests docopt 06:25:29 INFO - Cleaning up... 06:25:29 INFO - Return code: 0 06:25:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:25:29 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')]} 06:25:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:25:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:25:29 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')]} 06:25:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:25:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:25:29 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 0x10a483a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a48a4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f90c2c79be0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a327d30>, '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 0x10a18bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a31eb20>, '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.ZRWZ7NMchd/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.JHDtPFup3Y/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/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 06:25:29 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 06:25:29 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 06:25:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZRWZ7NMchd/Render', 06:25:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:25:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:25:29 INFO - 'HOME': '/Users/cltbld', 06:25:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:25:29 INFO - 'LOGNAME': 'cltbld', 06:25:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:25:29 INFO - 'MOZ_NO_REMOTE': '1', 06:25:29 INFO - 'NO_EM_RESTART': '1', 06:25:29 INFO - 'PAGER': '/bin/cat', 06:25:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:25:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:25:29 INFO - 'PWD': '/builds/slave/test', 06:25:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:25:29 INFO - 'SHELL': '/bin/bash', 06:25:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JHDtPFup3Y/Listeners', 06:25:29 INFO - 'TMPDIR': '/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/', 06:25:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:25:29 INFO - 'USER': 'cltbld', 06:25:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:25:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:25:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:25:29 INFO - 'XPC_FLAGS': '0x0', 06:25:29 INFO - 'XPC_SERVICE_NAME': '0', 06:25:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:25:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:25:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:25:30 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-N4NeCK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:25:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:25:30 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-Yf70sw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:25:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:25:30 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-WwoIXX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:25:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:25:30 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-idX3CD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:25:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:25:30 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-blnEt7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:25:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:25:30 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-TbBXNY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:25:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:25:30 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-xFHDRi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:25:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:25:30 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-JLhf8L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:25:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:25:30 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-rOn_SE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:25:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:25:31 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-7UIfTg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:25:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:25:31 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-xwHtwO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:25:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:25:31 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-1tRH7b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:25:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:25:31 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-ftPJvB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:25:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:25:31 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-e8hGQa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:25:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:25:31 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-uZyXYW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:25:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:25:31 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-OUewB2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:25:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:25:31 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-e7llwR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:25:31 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:25:31 INFO - Running setup.py install for manifestparser 06:25:32 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:25:32 INFO - Running setup.py install for mozcrash 06:25:32 INFO - Running setup.py install for mozdebug 06:25:32 INFO - Running setup.py install for mozdevice 06:25:32 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:25:32 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:25:32 INFO - Running setup.py install for mozfile 06:25:32 INFO - Running setup.py install for mozhttpd 06:25:32 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:25:32 INFO - Running setup.py install for mozinfo 06:25:32 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:25:32 INFO - Running setup.py install for mozInstall 06:25:33 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:25:33 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:25:33 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:25:33 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:25:33 INFO - Running setup.py install for mozleak 06:25:33 INFO - Running setup.py install for mozlog 06:25:33 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:25:33 INFO - Running setup.py install for moznetwork 06:25:33 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:25:33 INFO - Running setup.py install for mozprocess 06:25:33 INFO - Running setup.py install for mozprofile 06:25:33 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:25:33 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:25:33 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:25:33 INFO - Running setup.py install for mozrunner 06:25:34 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:25:34 INFO - Running setup.py install for mozscreenshot 06:25:34 INFO - Running setup.py install for moztest 06:25:34 INFO - Running setup.py install for mozversion 06:25:34 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:25:34 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:25:34 INFO - Cleaning up... 06:25:34 INFO - Return code: 0 06:25:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:25:34 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')]} 06:25:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:25:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:25:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:25:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:25:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:25:35 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 0x10a483a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a48a4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f90c2c79be0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a327d30>, '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 0x10a18bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a31eb20>, '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.ZRWZ7NMchd/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.JHDtPFup3Y/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/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 06:25:35 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 06:25:35 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 06:25:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZRWZ7NMchd/Render', 06:25:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:25:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:25:35 INFO - 'HOME': '/Users/cltbld', 06:25:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:25:35 INFO - 'LOGNAME': 'cltbld', 06:25:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:25:35 INFO - 'MOZ_NO_REMOTE': '1', 06:25:35 INFO - 'NO_EM_RESTART': '1', 06:25:35 INFO - 'PAGER': '/bin/cat', 06:25:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:25:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:25:35 INFO - 'PWD': '/builds/slave/test', 06:25:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:25:35 INFO - 'SHELL': '/bin/bash', 06:25:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JHDtPFup3Y/Listeners', 06:25:35 INFO - 'TMPDIR': '/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/', 06:25:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:25:35 INFO - 'USER': 'cltbld', 06:25:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:25:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:25:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:25:35 INFO - 'XPC_FLAGS': '0x0', 06:25:35 INFO - 'XPC_SERVICE_NAME': '0', 06:25:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:25:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:25:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:25:35 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-MjipKQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:25:35 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)) 06:25:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:25:35 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-CVDRh0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:25:35 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)) 06:25:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:25:35 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-4DBK1A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:25:35 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)) 06:25:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:25:35 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-u1zurD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:25:35 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)) 06:25:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:25:35 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-Ba8fOH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:25:35 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)) 06:25:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:25:35 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-3_r8a5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:25:35 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)) 06:25:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:25:35 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-1QmQv3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:25:36 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)) 06:25:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:25:36 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-TBzXmz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:25:36 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)) 06:25:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:25:36 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-BJI7Dd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:25:36 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)) 06:25:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:25:36 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-YCgPdN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:25:36 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)) 06:25:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:25:36 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-DarTRE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:25:36 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)) 06:25:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:25:36 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-UW3YqU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:25:36 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)) 06:25:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:25:36 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-85WbeU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:25:36 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)) 06:25:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:25:36 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-dkhG7d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:25:36 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)) 06:25:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:25:36 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-0Iyp7P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:25:36 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)) 06:25:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:25:36 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-WpkGgv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:25:36 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)) 06:25:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:25:36 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-IJcTis-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:25:37 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)) 06:25:37 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)) 06:25:37 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)) 06:25:37 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)) 06:25:37 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)) 06:25:37 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)) 06:25:37 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:25:37 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 06:25:37 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 06:25:37 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 06:25:37 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 06:25:37 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 06:25:37 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 06:25:39 INFO - Downloading blessings-1.6.tar.gz 06:25:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:25:39 INFO - Installing collected packages: blessings 06:25:39 INFO - Running setup.py install for blessings 06:25:40 INFO - Successfully installed blessings 06:25:40 INFO - Cleaning up... 06:25:40 INFO - Return code: 0 06:25:40 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:25:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:25:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:25:40 INFO - Reading from file tmpfile_stdout 06:25:40 INFO - Current package versions: 06:25:40 INFO - blessings == 1.6 06:25:40 INFO - blobuploader == 1.2.4 06:25:40 INFO - docopt == 0.6.1 06:25:40 INFO - manifestparser == 1.1 06:25:40 INFO - mozInstall == 1.12 06:25:40 INFO - mozcrash == 0.17 06:25:40 INFO - mozdebug == 0.1 06:25:40 INFO - mozdevice == 0.48 06:25:40 INFO - mozfile == 1.2 06:25:40 INFO - mozhttpd == 0.7 06:25:40 INFO - mozinfo == 0.9 06:25:40 INFO - mozleak == 0.1 06:25:40 INFO - mozlog == 3.1 06:25:40 INFO - moznetwork == 0.27 06:25:40 INFO - mozprocess == 0.22 06:25:40 INFO - mozprofile == 0.28 06:25:40 INFO - mozrunner == 6.11 06:25:40 INFO - mozscreenshot == 0.1 06:25:40 INFO - mozsystemmonitor == 0.0 06:25:40 INFO - moztest == 0.7 06:25:40 INFO - mozversion == 1.4 06:25:40 INFO - psutil == 3.1.1 06:25:40 INFO - requests == 1.2.3 06:25:40 INFO - wsgiref == 0.1.2 06:25:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:25:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:25:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:25:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:25:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:25:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:25:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:25:40 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 0x10a483a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a48a4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f90c2c79be0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a327d30>, '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 0x10a18bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a31eb20>, '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.ZRWZ7NMchd/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.JHDtPFup3Y/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/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 06:25:40 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 06:25:40 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 06:25:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZRWZ7NMchd/Render', 06:25:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:25:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:25:40 INFO - 'HOME': '/Users/cltbld', 06:25:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:25:40 INFO - 'LOGNAME': 'cltbld', 06:25:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:25:40 INFO - 'MOZ_NO_REMOTE': '1', 06:25:40 INFO - 'NO_EM_RESTART': '1', 06:25:40 INFO - 'PAGER': '/bin/cat', 06:25:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:25:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:25:40 INFO - 'PWD': '/builds/slave/test', 06:25:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:25:40 INFO - 'SHELL': '/bin/bash', 06:25:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JHDtPFup3Y/Listeners', 06:25:40 INFO - 'TMPDIR': '/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/', 06:25:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:25:40 INFO - 'USER': 'cltbld', 06:25:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:25:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:25:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:25:40 INFO - 'XPC_FLAGS': '0x0', 06:25:40 INFO - 'XPC_SERVICE_NAME': '0', 06:25:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:25:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:25:40 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)) 06:25:40 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)) 06:25:40 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)) 06:25:40 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)) 06:25:40 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)) 06:25:40 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)) 06:25:40 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)) 06:25:40 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)) 06:25:40 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)) 06:25:40 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)) 06:25:40 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)) 06:25:40 INFO - Cleaning up... 06:25:40 INFO - Return code: 0 06:25:40 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:25:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:25:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:25:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:25:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:25:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:25:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:25:40 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 0x10a483a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a48a4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f90c2c79be0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a327d30>, '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 0x10a18bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a31eb20>, '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.ZRWZ7NMchd/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.JHDtPFup3Y/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/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 06:25:40 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 06:25:40 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 06:25:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZRWZ7NMchd/Render', 06:25:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:25:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:25:40 INFO - 'HOME': '/Users/cltbld', 06:25:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:25:40 INFO - 'LOGNAME': 'cltbld', 06:25:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:25:40 INFO - 'MOZ_NO_REMOTE': '1', 06:25:40 INFO - 'NO_EM_RESTART': '1', 06:25:40 INFO - 'PAGER': '/bin/cat', 06:25:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:25:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:25:40 INFO - 'PWD': '/builds/slave/test', 06:25:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:25:40 INFO - 'SHELL': '/bin/bash', 06:25:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JHDtPFup3Y/Listeners', 06:25:40 INFO - 'TMPDIR': '/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/', 06:25:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:25:40 INFO - 'USER': 'cltbld', 06:25:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:25:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:25:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:25:40 INFO - 'XPC_FLAGS': '0x0', 06:25:40 INFO - 'XPC_SERVICE_NAME': '0', 06:25:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:25:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:25:40 INFO - Downloading/unpacking jsonschema 06:25:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:25:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:25:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:25:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:25:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:25:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:25:43 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:25:43 INFO - Downloading/unpacking functools32 (from jsonschema) 06:25:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:25:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:25:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:25:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:25:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:25:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:25:43 INFO - Downloading functools32-3.2.3-2.tar.gz 06:25:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:25:43 INFO - warning: no files found matching '*.txt' 06:25:43 INFO - no previously-included directories found matching 'build' 06:25:43 INFO - no previously-included directories found matching 'dist' 06:25:43 INFO - no previously-included directories found matching '.git*' 06:25:43 INFO - Installing collected packages: jsonschema, functools32 06:25:44 INFO - Running setup.py install for functools32 06:25:44 INFO - warning: no files found matching '*.txt' 06:25:44 INFO - no previously-included directories found matching 'build' 06:25:44 INFO - no previously-included directories found matching 'dist' 06:25:44 INFO - no previously-included directories found matching '.git*' 06:25:44 INFO - Successfully installed jsonschema functools32 06:25:44 INFO - Cleaning up... 06:25:44 INFO - Return code: 0 06:25:44 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 06:25:44 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')]} 06:25:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:25:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:25:44 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')]} 06:25:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:25:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:25:44 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 0x10a483a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a48a4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f90c2c79be0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a327d30>, '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 0x10a18bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a31eb20>, '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.ZRWZ7NMchd/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.JHDtPFup3Y/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/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 06:25:44 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 06:25:44 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 06:25:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZRWZ7NMchd/Render', 06:25:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:25:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:25:44 INFO - 'HOME': '/Users/cltbld', 06:25:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:25:44 INFO - 'LOGNAME': 'cltbld', 06:25:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:25:44 INFO - 'MOZ_NO_REMOTE': '1', 06:25:44 INFO - 'NO_EM_RESTART': '1', 06:25:44 INFO - 'PAGER': '/bin/cat', 06:25:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:25:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:25:44 INFO - 'PWD': '/builds/slave/test', 06:25:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:25:44 INFO - 'SHELL': '/bin/bash', 06:25:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JHDtPFup3Y/Listeners', 06:25:44 INFO - 'TMPDIR': '/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/', 06:25:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:25:44 INFO - 'USER': 'cltbld', 06:25:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:25:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:25:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:25:44 INFO - 'XPC_FLAGS': '0x0', 06:25:44 INFO - 'XPC_SERVICE_NAME': '0', 06:25:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:25:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:25:44 INFO - Downloading/unpacking flake8 06:25:44 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 06:25:44 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 06:25:44 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 06:25:44 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 06:25:44 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 06:25:44 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 06:25:46 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 06:25:46 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 06:25: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 06:25: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 06:25: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 06:25: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 06:25: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 06:25: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 06:25:47 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 06:25:47 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 06:25:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:25:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:25:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:25:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:25:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:25:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:25:47 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 06:25:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:25:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:25:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:25:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:25:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:25:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:25:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 06:25:48 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:25:48 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:25:48 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:25:48 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:25:48 INFO - no previously-included directories found matching 'docs/_build' 06:25:48 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 06:25:48 INFO - Running setup.py install for pep8 06:25:48 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:25:48 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:25:48 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:25:48 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:25:48 INFO - no previously-included directories found matching 'docs/_build' 06:25:48 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 06:25:48 INFO - Successfully installed flake8 mccabe pyflakes pep8 06:25:48 INFO - Cleaning up... 06:25:48 INFO - Return code: 0 06:25:48 INFO - Running post-action listener: _resource_record_post_action 06:25:48 INFO - Running post-action listener: _start_resource_monitoring 06:25:48 INFO - Starting resource monitoring. 06:25:48 INFO - ##### 06:25:48 INFO - ##### Running install step. 06:25:48 INFO - ##### 06:25:48 INFO - Running pre-action listener: _resource_record_pre_action 06:25:48 INFO - Running main action method: install 06:25:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:25:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:25:48 INFO - Reading from file tmpfile_stdout 06:25:48 INFO - Detecting whether we're running mozinstall >=1.0... 06:25:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:25:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:25:48 INFO - Reading from file tmpfile_stdout 06:25:48 INFO - Output received: 06:25:48 INFO - Usage: mozinstall [options] installer 06:25:48 INFO - Options: 06:25:48 INFO - -h, --help show this help message and exit 06:25:48 INFO - -d DEST, --destination=DEST 06:25:48 INFO - Directory to install application into. [default: 06:25:48 INFO - "/builds/slave/test"] 06:25:48 INFO - --app=APP Application being installed. [default: firefox] 06:25:48 INFO - mkdir: /builds/slave/test/build/application 06:25:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 06:25:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0.en-US.mac.dmg --destination /builds/slave/test/build/application 06:26:11 INFO - Reading from file tmpfile_stdout 06:26:11 INFO - Output received: 06:26:11 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 06:26:11 INFO - Running post-action listener: _resource_record_post_action 06:26:11 INFO - ##### 06:26:11 INFO - ##### Running run-tests step. 06:26:11 INFO - ##### 06:26:11 INFO - Running pre-action listener: _resource_record_pre_action 06:26:11 INFO - Running main action method: run_tests 06:26:11 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 06:26:11 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 06:26:11 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 06:26:11 INFO - 2016-05-13 06:26:11.367 screenresolution[1650:8053] starting screenresolution argv=screenresolution get 06:26:11 INFO - 2016-05-13 06:26:11.369 screenresolution[1650:8053] Display 0: 1600x1200x32@60 06:26:11 INFO - 2016-05-13 06:26:11.374 screenresolution[1651:8055] starting screenresolution argv=screenresolution list 06:26:11 INFO - Available Modes on Display 0 06:26:11 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 06:26:11 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 06:26:11 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 06:26:11 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 06:26:11 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 06:26:11 INFO - Intel Iris: 06:26:11 INFO - Chipset Model: Intel Iris 06:26:11 INFO - Type: GPU 06:26:11 INFO - Bus: Built-In 06:26:11 INFO - VRAM (Dynamic, Max): 1536 MB 06:26:11 INFO - Vendor: Intel (0x8086) 06:26:11 INFO - Device ID: 0x0a2e 06:26:11 INFO - Revision ID: 0x0009 06:26:11 INFO - Displays: 06:26:11 INFO - Display: 06:26:11 INFO - Resolution: 1600 x 1200 @ 60 Hz 06:26:11 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 06:26:11 INFO - Display Serial Number: 1600x1200 60 06:26:11 INFO - Main Display: Yes 06:26:11 INFO - Mirror: Off 06:26:11 INFO - Online: Yes 06:26:11 INFO - Rotation: Supported 06:26:11 INFO - Return code: 0 06:26:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:26:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:26:11 INFO - Python 2.7.3 06:26:11 INFO - Return code: 0 06:26:11 INFO - grabbing minidump binary from tooltool 06:26:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:26:11 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 0x10a327d30>, '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 0x10a18bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a31eb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:26:11 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 06:26:11 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 06:26:11 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:26:11 INFO - Return code: 0 06:26:11 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 06:26:11 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:26:11 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:26:11 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 06:26:11 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:26:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 06:26:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 06:26:12 INFO - Return code: 0 06:26:12 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/D1q4ZZX2SdiPFfGmbKsf8A/artifacts/public/build/firefox-47.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0214', '--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 06:26:12 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/D1q4ZZX2SdiPFfGmbKsf8A/artifacts/public/build/firefox-47.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0214 --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 06:26:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZRWZ7NMchd/Render', 06:26:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:26:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:26:12 INFO - 'HOME': '/Users/cltbld', 06:26:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:26:12 INFO - 'LOGNAME': 'cltbld', 06:26:12 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:26:12 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 06:26:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:26:12 INFO - 'MOZ_NO_REMOTE': '1', 06:26:12 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:26:12 INFO - 'NO_EM_RESTART': '1', 06:26:12 INFO - 'PAGER': '/bin/cat', 06:26:12 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:26:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:26:12 INFO - 'PWD': '/builds/slave/test', 06:26:12 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:26:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:26:12 INFO - 'SHELL': '/bin/bash', 06:26:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JHDtPFup3Y/Listeners', 06:26:12 INFO - 'TMPDIR': '/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/', 06:26:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:26:12 INFO - 'USER': 'cltbld', 06:26:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:26:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:26:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:26:12 INFO - 'XPC_FLAGS': '0x0', 06:26:12 INFO - 'XPC_SERVICE_NAME': '0', 06:26:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:26:12 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/D1q4ZZX2SdiPFfGmbKsf8A/artifacts/public/build/firefox-47.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0214', '--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 06:26:13 INFO - mozversion application_buildid: 20160513041937 06:26:13 INFO - mozversion application_changeset: 3e9245c2bfaa9089cd3cc9e691159c091eb21e28 06:26:13 INFO - mozversion application_display_name: Firefox 06:26:13 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:26:13 INFO - mozversion application_name: Firefox 06:26:13 INFO - mozversion application_remotingname: firefox 06:26:13 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 06:26:13 INFO - mozversion application_vendor: Mozilla 06:26:13 INFO - mozversion application_version: 47.0 06:26:13 INFO - mozversion platform_buildid: 20160513041937 06:26:13 INFO - mozversion platform_changeset: 3e9245c2bfaa9089cd3cc9e691159c091eb21e28 06:26:13 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 06:26:13 INFO - mozversion platform_version: 47.0 06:26:13 INFO - using testdate: 1463145973 06:26:13 INFO - actual date: 1463145973 06:26:13 INFO - starting webserver on 'localhost:49272' 06:26:13 INFO - SUITE-START | Running 2 tests 06:26:13 INFO - TEST-START | dromaeo_css 06:26:13 INFO - operating with platform_type : mac_ 06:26:13 INFO - Initialising browser for dromaeo_css test... 06:26:13 INFO - TEST-INFO | started process 1669 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/tmpIWcGUq/profile http://localhost:49272/getInfo.html) 06:26:15 INFO - PROCESS | 1669 | __metrics Screen width/height:1600/1200 06:26:15 INFO - PROCESS | 1669 | colorDepth:24 06:26:15 INFO - PROCESS | 1669 | Browser inner width/height: 1024/689 06:26:15 INFO - PROCESS | 1669 | __metrics 06:26:15 INFO - PROCESS | 1669 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 06:26:15 INFO - PROCESS | 1669 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:26:16 INFO - TEST-INFO | 1669: exit 0 06:26:16 INFO - Browser initialized. 06:26:16 INFO - Running cycle 1/1 for dromaeo_css test... 06:26:16 INFO - TEST-INFO | started process 1673 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/tmpIWcGUq/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:26:28 INFO - PROCESS | 1673 | RSS: Main: 157208576 06:26:28 INFO - PROCESS | 1673 | 06:27:19 INFO - PROCESS | 1673 | 1463146039966 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] 06:29:28 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49272/tests/dromaeo/cssquery-ext.html) 06:29:30 INFO - PROCESS | 1673 | RSS: Main: 277393408 06:29:30 INFO - PROCESS | 1673 | 06:32:32 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-ext.html (next: http://localhost:49272/tests/dromaeo/cssquery-jquery.html) 06:32:32 INFO - PROCESS | 1673 | RSS: Main: 292007936 06:32:32 INFO - PROCESS | 1673 | 06:35:34 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49272/tests/dromaeo/cssquery-mootools.html) 06:35:35 INFO - PROCESS | 1673 | RSS: Main: 299520000 06:35:35 INFO - PROCESS | 1673 | 06:38:37 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49272/tests/dromaeo/cssquery-prototype.html) 06:38:37 INFO - PROCESS | 1673 | RSS: Main: 252792832 06:38:37 INFO - PROCESS | 1673 | 06:41:40 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49272/tests/dromaeo/cssquery-yui.html) 06:41:41 INFO - PROCESS | 1673 | RSS: Main: 254361600 06:41:41 INFO - PROCESS | 1673 | 06:44:43 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-yui.html (next: http://localhost:49272/tests/dromaeo/cssquery-dojo.html) 06:44:44 INFO - PROCESS | 1673 | RSS: Main: 301957120 06:44:44 INFO - PROCESS | 1673 | 06:44:44 INFO - PROCESS | 1673 | __start_tp_report 06:44:44 INFO - PROCESS | 1673 | _x_x_mozilla_page_load 06:44:44 INFO - PROCESS | 1673 | _x_x_mozilla_page_load_details 06:44:44 INFO - PROCESS | 1673 | |i|pagename|runs| 06:44:44 INFO - PROCESS | 1673 | |0;dojo.html;3011.8042327248727;3526.947095793563;3635.690966267867;3654.415293553032;3710.07248187953;5782.392848750884;5785.363610002896;5789.247397838286;5791.102379131231;5839.8540036499;5766.509846663039;5823.388544202861;5827.854303642411;5831.067029275317;5853.151293062503;5162.070827251093;5226.372835259775;5232.502912223333;5258.237555554442;5308.893822123555;5291.814786482474;5297.47025297471;5307;5315.707636080014;5326.2543243945875;5279.260903473517;5310.230016647603;5329.840104796862;5345.278387417708;5353.946460535403;5322.095243808542;5372.382176049726;5374.516293533601;5375.784968601251;5399.5680345572655;5115.974420127875;5282.445343238982;5282.4717528246865;5313.203019547061;5323.653962492425;5640.32316122068;5695.829125126253;5705.058665320217;5716.3426205986425;5726.198332233449;6183.443490085869;6327.145835312266;6338.651374174418;6340.9048864266615;6354.332795056545;6246.812595622138;6258.374162583751;6323.05154226865;6325.652089135096;6338.651374174418;5905.970470147665;5956.374580669054;5957.612755170943;5958.6424814511265;5977.103434484775;6215.06773983906;6280.0893870389455;6348.936510634927;6351.2696039956;6367.968160159169;6233.75064997395;6242.781502647385;6250.0937364082865;6260.342664020303;6265.65538895356;6306.779262725782;6309;6316.526260530479;6317.6209427434505;6336.936630633727;6078.3921607838865;6204.503639708812;6243.313235544087;6283.937160628427;6311.242650881832;6282.811515654537;6318.557700960889;6323.810285691437;6326.936730632727;6337.556371054075;4999.200127979506;5007.824726134568;5010.599152067826;5016.924746128811;5028.195488721787;4391.231534481453;4447.844325448594;4511.932321015187;4524.819007239674;4535.705179163344;5938.168656388109;5949.970250148808;5954.583179177503;5956.225690660273;5987.311459182162;6306.9684651576445;6307.400796924285;6308.179936608303;6312.8421789454715;6325.778597749057;5771.769129234867;5865.67738774363;5942.762289508458;5949.077892926603;5959.553033522417;5436.728163591804;5449.509544140967;5456.154296084113;5465.398806131322;5474.972625136849;6366.4588509977175;6386.489080873519;6408.10286559882;6419.518536109717;6427;6200.162977997912;6226.813195604139;6294.087357333253;6320.778772742932;6337.04944258365;6380;6415.101885735908;6416.230052393743;6427.035944608159;6428.582142160744;6130.459285710702;6302.275238347649;6307.936920630735;6312.400321969406;6331.493480521639;6257.342978987323;6279.937200628118;6316.431521163117;6318.778842740482;6326.778562750465;6189.195404597373;6229.470495007975;6234.1583886174785;6242.781502647385;6246.125542424155;6009.248843894513;6132.04958718918;6186.350433204449;6215;6217.720202590804;5996.970015149896;6017.518598512196;6033.607815491979;6035.758569657164;6075.544334175043;6159.014557670751;6177.62934223948;6196.659183744938;6213.440790328892;6218.968905155445;5919.852003699942;5933.554983376178;6050.969745151246;6054.513513917098;6054.727537260922 06:44:44 INFO - PROCESS | 1673 | |1;ext.html;487.95852352550077;526.0452279113412;609.5854818723267;657.5857209957727;662.7183447035011;32136.67863321369;32608.510872336934;32722.67277327226;32731.50902736461;32825.50761738576;34147.82926085372;38919.805400973026;39998.60004899829;43135.35296970548;43551.56448435515;9723.12491875731;9964.501774911261;9971.950140249324;9985.450800205987;9991;9862.802743945153;9996.950015249913;10002.749931251705;10009.799804003915;10012.649557265497;9972;10017.899821001805;10063.597456101783;10069.748256293578;10078.39529628221;9946.005399460033;10111.24165687569;10114.696559103239;10122.443265620388;10123;9611.134997850228;9725.319227654067;9736.853947190797;9760.365576237593;9780.706578802647;43600;43943.56056439459;44010.77994610038;44028.55971440308;44129.77935110336;3331.4336562784383;3433.656634336571;3445.3453843769603;3548.929021419583;3929.390944403622;29475.52622368873;30418.239544011354;30524.69475305263;30651.693483065108;30943.38113237745;2717.5108480473505;2721.102036328007;2787.4703806276743;2819.943601127966;2846.44494323607;468806;469987;471305;471515;471619.64190179174;68240.65879670669;68595.65702171458;68836.6558167206;69004.65497672479;69214.80888933351;71574.64212678903;77749;78754.60622696964;78846;78981;18798.812011879978;19051.237950482104;19063.237470501303;19085.713714294296;19104;14375.78436323456;14432.927835360755;14448.855511444961;14450.421983120768;14454.98815082934;22582.548349032928;22890.8855455725;22922.885385572965;22971.19600813997;22989;7474.925250747532;7987.480813747088;8343;9023.684171053981;9064.909350906539;988.4069558264983;1027.6146445082945;1042.697617690861;1144.594830379614;1151.4875880233217;30402.239944001136;30825;31138;31438;31632.36735265282;1090.1759713268755;1148.5807680196835;1152.8270759385991;1222.2605323779164;1226.1294480918648;15659.843401565839;15930.681386372207;16006.279717412745;16068.598285042968;16256.43102491407;531737;535149;536663;538586;539940;62944.05583916245;63333.05000424997;63549;63589.36410635834;63684.68157659182;1402.3479082226609;1425.978610320846;1487.7247709173837;1515.8559936805987;1546.5515000649686;30019.02264340308;31214.37571248517;31484.055478335686;31570.842145789124;31829.840850795597;47645.617719113216;50734.985300294524;51182.488175117775;51253.231201532755;51342.48657513377;322895;374286;374547;374556;374657;30670.539941900442;35218.11954701153;35545.82227088951;35579.46630800592;36259.63740362668;43871;44888.77555612201;44909.775451122536;45094.098118036796;45392.54607453883;35525.644743552235;36114.09714757047;36949.81525092357;37244.44133337948;37888.24223515459;37277.81361093177;37305.25389492249;37337.4399384004;37923.05192370213;38113.2377352457;37926.0518487029;38365.80817095897;38791.418128728656;39252.803735981135;39298;32259.838700806347;33967.32065358728;34393.484097739056;34402.48396274108;34474.65525344714;25669.10158144456;25791.742082578934;26082.60876086822;26820.927162913264;26855.328616784736 06:44:44 INFO - PROCESS | 1673 | |2;jquery.html;326.8774209671373;385.6914468425259;386.75054589789585;394.26469634132354;394.69016821794895;20601.793982060175;20797.896010519944;21051.368458946235;21169.788302116973;21271.36185914421;20931.9534023299;21256.14975400986;21777.911104444793;22042.787646679426;22060.227892023784;5923.081922302039;6032.396760323954;6092.969535152318;6138.7237574309265;6142.293636231823;5891.086881533369;6031.276246850384;6041.818745437644;6043.788467403641;6055.455009049185;5723.713814309289;5996.2804463464445;5998.070299103646;6001.519878409738;6010.609310394832;5927.733252003649;5950.821475355746;5964.463198312173;5966;5993.400659933994;5129.769160387791;5209.531142197183;5210.192420174879;5213;5223.059849227137;26952.326191845164;27090.86454567734;27370.726292737218;27433.725662743316;27454.45091098187;2251.5265429520437;2263.094762095175;2352.776486233805;2367.1596583213054;2427.538767634144;14429;14980.700385992328;15308.617284567863;15516.379344826193;16295.429659961963;1807.1054827860294;1821.6083542038393;1883.3690713610956;1915.4445210888964;1969.2615269274022;105481;109407;111291.44354278258;111378;112170.43914780456;11568.479418426192;11615.419229038514;11618.244814087057;11625.1862369635;11826.704332391588;14439.711205776035;14490.85509144916;14508.984371093922;14512.185976752906;14528.782068268985;8715.346349023848;9007.459552426875;9045.366824322366;9119.772005699779;9136.771580710403;9218.308626853013;9224.584893679801;9237.815243695088;9315;9319.114684105;4494.775261236925;4569.97175635486;4574.839880604163;4610.792514336863;4615.2384856498975;1642.605774614084;1849.5098798818324;1909.5321646196771;1912.6365990461768;1925.6891729924148;870.1733353314377;977.7066879935991;980.7352014955922;1014.4927536231884;1019.2277006542193;20740.58518829615;21264.468388290417;21344.786552134592;21364.679529807065;21449.92750362507;989.2827699917646;1009.3388830316155;1014.2595904989251;1040.328987802863;1057.6932689520106;8415.410921235578;10875.719519873865;11207.719807004727;11233.66299011031;11294.94352528232;632022;638755;645126;646421;663407;103228.96771032193;128133.604871758;128438;130787;132508;1028.5937054863286;1031.9122874555596;1044.4516628769804;1049.5434485998614;1051.731808388856;17810.465686029438;17847.643047139245;17982.37061702834;18268.725969110208;18471.445856624323;55474.89050219054;56431;58221.70889145527;59070.40929590649;59144;64549;79200.60399697964;80471;81591.59204203941;84217.15782842092;7847.84304313922;8105.837883242184;8215.876761848458;8275.08974012846;8283.544405057779;9551;13012.739745204854;13223.338833058117;13407.396667150197;13468.259245741578;10869.836952445561;11206.646604212881;11677;11687.824682629598;11848.229865058744;9785.168260697636;10839.566417343533;11058.281211721212;11190.66428007161;11474;11162.441877906234;11377.032952198824;11547.942260288644;11665.35840528779;11964.521419143137;6521.576097553833;7979.401544884273;8108.797280068045;8177.509349439053;8398.538080405637;9631.759206019906;11132;11172.21794474379;11367.20429569922;11552.82670759956 06:44:44 INFO - PROCESS | 1673 | |3;mootools.html;1535.3628244278625;1667.5747684340492;1682.1421075251621;2013.4865609269634;2078.9792102078973;7782.182870798562;8512.957435212831;8523.360747943914;8539;8881.067487913773;7764.223577642233;9045.140711632384;9082.409643373176;9199.034101419355;9200.953995230031;2603.9869800651018;2633.3285012321926;2636.841789492627;2638.287662331179;2639.8416095034263;2565.2817211180804;2641.4849104424643;2647.8808453619536;2649.390640152766;2650.390410205654;2624.776893964006;2630.5659566171557;2670.0921686626543;2671.27875473622;2674.398260391416;2612.6995395529566;2630.2240838952457;2660.9866950665123;2664.2806442260676;2665.5335316319565;2611.3863242138273;2636.6045093235975;2637.129747183425;2658.587918872578;2658.734126587345;9269.443833369953;9308.581113849894;9313.208377287938;9326;9346.766330841716;5734.340550836624;5854.619449735754;5906.468417842415;5907.054871220584;5908.320543137551;3666.651668091527;3730.4963829883163;3781.2815565042556;3832.463455116286;3848.5381754189398;1066.898644628759;1077.876044254905;1081.6106201767357;1103.150574057971;1122.7137080044618;12515.311657858814;12578.245305281713;12601.243925364508;12616.621501354974;12641.747165056648;5114.232865070269;5151.7166555839785;5160.845174644766;5189.299444574934;5194.6104042196985;10626.946865265625;10663.146948244123;10677.466126693635;10682.412467314372;10682.893171068345;5836.474717275466;5887.499562537232;5914.645121292736;5926.140709597171;5974.372690867396;4684.508126646653;4755.881102972453;5018.197088465828;5223.3209682741;5288.497592728685;4070.430139780433;4106.425100485934;4135.421041054255;4156.314208155681;4164.937525937114;1355.4849157320155;1364.1133263378883;1367.446184295362;1374.0656353679394;1380.6617378742071;1390.1589538329367;1403.4596680278166;1436.920969346696;1436.992815035918;1437.4465830655272;8018.4787988780545;8747.91252087471;8749.25631321332;8753.737387878375;8765.38642295046;1262.7474505099017;1264.222503160568;1268.5686866465446;1274.5730180389673;1303.5828534868751;6500.739970401226;6544.149260596188;6607.735690572324;6611.537192396582;6612.86774264512;11195.832062519068;11562.479688414041;11590.13074019452;11603.88396116028;11618.825717614243;11195.664130076111;11356.432178391047;11392.544298228144;11499.425028748528;11617.941910290394;8833.514156721314;8926.464412135163;8968.148025937526;8977.192052715156;8978.775530611656;8221.218984196492;8329.458585191944;8407.53758543286;8407.621657025325;8427.915720842713;9683;10098.444585547866;10112.797744045225;10163.237757168094;10235.641752538626;10236;10244.59021639156;10450.320729152581;10621.681349559525;10629.25595208328;6677.265500795006;6844.863102738017;6860.8284792878585;7320.304571065741;7468.253174682705;7830.765077047698;8139.1453897339925;8315.293200077818;8541.786455338666;8542.658293668184;7382.52013619113;7489.475736698597;7542.170361260147;7567.167611562613;7740.41946853977;5909.793157239476;7422.369098626677;7429;7499.100107987077;7518;7973.44185906981;7998.040235171817;8039.276465118168;8039.638216280398;8051.2351326623875;7179.820504487429;7216;7262.201157872735;7284.453665975179;7297.781066568012;7311.3785328247695;7382.5570465772225;7405.259474052552;7445.702171913063;7464.477486575887 06:44:44 INFO - PROCESS | 1673 | |4;prototype.html;337.49207442798587;346.2071855451017;347.8452088820476;348.16787876974035;353.80187095226694;6636.70134843932;6681.99770034495;6770.322967703233;6771.83070423239;6775.525713200078;6609.768658096968;6670.6331151786635;6675.532712710112;6691.230508491512;6698.464122870171;4734.739589322586;4842.782074806642;4892.828750993716;4897.902041959159;5037.017781532602;4862.878428039309;4892.828750993716;4968.080905032581;4985.900281994376;4993.700377977315;4060.2894493463527;4832.251001094818;4937.629677774164;4949.430815456215;4973.204287314031;3932.921341573167;4006.238814625241;4724.763761811896;4955.405351357842;5007.774650140753;4158.9376159357635;4252.043290259698;4263.360495925605;4269.380939763717;4296;6290.087937249074;6317.5893566918;6322.652254126021;6343.175387199681;6355.491560675181;5846.941530584725;5848.444397782204;5862;5864.061750120003;5871.735771890275;7014.894776578355;7021.508494405393;7035.33164349386;7042.92957070433;7043.330883566053;4275.230458517465;4411.558844115562;4785.994941062381;4793.880152996203;4809.759512024385;7399.149097853762;7420.740274090381;7470.887936680954;7476.626168691544;7488.176300606929;4630.490646028934;4913.164761990471;4913.680610760289;4913.975430122827;4919.139150648693;5001.774920128603;5010.69935803853;5010.849674509771;5012.874678133076;5013.273075404119;5873.177755114288;5886.970565147147;5888.057910734347;5889.293284805765;5890.4698577128265;6820.113385259884;7084.36240738336;7092;7178.066851309296;7182.3894968928225;1343.7782765843526;1728.0927513055494;1746.8253174682684;1747.257415598391;1750.9212085455931;913.9497327647043;1118.8657361116555;1135.6195674448986;1141.1612464838338;1143.6340371081174;6540.247871494744;6679.432248258952;6679.56582822115;6703.798886033427;6723.260441351447;7192.748253811092;7278.6724597392185;7335.339819416278;7335.596542190124;7374.889376659355;5439.564834813205;6746.898796518056;6747.628880411625;6767.154105736783;6768.593884366954;3477;3621.5332790220004;3934.6458818706456;3935.4883865097354;3938.8818335449982;7408.629568521553;7724.266194711493;7736.071671399468;7761.223877612194;7769.417293702995;7558.811029724191;7591.620418979029;7605.885911711329;7619.390448764086;7621.31408173267;7705.691772329044;7841.686332546634;7918.3665306776475;7934.60326983637;7944.6424910877995;7387.187409385071;7391.334779869838;7395.7041718330665;7398.075240594926;7408.37028852532;6974.302569742985;7223.494355395072;7249.383802376857;7272.272772722686;7289.671964761493;7697.422693297913;7729.729459468892;7730.884036739566;7750.147483776893;7767.990161278997;4927.1131196384995;4932.21084626458;4934.28452874324;4935.703857768545;4936.975315123402;7386.227305446761;7388.963055184905;7389.704411823682;7398.704051837866;7407.777766667009;5727.799527016535;6856.691448884712;7062.646867656494;7132.286771322826;7149.177844547944;5302.70835104073;7098.787036388917;7127.216006239206;7129.679164437509;7183.066201393785;6929.82675433098;6932.376086152271;6935.375816176366;6942.1669399670345;6949.992251123457;6965.024896514391;7118.5017048806085;7119.67961441726;7142.607156606437;7160.856782864418;6706.128203333536;6755.493337999571;6988.126484189476;7022.192447868356;7036.648167591702 06:44:44 INFO - PROCESS | 1673 | |5;yui.html;674.4435840431642;717.4654882112825;771;782.2881178127898;805.1465446626574;15635.218239088043;15673.608159796011;16004.119773412458;16007;16047;14947.476838310662;15033.323500442479;15048.097114173157;15052.172130532816;15076.849231507682;824.2169938558363;825.8018075661857;834.05751500804;947.5072962059725;975.8194733974202;996.2826764729383;1003.0170432975689;1005.4269066632023;1006.9194464442827;1011.1304278320638;1051.0645525482328;1055.6147006342705;1055.788842231553;1057.8095942730306;1058.7141471802609;860.8192279621255;872.6596627315321;1049.1659130990881;1057.7831544533353;1059.2214722179192;785.7839094249127;786.8150984518634;786.838698066895;787.2796391301952;787.4841978504089;15783.368665253376;15884.76172857408;15898.443554475654;15939.681206375924;15940.20298985046;13054.34728263583;13147.211167329895;13353.265570393625;13356.131851429724;13374.86625133746;10205.795884082278;10490.16078713701;10508.842367364496;10575.841362379571;10781.9460902695;3586.4620306953907;3588.2285308658766;3625.854965801365;3671.1739858531882;3846.7114966377353;82754.58622706908;84142;84265.15734842696;84474;85765.14234857634;9957.01438136366;10033;10036.397816131055;10058.446785426871;10307.660004199406;23124.768752312262;23133.537329253657;23147.53704925892;23208.3037508875;23307.7669223309;7533.20901305366;7626.046744156981;7711.228877112244;7735.497192682457;7835;4154.958450415517;4224.302990006676;4225.830966761357;4287.035417031143;4523.2988886722615;3688.8708895189075;3758.079270578671;3758.511393518825;3760.7931563764255;3764.247150569897;633.3318349141608;642.4539141729492;646.3859333633068;653.3238098568054;653.833272515515;490.1741904435912;499.5054895653277;535.7937194180269;579.7130420441824;584.2900875436366;8124.512529248264;8182.631781569844;8194.467359621725;8329.125441828643;8391.95804020976;537.5296615461472;555.9444055594408;562.8395907166438;564.2467306146259;573.3091624592439;3683.4290684943876;3840.0975770693863;3842.289176502356;3882.6893848492055;3956.624120708528;85802;86453;86894.56552717196;87863.24273514622;88084.55957720299;84456;84743;85395;85652;86595;58373.24880253514;72686.63656681683;72883.63558182282;73407.53184936271;75894;7560.6219689016425;7640.617969101411;7834.921650783419;7853.410994175574;7925.643346049326;51018.48981510138;51839.222411663104;52873;52929.73535132454;53316.73341633267;67911.98132028122;68258;68536.6573167131;71282;73529;10846.457677115955;11047.337159770439;11063.944680276547;11106.333619982826;11732.94133529327;11718.589849355232;11948.61027794462;12047.75904481923;12087.51649934028;12587;11013.394263315595;11422.48598813072;11448;11633.53465861356;11690.415479226174;11158.497867595815;11359.432028398713;11362;11394.772104558027;11535.653930382103;11190.608328708457;11331.32012079278;11372.54509819598;11385.601503947322;11609.6517104487;9325.533723313943;9533.189678877096;9584.041595840361;9619.470929098967;9936.552855121681;9494.24046076326;9500.287478439006;9611.519424028631;9634.951825240829;9676.75808104803 06:44:44 INFO - PROCESS | 1673 | __end_tp_report 06:44:44 INFO - PROCESS | 1673 | __start_cc_report 06:44:44 INFO - PROCESS | 1673 | _x_x_mozilla_cycle_collect,1076 06:44:44 INFO - PROCESS | 1673 | __end_cc_report 06:44:44 INFO - PROCESS | 1673 | __startTimestamp1463147084043__endTimestamp 06:44:44 INFO - PROCESS | 1673 | 06:44:44 INFO - PROCESS | 1673 | ------- Summary: start ------- 06:44:44 INFO - PROCESS | 1673 | Number of tests: 6 06:44:44 INFO - PROCESS | 1673 | 06:44:44 INFO - PROCESS | 1673 | [#0] dojo.html Cycles:165 Average:5839.38 Median:6050.97 stddev:631.45 (10.4%) stddev-sans-first:593.15 06:44:44 INFO - PROCESS | 1673 | Values: 3011.8 3526.9 3635.7 3654.4 3710.1 5782.4 5785.4 5789.2 5791.1 5839.9 5766.5 5823.4 5827.9 5831.1 5853.2 5162.1 5226.4 5232.5 5258.2 5308.9 5291.8 5297.5 5307.0 5315.7 5326.3 5279.3 5310.2 5329.8 5345.3 5353.9 5322.1 5372.4 5374.5 5375.8 5399.6 5116.0 5282.4 5282.5 5313.2 5323.7 5640.3 5695.8 5705.1 5716.3 5726.2 6183.4 6327.1 6338.7 6340.9 6354.3 6246.8 6258.4 6323.1 6325.7 6338.7 5906.0 5956.4 5957.6 5958.6 5977.1 6215.1 6280.1 6348.9 6351.3 6368.0 6233.8 6242.8 6250.1 6260.3 6265.7 6306.8 6309.0 6316.5 6317.6 6336.9 6078.4 6204.5 6243.3 6283.9 6311.2 6282.8 6318.6 6323.8 6326.9 6337.6 4999.2 5007.8 5010.6 5016.9 5028.2 4391.2 4447.8 4511.9 4524.8 4535.7 5938.2 5950.0 5954.6 5956.2 5987.3 6307.0 6307.4 6308.2 6312.8 6325.8 5771.8 5865.7 5942.8 5949.1 5959.6 5436.7 5449.5 5456.2 5465.4 5475.0 6366.5 6386.5 6408.1 6419.5 6427.0 6200.2 6226.8 6294.1 6320.8 6337.0 6380.0 6415.1 6416.2 6427.0 6428.6 6130.5 6302.3 6307.9 6312.4 6331.5 6257.3 6279.9 6316.4 6318.8 6326.8 6189.2 6229.5 6234.2 6242.8 6246.1 6009.2 6132.0 6186.4 6215.0 6217.7 5997.0 6017.5 6033.6 6035.8 6075.5 6159.0 6177.6 6196.7 6213.4 6219.0 5919.9 5933.6 6051.0 6054.5 6054.7 06:44:44 INFO - PROCESS | 1673 | 06:44:44 INFO - PROCESS | 1673 | [#1] ext.html Cycles:180 Average:62056.19 Median:35846.78 stddev:122778.83 (342.5%) stddev-sans-first:123036.24 06:44:44 INFO - PROCESS | 1673 | Values: 488.0 526.0 609.6 657.6 662.7 32136.7 32608.5 32722.7 32731.5 32825.5 34147.8 38919.8 39998.6 43135.4 43551.6 9723.1 9964.5 9972.0 9985.5 9991.0 9862.8 9997.0 10002.7 10009.8 10012.6 9972.0 10017.9 10063.6 10069.7 10078.4 9946.0 10111.2 10114.7 10122.4 10123.0 9611.1 9725.3 9736.9 9760.4 9780.7 43600.0 43943.6 44010.8 44028.6 44129.8 3331.4 3433.7 3445.3 3548.9 3929.4 29475.5 30418.2 30524.7 30651.7 30943.4 2717.5 2721.1 2787.5 2819.9 2846.4 468806.0 469987.0 471305.0 471515.0 471619.6 68240.7 68595.7 68836.7 69004.7 69214.8 71574.6 77749.0 78754.6 78846.0 78981.0 18798.8 19051.2 19063.2 19085.7 19104.0 14375.8 14432.9 14448.9 14450.4 14455.0 22582.5 22890.9 22922.9 22971.2 22989.0 7474.9 7987.5 8343.0 9023.7 9064.9 988.4 1027.6 1042.7 1144.6 1151.5 30402.2 30825.0 31138.0 31438.0 31632.4 1090.2 1148.6 1152.8 1222.3 1226.1 15659.8 15930.7 16006.3 16068.6 16256.4 531737.0 535149.0 536663.0 538586.0 539940.0 62944.1 63333.1 63549.0 63589.4 63684.7 1402.3 1426.0 1487.7 1515.9 1546.6 30019.0 31214.4 31484.1 31570.8 31829.8 47645.6 50735.0 51182.5 51253.2 51342.5 322895.0 374286.0 374547.0 374556.0 374657.0 30670.5 35218.1 35545.8 35579.5 36259.6 43871.0 44888.8 44909.8 45094.1 45392.5 35525.6 36114.1 36949.8 37244.4 37888.2 37277.8 37305.3 37337.4 37923.1 38113.2 37926.1 38365.8 38791.4 39252.8 39298.0 32259.8 33967.3 34393.5 34402.5 34474.7 25669.1 25791.7 26082.6 26820.9 26855.3 06:44:44 INFO - PROCESS | 1673 | 06:44:44 INFO - PROCESS | 1673 | [#2] jquery.html Cycles:180 Average:36429.42 Median:22051.51 stddev:107021.32 (485.3%) stddev-sans-first:107287.21 06:44:44 INFO - PROCESS | 1673 | Values: 326.9 385.7 386.8 394.3 394.7 20601.8 20797.9 21051.4 21169.8 21271.4 20932.0 21256.1 21777.9 22042.8 22060.2 5923.1 6032.4 6093.0 6138.7 6142.3 5891.1 6031.3 6041.8 6043.8 6055.5 5723.7 5996.3 5998.1 6001.5 6010.6 5927.7 5950.8 5964.5 5966.0 5993.4 5129.8 5209.5 5210.2 5213.0 5223.1 26952.3 27090.9 27370.7 27433.7 27454.5 2251.5 2263.1 2352.8 2367.2 2427.5 14429.0 14980.7 15308.6 15516.4 16295.4 1807.1 1821.6 1883.4 1915.4 1969.3 105481.0 109407.0 111291.4 111378.0 112170.4 11568.5 11615.4 11618.2 11625.2 11826.7 14439.7 14490.9 14509.0 14512.2 14528.8 8715.3 9007.5 9045.4 9119.8 9136.8 9218.3 9224.6 9237.8 9315.0 9319.1 4494.8 4570.0 4574.8 4610.8 4615.2 1642.6 1849.5 1909.5 1912.6 1925.7 870.2 977.7 980.7 1014.5 1019.2 20740.6 21264.5 21344.8 21364.7 21449.9 989.3 1009.3 1014.3 1040.3 1057.7 8415.4 10875.7 11207.7 11233.7 11294.9 632022.0 638755.0 645126.0 646421.0 663407.0 103229.0 128133.6 128438.0 130787.0 132508.0 1028.6 1031.9 1044.5 1049.5 1051.7 17810.5 17847.6 17982.4 18268.7 18471.4 55474.9 56431.0 58221.7 59070.4 59144.0 64549.0 79200.6 80471.0 81591.6 84217.2 7847.8 8105.8 8215.9 8275.1 8283.5 9551.0 13012.7 13223.3 13407.4 13468.3 10869.8 11206.6 11677.0 11687.8 11848.2 9785.2 10839.6 11058.3 11190.7 11474.0 11162.4 11377.0 11547.9 11665.4 11964.5 6521.6 7979.4 8108.8 8177.5 8398.5 9631.8 11132.0 11172.2 11367.2 11552.8 06:44:44 INFO - PROCESS | 1673 | 06:44:44 INFO - PROCESS | 1673 | [#3] mootools.html Cycles:180 Average:6345.33 Median:4887.04 stddev:3322.96 (68.0%) stddev-sans-first:3312.61 06:44:44 INFO - PROCESS | 1673 | Values: 1535.4 1667.6 1682.1 2013.5 2079.0 7782.2 8513.0 8523.4 8539.0 8881.1 7764.2 9045.1 9082.4 9199.0 9201.0 2604.0 2633.3 2636.8 2638.3 2639.8 2565.3 2641.5 2647.9 2649.4 2650.4 2624.8 2630.6 2670.1 2671.3 2674.4 2612.7 2630.2 2661.0 2664.3 2665.5 2611.4 2636.6 2637.1 2658.6 2658.7 9269.4 9308.6 9313.2 9326.0 9346.8 5734.3 5854.6 5906.5 5907.1 5908.3 3666.7 3730.5 3781.3 3832.5 3848.5 1066.9 1077.9 1081.6 1103.2 1122.7 12515.3 12578.2 12601.2 12616.6 12641.7 5114.2 5151.7 5160.8 5189.3 5194.6 10626.9 10663.1 10677.5 10682.4 10682.9 5836.5 5887.5 5914.6 5926.1 5974.4 4684.5 4755.9 5018.2 5223.3 5288.5 4070.4 4106.4 4135.4 4156.3 4164.9 1355.5 1364.1 1367.4 1374.1 1380.7 1390.2 1403.5 1436.9 1437.0 1437.4 8018.5 8747.9 8749.3 8753.7 8765.4 1262.7 1264.2 1268.6 1274.6 1303.6 6500.7 6544.1 6607.7 6611.5 6612.9 11195.8 11562.5 11590.1 11603.9 11618.8 11195.7 11356.4 11392.5 11499.4 11617.9 8833.5 8926.5 8968.1 8977.2 8978.8 8221.2 8329.5 8407.5 8407.6 8427.9 9683.0 10098.4 10112.8 10163.2 10235.6 10236.0 10244.6 10450.3 10621.7 10629.3 6677.3 6844.9 6860.8 7320.3 7468.3 7830.8 8139.1 8315.3 8541.8 8542.7 7382.5 7489.5 7542.2 7567.2 7740.4 5909.8 7422.4 7429.0 7499.1 7518.0 7973.4 7998.0 8039.3 8039.6 8051.2 7179.8 7216.0 7262.2 7284.5 7297.8 7311.4 7382.6 7405.3 7445.7 7464.5 06:44:44 INFO - PROCESS | 1673 | 06:44:44 INFO - PROCESS | 1673 | [#4] prototype.html Cycles:180 Average:5847.18 Median:6694.85 stddev:1863.45 (27.8%) stddev-sans-first:1822.22 06:44:44 INFO - PROCESS | 1673 | Values: 337.5 346.2 347.8 348.2 353.8 6636.7 6682.0 6770.3 6771.8 6775.5 6609.8 6670.6 6675.5 6691.2 6698.5 4734.7 4842.8 4892.8 4897.9 5037.0 4862.9 4892.8 4968.1 4985.9 4993.7 4060.3 4832.3 4937.6 4949.4 4973.2 3932.9 4006.2 4724.8 4955.4 5007.8 4158.9 4252.0 4263.4 4269.4 4296.0 6290.1 6317.6 6322.7 6343.2 6355.5 5846.9 5848.4 5862.0 5864.1 5871.7 7014.9 7021.5 7035.3 7042.9 7043.3 4275.2 4411.6 4786.0 4793.9 4809.8 7399.1 7420.7 7470.9 7476.6 7488.2 4630.5 4913.2 4913.7 4914.0 4919.1 5001.8 5010.7 5010.8 5012.9 5013.3 5873.2 5887.0 5888.1 5889.3 5890.5 6820.1 7084.4 7092.0 7178.1 7182.4 1343.8 1728.1 1746.8 1747.3 1750.9 913.9 1118.9 1135.6 1141.2 1143.6 6540.2 6679.4 6679.6 6703.8 6723.3 7192.7 7278.7 7335.3 7335.6 7374.9 5439.6 6746.9 6747.6 6767.2 6768.6 3477.0 3621.5 3934.6 3935.5 3938.9 7408.6 7724.3 7736.1 7761.2 7769.4 7558.8 7591.6 7605.9 7619.4 7621.3 7705.7 7841.7 7918.4 7934.6 7944.6 7387.2 7391.3 7395.7 7398.1 7408.4 6974.3 7223.5 7249.4 7272.3 7289.7 7697.4 7729.7 7730.9 7750.1 7768.0 4927.1 4932.2 4934.3 4935.7 4937.0 7386.2 7389.0 7389.7 7398.7 7407.8 5727.8 6856.7 7062.6 7132.3 7149.2 5302.7 7098.8 7127.2 7129.7 7183.1 6929.8 6932.4 6935.4 6942.2 6950.0 6965.0 7118.5 7119.7 7142.6 7160.9 6706.1 6755.5 6988.1 7022.2 7036.6 06:44:44 INFO - PROCESS | 1673 | 06:44:44 INFO - PROCESS | 1673 | [#5] yui.html Cycles:180 Average:18790.99 Median:2506.74 stddev:26253.70 (1047.3%) stddev-sans-first:26292.11 06:44:44 INFO - PROCESS | 1673 | Values: 674.4 717.5 771.0 782.3 805.1 15635.2 15673.6 16004.1 16007.0 16047.0 14947.5 15033.3 15048.1 15052.2 15076.8 824.2 825.8 834.1 947.5 975.8 996.3 1003.0 1005.4 1006.9 1011.1 1051.1 1055.6 1055.8 1057.8 1058.7 860.8 872.7 1049.2 1057.8 1059.2 785.8 786.8 786.8 787.3 787.5 15783.4 15884.8 15898.4 15939.7 15940.2 13054.3 13147.2 13353.3 13356.1 13374.9 10205.8 10490.2 10508.8 10575.8 10781.9 3586.5 3588.2 3625.9 3671.2 3846.7 82754.6 84142.0 84265.2 84474.0 85765.1 9957.0 10033.0 10036.4 10058.4 10307.7 23124.8 23133.5 23147.5 23208.3 23307.8 7533.2 7626.0 7711.2 7735.5 7835.0 4155.0 4224.3 4225.8 4287.0 4523.3 3688.9 3758.1 3758.5 3760.8 3764.2 633.3 642.5 646.4 653.3 653.8 490.2 499.5 535.8 579.7 584.3 8124.5 8182.6 8194.5 8329.1 8392.0 537.5 555.9 562.8 564.2 573.3 3683.4 3840.1 3842.3 3882.7 3956.6 85802.0 86453.0 86894.6 87863.2 88084.6 84456.0 84743.0 85395.0 85652.0 86595.0 58373.2 72686.6 72883.6 73407.5 75894.0 7560.6 7640.6 7834.9 7853.4 7925.6 51018.5 51839.2 52873.0 52929.7 53316.7 67912.0 68258.0 68536.7 71282.0 73529.0 10846.5 11047.3 11063.9 11106.3 11732.9 11718.6 11948.6 12047.8 12087.5 12587.0 11013.4 11422.5 11448.0 11633.5 11690.4 11158.5 11359.4 11362.0 11394.8 11535.7 11190.6 11331.3 11372.5 11385.6 11609.7 9325.5 9533.2 9584.0 9619.5 9936.6 9494.2 9500.3 9611.5 9635.0 9676.8 06:44:44 INFO - PROCESS | 1673 | -------- Summary: end -------- 06:44:44 INFO - PROCESS | 1673 | 06:44:44 INFO - TEST-INFO | 1673: exit 0 06:44:44 INFO - TEST-OK | dromaeo_css | took 1111446ms 06:44:44 INFO - TEST-START | kraken 06:44:44 INFO - operating with platform_type : mac_ 06:44:44 INFO - Initialising browser for kraken test... 06:44:44 INFO - TEST-INFO | started process 1681 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/tmpNBw2Rt/profile http://localhost:49272/getInfo.html) 06:44:46 INFO - PROCESS | 1681 | __metrics Screen width/height:1600/1200 06:44:46 INFO - PROCESS | 1681 | colorDepth:24 06:44:46 INFO - PROCESS | 1681 | Browser inner width/height: 1024/689 06:44:46 INFO - PROCESS | 1681 | __metrics 06:44:46 INFO - PROCESS | 1681 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 06:44:46 INFO - PROCESS | 1681 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:44:47 INFO - TEST-INFO | 1681: exit 0 06:44:47 INFO - Browser initialized. 06:44:47 INFO - Running cycle 1/1 for kraken test... 06:44:47 INFO - TEST-INFO | started process 1684 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/tmpNBw2Rt/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:44:59 INFO - PROCESS | 1684 | RSS: Main: 156848128 06:44:59 INFO - PROCESS | 1684 | 06:45:01 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-beat-detection) 06:45:02 INFO - PROCESS | 1684 | RSS: Main: 212901888 06:45:02 INFO - PROCESS | 1684 | 06:45:04 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-dft) 06:45:05 INFO - PROCESS | 1684 | RSS: Main: 223453184 06:45:05 INFO - PROCESS | 1684 | 06:45:08 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-fft) 06:45:09 INFO - PROCESS | 1684 | RSS: Main: 214208512 06:45:09 INFO - PROCESS | 1684 | 06:45:10 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-oscillator) 06:45:11 INFO - PROCESS | 1684 | RSS: Main: 215289856 06:45:11 INFO - PROCESS | 1684 | 06:45:13 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:45:14 INFO - PROCESS | 1684 | RSS: Main: 215298048 06:45:14 INFO - PROCESS | 1684 | 06:45:16 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-darkroom) 06:45:17 INFO - PROCESS | 1684 | RSS: Main: 215171072 06:45:17 INFO - PROCESS | 1684 | 06:45:20 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-desaturate) 06:45:20 INFO - PROCESS | 1684 | RSS: Main: 215207936 06:45:20 INFO - PROCESS | 1684 | 06:45:23 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49272/tests/kraken/driver.html?testName=json-parse-financial) 06:45:24 INFO - PROCESS | 1684 | RSS: Main: 215994368 06:45:24 INFO - PROCESS | 1684 | 06:45:25 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49272/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:45:26 INFO - PROCESS | 1684 | RSS: Main: 250286080 06:45:26 INFO - PROCESS | 1684 | 06:45:27 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:45:28 INFO - PROCESS | 1684 | RSS: Main: 250732544 06:45:28 INFO - PROCESS | 1684 | 06:45:30 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:45:31 INFO - PROCESS | 1684 | RSS: Main: 255680512 06:45:31 INFO - PROCESS | 1684 | 06:45:33 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:45:34 INFO - PROCESS | 1684 | RSS: Main: 257638400 06:45:34 INFO - PROCESS | 1684 | 06:45:36 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:45:37 INFO - PROCESS | 1684 | RSS: Main: 257957888 06:45:37 INFO - PROCESS | 1684 | 06:45:39 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49272/tests/kraken/driver.html?testName=ai-astar) 06:45:39 INFO - PROCESS | 1684 | RSS: Main: 321482752 06:45:39 INFO - PROCESS | 1684 | 06:45:39 INFO - PROCESS | 1684 | __start_tp_report 06:45:39 INFO - PROCESS | 1684 | _x_x_mozilla_page_load 06:45:39 INFO - PROCESS | 1684 | _x_x_mozilla_page_load_details 06:45:39 INFO - PROCESS | 1684 | |i|pagename|runs| 06:45:39 INFO - PROCESS | 1684 | |0;ai-astar;113;109;110;110;113;111;120;111;110;110 06:45:39 INFO - PROCESS | 1684 | |1;audio-beat-detection;154;120;153;148;120;138;117;147;149;136 06:45:39 INFO - PROCESS | 1684 | |2;audio-dft;181;183;184;186;184;184;184;182;184;181 06:45:39 INFO - PROCESS | 1684 | |3;audio-fft;73;70;76;112;55;57;57;59;116;56 06:45:39 INFO - PROCESS | 1684 | |4;audio-oscillator;90;91;124;81;77;83;116;75;79;113 06:45:39 INFO - PROCESS | 1684 | |5;imaging-gaussian-blur;88;84;87;83;86;83;87;83;86;82 06:45:39 INFO - PROCESS | 1684 | |6;imaging-darkroom;92;93;93;93;93;92;94;92;93;91 06:45:39 INFO - PROCESS | 1684 | |7;imaging-desaturate;94;84;83;83;84;86;86;86;83;84 06:45:39 INFO - PROCESS | 1684 | |8;json-parse-financial;56;58;57;57;56;55;57;57;52;51 06:45:39 INFO - PROCESS | 1684 | |9;json-stringify-tinderbox;62;63;70;78;73;73;66;66;66;67 06:45:39 INFO - PROCESS | 1684 | |10;stanford-crypto-aes;82;82;81;80;80;82;79;79;81;83 06:45:39 INFO - PROCESS | 1684 | |11;stanford-crypto-ccm;131;130;120;148;126;133;116;115;114;116 06:45:39 INFO - PROCESS | 1684 | |12;stanford-crypto-pbkdf2;133;137;158;171;131;122;136;133;134;134 06:45:39 INFO - PROCESS | 1684 | |13;stanford-crypto-sha256-iterative;56;77;93;95;68;64;67;66;67;65 06:45:39 INFO - PROCESS | 1684 | __end_tp_report 06:45:39 INFO - PROCESS | 1684 | __start_cc_report 06:45:39 INFO - PROCESS | 1684 | _x_x_mozilla_cycle_collect,1202 06:45:39 INFO - PROCESS | 1684 | __end_cc_report 06:45:39 INFO - PROCESS | 1684 | __startTimestamp1463147139431__endTimestamp 06:45:39 INFO - PROCESS | 1684 | 06:45:39 INFO - PROCESS | 1684 | ------- Summary: start ------- 06:45:39 INFO - PROCESS | 1684 | Number of tests: 14 06:45:39 INFO - PROCESS | 1684 | 06:45:39 INFO - PROCESS | 1684 | [#0] ai-astar Cycles:10 Average:111.70 Median:111.00 stddev:3.20 (2.9%) stddev-sans-first:3.36 06:45:39 INFO - PROCESS | 1684 | Values: 113.0 109.0 110.0 110.0 113.0 111.0 120.0 111.0 110.0 110.0 06:45:39 INFO - PROCESS | 1684 | 06:45:39 INFO - PROCESS | 1684 | [#1] audio-beat-detection Cycles:10 Average:138.20 Median:147.50 stddev:14.44 (9.8%) stddev-sans-first:14.13 06:45:39 INFO - PROCESS | 1684 | Values: 154.0 120.0 153.0 148.0 120.0 138.0 117.0 147.0 149.0 136.0 06:45:39 INFO - PROCESS | 1684 | 06:45:39 INFO - PROCESS | 1684 | [#2] audio-dft Cycles:10 Average:183.30 Median:184.00 stddev:1.57 (0.9%) stddev-sans-first:1.42 06:45:39 INFO - PROCESS | 1684 | Values: 181.0 183.0 184.0 186.0 184.0 184.0 184.0 182.0 184.0 181.0 06:45:39 INFO - PROCESS | 1684 | 06:45:39 INFO - PROCESS | 1684 | [#3] audio-fft Cycles:10 Average:73.10 Median:58.00 stddev:22.87 (39.4%) stddev-sans-first:24.26 06:45:39 INFO - PROCESS | 1684 | Values: 73.0 70.0 76.0 112.0 55.0 57.0 57.0 59.0 116.0 56.0 06:45:39 INFO - PROCESS | 1684 | 06:45:39 INFO - PROCESS | 1684 | [#4] audio-oscillator Cycles:10 Average:92.90 Median:80.00 stddev:18.02 (22.5%) stddev-sans-first:19.08 06:45:39 INFO - PROCESS | 1684 | Values: 90.0 91.0 124.0 81.0 77.0 83.0 116.0 75.0 79.0 113.0 06:45:39 INFO - PROCESS | 1684 | 06:45:39 INFO - PROCESS | 1684 | [#5] imaging-gaussian-blur Cycles:10 Average:84.90 Median:86.00 stddev:2.13 (2.5%) stddev-sans-first:1.94 06:45:39 INFO - PROCESS | 1684 | Values: 88.0 84.0 87.0 83.0 86.0 83.0 87.0 83.0 86.0 82.0 06:45:39 INFO - PROCESS | 1684 | 06:45:39 INFO - PROCESS | 1684 | [#6] imaging-darkroom Cycles:10 Average:92.60 Median:93.00 stddev:0.84 (0.9%) stddev-sans-first:0.87 06:45:39 INFO - PROCESS | 1684 | Values: 92.0 93.0 93.0 93.0 93.0 92.0 94.0 92.0 93.0 91.0 06:45:39 INFO - PROCESS | 1684 | 06:45:39 INFO - PROCESS | 1684 | [#7] imaging-desaturate Cycles:10 Average:85.30 Median:85.00 stddev:3.30 (3.9%) stddev-sans-first:1.32 06:45:39 INFO - PROCESS | 1684 | Values: 94.0 84.0 83.0 83.0 84.0 86.0 86.0 86.0 83.0 84.0 06:45:39 INFO - PROCESS | 1684 | 06:45:39 INFO - PROCESS | 1684 | [#8] json-parse-financial Cycles:10 Average:55.60 Median:57.00 stddev:2.32 (4.1%) stddev-sans-first:2.46 06:45:39 INFO - PROCESS | 1684 | Values: 56.0 58.0 57.0 57.0 56.0 55.0 57.0 57.0 52.0 51.0 06:45:39 INFO - PROCESS | 1684 | 06:45:39 INFO - PROCESS | 1684 | [#9] json-stringify-tinderbox Cycles:10 Average:68.40 Median:68.50 stddev:5.02 (7.3%) stddev-sans-first:4.76 06:45:39 INFO - PROCESS | 1684 | Values: 62.0 63.0 70.0 78.0 73.0 73.0 66.0 66.0 66.0 67.0 06:45:39 INFO - PROCESS | 1684 | 06:45:39 INFO - PROCESS | 1684 | [#10] stanford-crypto-aes Cycles:10 Average:80.90 Median:81.50 stddev:1.37 (1.7%) stddev-sans-first:1.39 06:45:39 INFO - PROCESS | 1684 | Values: 82.0 82.0 81.0 80.0 80.0 82.0 79.0 79.0 81.0 83.0 06:45:39 INFO - PROCESS | 1684 | 06:45:39 INFO - PROCESS | 1684 | [#11] stanford-crypto-ccm Cycles:10 Average:124.90 Median:128.00 stddev:10.87 (8.5%) stddev-sans-first:11.30 06:45:39 INFO - PROCESS | 1684 | Values: 131.0 130.0 120.0 148.0 126.0 133.0 116.0 115.0 114.0 116.0 06:45:39 INFO - PROCESS | 1684 | 06:45:39 INFO - PROCESS | 1684 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:138.90 Median:135.00 stddev:14.43 (10.7%) stddev-sans-first:15.14 06:45:39 INFO - PROCESS | 1684 | Values: 133.0 137.0 158.0 171.0 131.0 122.0 136.0 133.0 134.0 134.0 06:45:39 INFO - PROCESS | 1684 | 06:45:39 INFO - PROCESS | 1684 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.80 Median:67.50 stddev:12.76 (18.9%) stddev-sans-first:12.19 06:45:39 INFO - PROCESS | 1684 | Values: 56.0 77.0 93.0 95.0 68.0 64.0 67.0 66.0 67.0 65.0 06:45:39 INFO - PROCESS | 1684 | -------- Summary: end -------- 06:45:39 INFO - PROCESS | 1684 | 06:45:40 INFO - TEST-INFO | 1684: exit 0 06:45:40 INFO - TEST-OK | kraken | took 55721ms 06:45:40 INFO - SUITE-END | took 1167s 06:45:40 INFO - Completed test suite (00:19:27) 06:45:40 INFO - javascript benchmark 06:45:40 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3011.8042327248727, 3526.947095793563, 3635.690966267867, 3654.415293553032, 3710.07248187953, 5782.392848750884, 5785.363610002896, 5789.247397838286, 5791.102379131231, 5839.8540036499, 5766.509846663039, 5823.388544202861, 5827.854303642411, 5831.067029275317, 5853.151293062503, 5162.070827251093, 5226.372835259775, 5232.502912223333, 5258.237555554442, 5308.893822123555, 5291.814786482474, 5297.47025297471, 5307.0, 5315.707636080014, 5326.2543243945875, 5279.260903473517, 5310.230016647603, 5329.840104796862, 5345.278387417708, 5353.946460535403, 5322.095243808542, 5372.382176049726, 5374.516293533601, 5375.784968601251, 5399.5680345572655, 5115.974420127875, 5282.445343238982, 5282.4717528246865, 5313.203019547061, 5323.653962492425, 5640.32316122068, 5695.829125126253, 5705.058665320217, 5716.3426205986425, 5726.198332233449, 6183.443490085869, 6327.145835312266, 6338.651374174418, 6340.9048864266615, 6354.332795056545, 6246.812595622138, 6258.374162583751, 6323.05154226865, 6325.652089135096, 6338.651374174418, 5905.970470147665, 5956.374580669054, 5957.612755170943, 5958.6424814511265, 5977.103434484775, 6215.06773983906, 6280.0893870389455, 6348.936510634927, 6351.2696039956, 6367.968160159169, 6233.75064997395, 6242.781502647385, 6250.0937364082865, 6260.342664020303, 6265.65538895356, 6306.779262725782, 6309.0, 6316.526260530479, 6317.6209427434505, 6336.936630633727, 6078.3921607838865, 6204.503639708812, 6243.313235544087, 6283.937160628427, 6311.242650881832, 6282.811515654537, 6318.557700960889, 6323.810285691437, 6326.936730632727, 6337.556371054075, 4999.200127979506, 5007.824726134568, 5010.599152067826, 5016.924746128811, 5028.195488721787, 4391.231534481453, 4447.844325448594, 4511.932321015187, 4524.819007239674, 4535.705179163344, 5938.168656388109, 5949.970250148808, 5954.583179177503, 5956.225690660273, 5987.311459182162, 6306.9684651576445, 6307.400796924285, 6308.179936608303, 6312.8421789454715, 6325.778597749057, 5771.769129234867, 5865.67738774363, 5942.762289508458, 5949.077892926603, 5959.553033522417, 5436.728163591804, 5449.509544140967, 5456.154296084113, 5465.398806131322, 5474.972625136849, 6366.4588509977175, 6386.489080873519, 6408.10286559882, 6419.518536109717, 6427.0, 6200.162977997912, 6226.813195604139, 6294.087357333253, 6320.778772742932, 6337.04944258365, 6380.0, 6415.101885735908, 6416.230052393743, 6427.035944608159, 6428.582142160744, 6130.459285710702, 6302.275238347649, 6307.936920630735, 6312.400321969406, 6331.493480521639, 6257.342978987323, 6279.937200628118, 6316.431521163117, 6318.778842740482, 6326.778562750465, 6189.195404597373, 6229.470495007975, 6234.1583886174785, 6242.781502647385, 6246.125542424155, 6009.248843894513, 6132.04958718918, 6186.350433204449, 6215.0, 6217.720202590804, 5996.970015149896, 6017.518598512196, 6033.607815491979, 6035.758569657164, 6075.544334175043, 6159.014557670751, 6177.62934223948, 6196.659183744938, 6213.440790328892, 6218.968905155445, 5919.852003699942, 5933.554983376178, 6050.969745151246, 6054.513513917098, 6054.727537260922], "unit": "score", "name": "dojo.html", "value": 5799.557415918614}, {"lowerIsBetter": false, "replicates": [487.95852352550077, 526.0452279113412, 609.5854818723267, 657.5857209957727, 662.7183447035011, 32136.67863321369, 32608.510872336934, 32722.67277327226, 32731.50902736461, 32825.50761738576, 34147.82926085372, 38919.805400973026, 39998.60004899829, 43135.35296970548, 43551.56448435515, 9723.12491875731, 9964.501774911261, 9971.950140249324, 9985.450800205987, 9991.0, 9862.802743945153, 9996.950015249913, 10002.749931251705, 10009.799804003915, 10012.649557265497, 9972.0, 10017.899821001805, 10063.597456101783, 10069.748256293578, 10078.39529628221, 9946.005399460033, 10111.24165687569, 10114.696559103239, 10122.443265620388, 10123.0, 9611.134997850228, 9725.319227654067, 9736.853947190797, 9760.365576237593, 9780.706578802647, 43600.0, 43943.56056439459, 44010.77994610038, 44028.55971440308, 44129.77935110336, 3331.4336562784383, 3433.656634336571, 3445.3453843769603, 3548.929021419583, 3929.390944403622, 29475.52622368873, 30418.239544011354, 30524.69475305263, 30651.693483065108, 30943.38113237745, 2717.5108480473505, 2721.102036328007, 2787.4703806276743, 2819.943601127966, 2846.44494323607, 468806.0, 469987.0, 471305.0, 471515.0, 471619.64190179174, 68240.65879670669, 68595.65702171458, 68836.6558167206, 69004.65497672479, 69214.80888933351, 71574.64212678903, 77749.0, 78754.60622696964, 78846.0, 78981.0, 18798.812011879978, 19051.237950482104, 19063.237470501303, 19085.713714294296, 19104.0, 14375.78436323456, 14432.927835360755, 14448.855511444961, 14450.421983120768, 14454.98815082934, 22582.548349032928, 22890.8855455725, 22922.885385572965, 22971.19600813997, 22989.0, 7474.925250747532, 7987.480813747088, 8343.0, 9023.684171053981, 9064.909350906539, 988.4069558264983, 1027.6146445082945, 1042.697617690861, 1144.594830379614, 1151.4875880233217, 30402.239944001136, 30825.0, 31138.0, 31438.0, 31632.36735265282, 1090.1759713268755, 1148.5807680196835, 1152.8270759385991, 1222.2605323779164, 1226.1294480918648, 15659.843401565839, 15930.681386372207, 16006.279717412745, 16068.598285042968, 16256.43102491407, 531737.0, 535149.0, 536663.0, 538586.0, 539940.0, 62944.05583916245, 63333.05000424997, 63549.0, 63589.36410635834, 63684.68157659182, 1402.3479082226609, 1425.978610320846, 1487.7247709173837, 1515.8559936805987, 1546.5515000649686, 30019.02264340308, 31214.37571248517, 31484.055478335686, 31570.842145789124, 31829.840850795597, 47645.617719113216, 50734.985300294524, 51182.488175117775, 51253.231201532755, 51342.48657513377, 322895.0, 374286.0, 374547.0, 374556.0, 374657.0, 30670.539941900442, 35218.11954701153, 35545.82227088951, 35579.46630800592, 36259.63740362668, 43871.0, 44888.77555612201, 44909.775451122536, 45094.098118036796, 45392.54607453883, 35525.644743552235, 36114.09714757047, 36949.81525092357, 37244.44133337948, 37888.24223515459, 37277.81361093177, 37305.25389492249, 37337.4399384004, 37923.05192370213, 38113.2377352457, 37926.0518487029, 38365.80817095897, 38791.418128728656, 39252.803735981135, 39298.0, 32259.838700806347, 33967.32065358728, 34393.484097739056, 34402.48396274108, 34474.65525344714, 25669.10158144456, 25791.742082578934, 26082.60876086822, 26820.927162913264, 26855.328616784736], "unit": "score", "name": "ext.html", "value": 20514.566236153656}, {"lowerIsBetter": false, "replicates": [326.8774209671373, 385.6914468425259, 386.75054589789585, 394.26469634132354, 394.69016821794895, 20601.793982060175, 20797.896010519944, 21051.368458946235, 21169.788302116973, 21271.36185914421, 20931.9534023299, 21256.14975400986, 21777.911104444793, 22042.787646679426, 22060.227892023784, 5923.081922302039, 6032.396760323954, 6092.969535152318, 6138.7237574309265, 6142.293636231823, 5891.086881533369, 6031.276246850384, 6041.818745437644, 6043.788467403641, 6055.455009049185, 5723.713814309289, 5996.2804463464445, 5998.070299103646, 6001.519878409738, 6010.609310394832, 5927.733252003649, 5950.821475355746, 5964.463198312173, 5966.0, 5993.400659933994, 5129.769160387791, 5209.531142197183, 5210.192420174879, 5213.0, 5223.059849227137, 26952.326191845164, 27090.86454567734, 27370.726292737218, 27433.725662743316, 27454.45091098187, 2251.5265429520437, 2263.094762095175, 2352.776486233805, 2367.1596583213054, 2427.538767634144, 14429.0, 14980.700385992328, 15308.617284567863, 15516.379344826193, 16295.429659961963, 1807.1054827860294, 1821.6083542038393, 1883.3690713610956, 1915.4445210888964, 1969.2615269274022, 105481.0, 109407.0, 111291.44354278258, 111378.0, 112170.43914780456, 11568.479418426192, 11615.419229038514, 11618.244814087057, 11625.1862369635, 11826.704332391588, 14439.711205776035, 14490.85509144916, 14508.984371093922, 14512.185976752906, 14528.782068268985, 8715.346349023848, 9007.459552426875, 9045.366824322366, 9119.772005699779, 9136.771580710403, 9218.308626853013, 9224.584893679801, 9237.815243695088, 9315.0, 9319.114684105, 4494.775261236925, 4569.97175635486, 4574.839880604163, 4610.792514336863, 4615.2384856498975, 1642.605774614084, 1849.5098798818324, 1909.5321646196771, 1912.6365990461768, 1925.6891729924148, 870.1733353314377, 977.7066879935991, 980.7352014955922, 1014.4927536231884, 1019.2277006542193, 20740.58518829615, 21264.468388290417, 21344.786552134592, 21364.679529807065, 21449.92750362507, 989.2827699917646, 1009.3388830316155, 1014.2595904989251, 1040.328987802863, 1057.6932689520106, 8415.410921235578, 10875.719519873865, 11207.719807004727, 11233.66299011031, 11294.94352528232, 632022.0, 638755.0, 645126.0, 646421.0, 663407.0, 103228.96771032193, 128133.604871758, 128438.0, 130787.0, 132508.0, 1028.5937054863286, 1031.9122874555596, 1044.4516628769804, 1049.5434485998614, 1051.731808388856, 17810.465686029438, 17847.643047139245, 17982.37061702834, 18268.725969110208, 18471.445856624323, 55474.89050219054, 56431.0, 58221.70889145527, 59070.40929590649, 59144.0, 64549.0, 79200.60399697964, 80471.0, 81591.59204203941, 84217.15782842092, 7847.84304313922, 8105.837883242184, 8215.876761848458, 8275.08974012846, 8283.544405057779, 9551.0, 13012.739745204854, 13223.338833058117, 13407.396667150197, 13468.259245741578, 10869.836952445561, 11206.646604212881, 11677.0, 11687.824682629598, 11848.229865058744, 9785.168260697636, 10839.566417343533, 11058.281211721212, 11190.66428007161, 11474.0, 11162.441877906234, 11377.032952198824, 11547.942260288644, 11665.35840528779, 11964.521419143137, 6521.576097553833, 7979.401544884273, 8108.797280068045, 8177.509349439053, 8398.538080405637, 9631.759206019906, 11132.0, 11172.21794474379, 11367.20429569922, 11552.82670759956], "unit": "score", "name": "jquery.html", "value": 9826.609064531503}, {"lowerIsBetter": false, "replicates": [1535.3628244278625, 1667.5747684340492, 1682.1421075251621, 2013.4865609269634, 2078.9792102078973, 7782.182870798562, 8512.957435212831, 8523.360747943914, 8539.0, 8881.067487913773, 7764.223577642233, 9045.140711632384, 9082.409643373176, 9199.034101419355, 9200.953995230031, 2603.9869800651018, 2633.3285012321926, 2636.841789492627, 2638.287662331179, 2639.8416095034263, 2565.2817211180804, 2641.4849104424643, 2647.8808453619536, 2649.390640152766, 2650.390410205654, 2624.776893964006, 2630.5659566171557, 2670.0921686626543, 2671.27875473622, 2674.398260391416, 2612.6995395529566, 2630.2240838952457, 2660.9866950665123, 2664.2806442260676, 2665.5335316319565, 2611.3863242138273, 2636.6045093235975, 2637.129747183425, 2658.587918872578, 2658.734126587345, 9269.443833369953, 9308.581113849894, 9313.208377287938, 9326.0, 9346.766330841716, 5734.340550836624, 5854.619449735754, 5906.468417842415, 5907.054871220584, 5908.320543137551, 3666.651668091527, 3730.4963829883163, 3781.2815565042556, 3832.463455116286, 3848.5381754189398, 1066.898644628759, 1077.876044254905, 1081.6106201767357, 1103.150574057971, 1122.7137080044618, 12515.311657858814, 12578.245305281713, 12601.243925364508, 12616.621501354974, 12641.747165056648, 5114.232865070269, 5151.7166555839785, 5160.845174644766, 5189.299444574934, 5194.6104042196985, 10626.946865265625, 10663.146948244123, 10677.466126693635, 10682.412467314372, 10682.893171068345, 5836.474717275466, 5887.499562537232, 5914.645121292736, 5926.140709597171, 5974.372690867396, 4684.508126646653, 4755.881102972453, 5018.197088465828, 5223.3209682741, 5288.497592728685, 4070.430139780433, 4106.425100485934, 4135.421041054255, 4156.314208155681, 4164.937525937114, 1355.4849157320155, 1364.1133263378883, 1367.446184295362, 1374.0656353679394, 1380.6617378742071, 1390.1589538329367, 1403.4596680278166, 1436.920969346696, 1436.992815035918, 1437.4465830655272, 8018.4787988780545, 8747.91252087471, 8749.25631321332, 8753.737387878375, 8765.38642295046, 1262.7474505099017, 1264.222503160568, 1268.5686866465446, 1274.5730180389673, 1303.5828534868751, 6500.739970401226, 6544.149260596188, 6607.735690572324, 6611.537192396582, 6612.86774264512, 11195.832062519068, 11562.479688414041, 11590.13074019452, 11603.88396116028, 11618.825717614243, 11195.664130076111, 11356.432178391047, 11392.544298228144, 11499.425028748528, 11617.941910290394, 8833.514156721314, 8926.464412135163, 8968.148025937526, 8977.192052715156, 8978.775530611656, 8221.218984196492, 8329.458585191944, 8407.53758543286, 8407.621657025325, 8427.915720842713, 9683.0, 10098.444585547866, 10112.797744045225, 10163.237757168094, 10235.641752538626, 10236.0, 10244.59021639156, 10450.320729152581, 10621.681349559525, 10629.25595208328, 6677.265500795006, 6844.863102738017, 6860.8284792878585, 7320.304571065741, 7468.253174682705, 7830.765077047698, 8139.1453897339925, 8315.293200077818, 8541.786455338666, 8542.658293668184, 7382.52013619113, 7489.475736698597, 7542.170361260147, 7567.167611562613, 7740.41946853977, 5909.793157239476, 7422.369098626677, 7429.0, 7499.100107987077, 7518.0, 7973.44185906981, 7998.040235171817, 8039.276465118168, 8039.638216280398, 8051.2351326623875, 7179.820504487429, 7216.0, 7262.201157872735, 7284.453665975179, 7297.781066568012, 7311.3785328247695, 7382.5570465772225, 7405.259474052552, 7445.702171913063, 7464.477486575887], "unit": "score", "name": "mootools.html", "value": 5210.07235809205}, {"lowerIsBetter": false, "replicates": [337.49207442798587, 346.2071855451017, 347.8452088820476, 348.16787876974035, 353.80187095226694, 6636.70134843932, 6681.99770034495, 6770.322967703233, 6771.83070423239, 6775.525713200078, 6609.768658096968, 6670.6331151786635, 6675.532712710112, 6691.230508491512, 6698.464122870171, 4734.739589322586, 4842.782074806642, 4892.828750993716, 4897.902041959159, 5037.017781532602, 4862.878428039309, 4892.828750993716, 4968.080905032581, 4985.900281994376, 4993.700377977315, 4060.2894493463527, 4832.251001094818, 4937.629677774164, 4949.430815456215, 4973.204287314031, 3932.921341573167, 4006.238814625241, 4724.763761811896, 4955.405351357842, 5007.774650140753, 4158.9376159357635, 4252.043290259698, 4263.360495925605, 4269.380939763717, 4296.0, 6290.087937249074, 6317.5893566918, 6322.652254126021, 6343.175387199681, 6355.491560675181, 5846.941530584725, 5848.444397782204, 5862.0, 5864.061750120003, 5871.735771890275, 7014.894776578355, 7021.508494405393, 7035.33164349386, 7042.92957070433, 7043.330883566053, 4275.230458517465, 4411.558844115562, 4785.994941062381, 4793.880152996203, 4809.759512024385, 7399.149097853762, 7420.740274090381, 7470.887936680954, 7476.626168691544, 7488.176300606929, 4630.490646028934, 4913.164761990471, 4913.680610760289, 4913.975430122827, 4919.139150648693, 5001.774920128603, 5010.69935803853, 5010.849674509771, 5012.874678133076, 5013.273075404119, 5873.177755114288, 5886.970565147147, 5888.057910734347, 5889.293284805765, 5890.4698577128265, 6820.113385259884, 7084.36240738336, 7092.0, 7178.066851309296, 7182.3894968928225, 1343.7782765843526, 1728.0927513055494, 1746.8253174682684, 1747.257415598391, 1750.9212085455931, 913.9497327647043, 1118.8657361116555, 1135.6195674448986, 1141.1612464838338, 1143.6340371081174, 6540.247871494744, 6679.432248258952, 6679.56582822115, 6703.798886033427, 6723.260441351447, 7192.748253811092, 7278.6724597392185, 7335.339819416278, 7335.596542190124, 7374.889376659355, 5439.564834813205, 6746.898796518056, 6747.628880411625, 6767.154105736783, 6768.593884366954, 3477.0, 3621.5332790220004, 3934.6458818706456, 3935.4883865097354, 3938.8818335449982, 7408.629568521553, 7724.266194711493, 7736.071671399468, 7761.223877612194, 7769.417293702995, 7558.811029724191, 7591.620418979029, 7605.885911711329, 7619.390448764086, 7621.31408173267, 7705.691772329044, 7841.686332546634, 7918.3665306776475, 7934.60326983637, 7944.6424910877995, 7387.187409385071, 7391.334779869838, 7395.7041718330665, 7398.075240594926, 7408.37028852532, 6974.302569742985, 7223.494355395072, 7249.383802376857, 7272.272772722686, 7289.671964761493, 7697.422693297913, 7729.729459468892, 7730.884036739566, 7750.147483776893, 7767.990161278997, 4927.1131196384995, 4932.21084626458, 4934.28452874324, 4935.703857768545, 4936.975315123402, 7386.227305446761, 7388.963055184905, 7389.704411823682, 7398.704051837866, 7407.777766667009, 5727.799527016535, 6856.691448884712, 7062.646867656494, 7132.286771322826, 7149.177844547944, 5302.70835104073, 7098.787036388917, 7127.216006239206, 7129.679164437509, 7183.066201393785, 6929.82675433098, 6932.376086152271, 6935.375816176366, 6942.1669399670345, 6949.992251123457, 6965.024896514391, 7118.5017048806085, 7119.67961441726, 7142.607156606437, 7160.856782864418, 6706.128203333536, 6755.493337999571, 6988.126484189476, 7022.192447868356, 7036.648167591702], "unit": "score", "name": "prototype.html", "value": 5228.917159513118}, {"lowerIsBetter": false, "replicates": [674.4435840431642, 717.4654882112825, 771.0, 782.2881178127898, 805.1465446626574, 15635.218239088043, 15673.608159796011, 16004.119773412458, 16007.0, 16047.0, 14947.476838310662, 15033.323500442479, 15048.097114173157, 15052.172130532816, 15076.849231507682, 824.2169938558363, 825.8018075661857, 834.05751500804, 947.5072962059725, 975.8194733974202, 996.2826764729383, 1003.0170432975689, 1005.4269066632023, 1006.9194464442827, 1011.1304278320638, 1051.0645525482328, 1055.6147006342705, 1055.788842231553, 1057.8095942730306, 1058.7141471802609, 860.8192279621255, 872.6596627315321, 1049.1659130990881, 1057.7831544533353, 1059.2214722179192, 785.7839094249127, 786.8150984518634, 786.838698066895, 787.2796391301952, 787.4841978504089, 15783.368665253376, 15884.76172857408, 15898.443554475654, 15939.681206375924, 15940.20298985046, 13054.34728263583, 13147.211167329895, 13353.265570393625, 13356.131851429724, 13374.86625133746, 10205.795884082278, 10490.16078713701, 10508.842367364496, 10575.841362379571, 10781.9460902695, 3586.4620306953907, 3588.2285308658766, 3625.854965801365, 3671.1739858531882, 3846.7114966377353, 82754.58622706908, 84142.0, 84265.15734842696, 84474.0, 85765.14234857634, 9957.01438136366, 10033.0, 10036.397816131055, 10058.446785426871, 10307.660004199406, 23124.768752312262, 23133.537329253657, 23147.53704925892, 23208.3037508875, 23307.7669223309, 7533.20901305366, 7626.046744156981, 7711.228877112244, 7735.497192682457, 7835.0, 4154.958450415517, 4224.302990006676, 4225.830966761357, 4287.035417031143, 4523.2988886722615, 3688.8708895189075, 3758.079270578671, 3758.511393518825, 3760.7931563764255, 3764.247150569897, 633.3318349141608, 642.4539141729492, 646.3859333633068, 653.3238098568054, 653.833272515515, 490.1741904435912, 499.5054895653277, 535.7937194180269, 579.7130420441824, 584.2900875436366, 8124.512529248264, 8182.631781569844, 8194.467359621725, 8329.125441828643, 8391.95804020976, 537.5296615461472, 555.9444055594408, 562.8395907166438, 564.2467306146259, 573.3091624592439, 3683.4290684943876, 3840.0975770693863, 3842.289176502356, 3882.6893848492055, 3956.624120708528, 85802.0, 86453.0, 86894.56552717196, 87863.24273514622, 88084.55957720299, 84456.0, 84743.0, 85395.0, 85652.0, 86595.0, 58373.24880253514, 72686.63656681683, 72883.63558182282, 73407.53184936271, 75894.0, 7560.6219689016425, 7640.617969101411, 7834.921650783419, 7853.410994175574, 7925.643346049326, 51018.48981510138, 51839.222411663104, 52873.0, 52929.73535132454, 53316.73341633267, 67911.98132028122, 68258.0, 68536.6573167131, 71282.0, 73529.0, 10846.457677115955, 11047.337159770439, 11063.944680276547, 11106.333619982826, 11732.94133529327, 11718.589849355232, 11948.61027794462, 12047.75904481923, 12087.51649934028, 12587.0, 11013.394263315595, 11422.48598813072, 11448.0, 11633.53465861356, 11690.415479226174, 11158.497867595815, 11359.432028398713, 11362.0, 11394.772104558027, 11535.653930382103, 11190.608328708457, 11331.32012079278, 11372.54509819598, 11385.601503947322, 11609.6517104487, 9325.533723313943, 9533.189678877096, 9584.041595840361, 9619.470929098967, 9936.552855121681, 9494.24046076326, 9500.287478439006, 9611.519424028631, 9634.951825240829, 9676.75808104803], "unit": "score", "name": "yui.html", "value": 7095.483122068802}], "name": "dromaeo_css", "value": 7804.685210750849}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [113.0, 109.0, 110.0, 110.0, 113.0, 111.0, 120.0, 111.0, 110.0, 110.0], "unit": "score", "name": "ai-astar", "value": 111.7}, {"lowerIsBetter": true, "replicates": [154.0, 120.0, 153.0, 148.0, 120.0, 138.0, 117.0, 147.0, 149.0, 136.0], "unit": "score", "name": "audio-beat-detection", "value": 138.2}, {"lowerIsBetter": true, "replicates": [181.0, 183.0, 184.0, 186.0, 184.0, 184.0, 184.0, 182.0, 184.0, 181.0], "unit": "score", "name": "audio-dft", "value": 183.3}, {"lowerIsBetter": true, "replicates": [73.0, 70.0, 76.0, 112.0, 55.0, 57.0, 57.0, 59.0, 116.0, 56.0], "unit": "score", "name": "audio-fft", "value": 73.1}, {"lowerIsBetter": true, "replicates": [90.0, 91.0, 124.0, 81.0, 77.0, 83.0, 116.0, 75.0, 79.0, 113.0], "unit": "score", "name": "audio-oscillator", "value": 92.9}, {"lowerIsBetter": true, "replicates": [88.0, 84.0, 87.0, 83.0, 86.0, 83.0, 87.0, 83.0, 86.0, 82.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 84.9}, {"lowerIsBetter": true, "replicates": [92.0, 93.0, 93.0, 93.0, 93.0, 92.0, 94.0, 92.0, 93.0, 91.0], "unit": "score", "name": "imaging-darkroom", "value": 92.6}, {"lowerIsBetter": true, "replicates": [94.0, 84.0, 83.0, 83.0, 84.0, 86.0, 86.0, 86.0, 83.0, 84.0], "unit": "score", "name": "imaging-desaturate", "value": 85.3}, {"lowerIsBetter": true, "replicates": [56.0, 58.0, 57.0, 57.0, 56.0, 55.0, 57.0, 57.0, 52.0, 51.0], "unit": "score", "name": "json-parse-financial", "value": 55.6}, {"lowerIsBetter": true, "replicates": [62.0, 63.0, 70.0, 78.0, 73.0, 73.0, 66.0, 66.0, 66.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.4}, {"lowerIsBetter": true, "replicates": [82.0, 82.0, 81.0, 80.0, 80.0, 82.0, 79.0, 79.0, 81.0, 83.0], "unit": "score", "name": "stanford-crypto-aes", "value": 80.9}, {"lowerIsBetter": true, "replicates": [131.0, 130.0, 120.0, 148.0, 126.0, 133.0, 116.0, 115.0, 114.0, 116.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 124.9}, {"lowerIsBetter": true, "replicates": [133.0, 137.0, 158.0, 171.0, 131.0, 122.0, 136.0, 133.0, 134.0, 134.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 138.9}, {"lowerIsBetter": true, "replicates": [56.0, 77.0, 93.0, 95.0, 68.0, 64.0, 67.0, 66.0, 67.0, 65.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 71.8}], "name": "kraken", "value": 1402.5}]} 06:45:40 INFO - Return code: 0 06:45:40 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 06:45:40 INFO - # TBPL SUCCESS # 06:45:40 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 06:45:40 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 06:45:40 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 06:45:40 INFO - 2016-05-13 06:45:40.752 screenresolution[1688:10184] starting screenresolution argv=screenresolution get 06:45:40 INFO - 2016-05-13 06:45:40.755 screenresolution[1688:10184] Display 0: 1600x1200x32@60 06:45:40 INFO - 2016-05-13 06:45:40.761 screenresolution[1689:10187] starting screenresolution argv=screenresolution list 06:45:40 INFO - Available Modes on Display 0 06:45:40 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 06:45:40 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 06:45:40 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 06:45:40 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 06:45:40 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 06:45:40 INFO - Intel Iris: 06:45:40 INFO - Chipset Model: Intel Iris 06:45:40 INFO - Type: GPU 06:45:40 INFO - Bus: Built-In 06:45:40 INFO - VRAM (Dynamic, Max): 1536 MB 06:45:40 INFO - Vendor: Intel (0x8086) 06:45:40 INFO - Device ID: 0x0a2e 06:45:40 INFO - Revision ID: 0x0009 06:45:40 INFO - Displays: 06:45:40 INFO - Display: 06:45:40 INFO - Resolution: 1600 x 1200 @ 60 Hz 06:45:40 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 06:45:40 INFO - Display Serial Number: 1600x1200 60 06:45:40 INFO - Main Display: Yes 06:45:40 INFO - Mirror: Off 06:45:40 INFO - Online: Yes 06:45:40 INFO - Rotation: Supported 06:45:40 INFO - Return code: 0 06:45:40 INFO - Running post-action listener: _resource_record_post_action 06:45:40 INFO - Running post-run listener: _resource_record_post_run 06:45:42 INFO - Total resource usage - Wall time: 1191s; CPU: 52.0%; Read bytes: 31419904; Write bytes: 509537280; Read time: 199; Write time: 1543 06:45:42 INFO - install - Wall time: 23s; CPU: 54.0%; Read bytes: 198523392; Write bytes: 199403008; Read time: 17979; Write time: 420 06:45:42 INFO - run-tests - Wall time: 1170s; CPU: 52.0%; Read bytes: 30498304; Write bytes: 300176896; Read time: 188; Write time: 1089 06:45:42 INFO - Running post-run listener: _upload_blobber_files 06:45:42 INFO - Blob upload gear active. 06:45:42 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:45:42 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 06:45:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:45:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:45:42 INFO - (blobuploader) - INFO - Open directory for files ... 06:45:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:45:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:45:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:45:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:45:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:45:43 INFO - (blobuploader) - INFO - Done attempting. 06:45:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 06:45:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:45:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:45:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:45:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:45:44 INFO - (blobuploader) - INFO - Done attempting. 06:45:44 INFO - (blobuploader) - INFO - Iteration through files over. 06:45:44 INFO - Return code: 0 06:45:44 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:45:44 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:45:44 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ad7e27a5605948f685b6d1ac19c36a181a25f99d0b28174b21cd556a0354aaf09665a8295a7bf1f9a5d09b1bc8c3b706e95f27a4055ece3fc6c35bec9aba2e14", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/6f95db654a01e554221957f7ec42d441d2c5965e30cfe59f841d85159c86289430be28f51dc4f04f9c2a6b9b671eb50725e7cdcbd503f8bf8b27e4ae9e32beaf"} 06:45:44 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:45:44 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:45:44 INFO - Contents: 06:45:44 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ad7e27a5605948f685b6d1ac19c36a181a25f99d0b28174b21cd556a0354aaf09665a8295a7bf1f9a5d09b1bc8c3b706e95f27a4055ece3fc6c35bec9aba2e14", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/6f95db654a01e554221957f7ec42d441d2c5965e30cfe59f841d85159c86289430be28f51dc4f04f9c2a6b9b671eb50725e7cdcbd503f8bf8b27e4ae9e32beaf"} 06:45:44 INFO - Running post-run listener: copy_logs_to_upload_dir 06:45:44 INFO - Copying logs to upload dir... 06:45:44 INFO - mkdir: /builds/slave/test/build/upload/logs 06:45:44 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1274.697449 ========= master_lag: 3.82 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 18 secs) (at 2016-05-13 06:45:48.469963) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-13 06:45:48.473498) ========= 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.ZRWZ7NMchd/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.JHDtPFup3Y/Listeners TMPDIR=/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/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/ad7e27a5605948f685b6d1ac19c36a181a25f99d0b28174b21cd556a0354aaf09665a8295a7bf1f9a5d09b1bc8c3b706e95f27a4055ece3fc6c35bec9aba2e14", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/6f95db654a01e554221957f7ec42d441d2c5965e30cfe59f841d85159c86289430be28f51dc4f04f9c2a6b9b671eb50725e7cdcbd503f8bf8b27e4ae9e32beaf"} build_url:https://queue.taskcluster.net/v1/task/D1q4ZZX2SdiPFfGmbKsf8A/artifacts/public/build/firefox-47.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011482 build_url: 'https://queue.taskcluster.net/v1/task/D1q4ZZX2SdiPFfGmbKsf8A/artifacts/public/build/firefox-47.0.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ad7e27a5605948f685b6d1ac19c36a181a25f99d0b28174b21cd556a0354aaf09665a8295a7bf1f9a5d09b1bc8c3b706e95f27a4055ece3fc6c35bec9aba2e14", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/6f95db654a01e554221957f7ec42d441d2c5965e30cfe59f841d85159c86289430be28f51dc4f04f9c2a6b9b671eb50725e7cdcbd503f8bf8b27e4ae9e32beaf"}' ========= master_lag: 0.04 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-13 06:45:48.526692) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-13 06:45:48.527082) ========= 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.ZRWZ7NMchd/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.JHDtPFup3Y/Listeners TMPDIR=/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/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.005131 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-13 06:45:48.576184) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-13 06:45:48.576534) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-13 06:45:48.576929) ========= ========= Total master_lag: 3.96 =========