builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0005 starttime: 1462538252.22 results: success (0) buildid: 20160506030222 builduid: bfaa4dc7b7814e41bfbe87ce2cfb4e5b revision: 25d777f7efb357fc5478251913548521986abaa0 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-06 05:37:32.216769) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-06 05:37:32.217224) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-06 05:37:32.217520) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-06 05:37:32.236451) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 05:37:32.236716) ========= 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.UVPBUXOF0G/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.jIyRGdoMhQ/Listeners TMPDIR=/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/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-06 05:37:32-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 26.7M=0s 2016-05-06 05:37:32 (26.7 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.094025 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 05:37:32.347652) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 05:37:32.347925) ========= 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.UVPBUXOF0G/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.jIyRGdoMhQ/Listeners TMPDIR=/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/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.027586 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 05:37:32.398698) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-06 05:37:32.399012) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 25d777f7efb357fc5478251913548521986abaa0 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 25d777f7efb357fc5478251913548521986abaa0 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.UVPBUXOF0G/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.jIyRGdoMhQ/Listeners TMPDIR=/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/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-06 05:37:32,438 truncating revision to first 12 chars 2016-05-06 05:37:32,438 Setting DEBUG logging. 2016-05-06 05:37:32,438 attempt 1/10 2016-05-06 05:37:32,438 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/25d777f7efb3?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-06 05:37:33,386 unpacking tar archive at: mozilla-central-25d777f7efb3/testing/mozharness/ program finished with exit code 0 elapsedTime=1.196091 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-06 05:37:33.617629) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-06 05:37:33.617951) ========= script_repo_revision: 25d777f7efb357fc5478251913548521986abaa0 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-06 05:37:33.618348) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-06 05:37:33.618613) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-06 05:37:33.631949) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2016-05-06 05:37:33.632216) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.UVPBUXOF0G/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.jIyRGdoMhQ/Listeners TMPDIR=/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 05:37:33 INFO - MultiFileLogger online at 20160506 05:37:33 in /builds/slave/test 05:37:33 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 05:37:33 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:37:33 INFO - {'append_to_log': False, 05:37:33 INFO - 'base_work_dir': '/builds/slave/test', 05:37:33 INFO - 'blob_upload_branch': 'Firefox', 05:37:33 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:37:33 INFO - 'branch': 'Firefox', 05:37:33 INFO - 'buildbot_json_path': 'buildprops.json', 05:37:33 INFO - 'config_files': ('talos/mac_config.py',), 05:37:33 INFO - 'default_actions': ('clobber', 05:37:33 INFO - 'read-buildbot-config', 05:37:33 INFO - 'download-and-extract', 05:37:33 INFO - 'populate-webroot', 05:37:33 INFO - 'create-virtualenv', 05:37:33 INFO - 'install', 05:37:33 INFO - 'run-tests'), 05:37:33 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:37:33 INFO - 'download_minidump_stackwalk': True, 05:37:33 INFO - 'download_symbols': 'ondemand', 05:37:33 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:37:33 INFO - 'tooltool.py': '/tools/tooltool.py', 05:37:33 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:37:33 INFO - '/tools/misc-python/virtualenv.py')}, 05:37:33 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:37:33 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:37:33 INFO - 'installer_path': 'installer.exe', 05:37:33 INFO - 'log_level': 'info', 05:37:33 INFO - 'log_name': 'talos', 05:37:33 INFO - 'log_to_console': True, 05:37:33 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 05:37:33 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 05:37:33 INFO - 'opt_config_files': (), 05:37:33 INFO - 'pip_index': False, 05:37:33 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:37:33 INFO - 'cmd': ('bash', 05:37:33 INFO - '-c', 05:37:33 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:37:33 INFO - 'enabled': True, 05:37:33 INFO - 'halt_on_failure': False, 05:37:33 INFO - 'name': 'check_screen_resolution'},), 05:37:33 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:37:33 INFO - 'cmd': ('bash', 05:37:33 INFO - '-c', 05:37:33 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:37:33 INFO - 'enabled': True, 05:37:33 INFO - 'halt_on_failure': False, 05:37:33 INFO - 'name': 'check_screen_resolution'},), 05:37:33 INFO - 'run_cmd_checks_enabled': True, 05:37:33 INFO - 'sps_profile': False, 05:37:33 INFO - 'sps_profile_interval': 0, 05:37:33 INFO - 'suite': 'dromaeojs', 05:37:33 INFO - 'system_bits': '32', 05:37:33 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:37:33 INFO - 'title': 't-yosemite-r7-0005', 05:37:33 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:37:33 INFO - 'use_talos_json': True, 05:37:33 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:37:33 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:37:33 INFO - 'work_dir': 'build'} 05:37:33 INFO - ##### 05:37:33 INFO - ##### Running clobber step. 05:37:33 INFO - ##### 05:37:33 INFO - Running pre-action listener: _resource_record_pre_action 05:37:33 INFO - Running main action method: clobber 05:37:33 INFO - rmtree: /builds/slave/test/build 05:37:33 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:37:36 INFO - Running post-action listener: _resource_record_post_action 05:37:36 INFO - ##### 05:37:36 INFO - ##### Running read-buildbot-config step. 05:37:36 INFO - ##### 05:37:36 INFO - Running pre-action listener: _resource_record_pre_action 05:37:36 INFO - Running main action method: read_buildbot_config 05:37:36 INFO - Using buildbot properties: 05:37:36 INFO - { 05:37:36 INFO - "project": "", 05:37:36 INFO - "product": "firefox", 05:37:36 INFO - "script_repo_revision": "production", 05:37:36 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 05:37:36 INFO - "repository": "", 05:37:36 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 05:37:36 INFO - "buildid": "20160506030222", 05:37:36 INFO - "stage_platform": "macosx64", 05:37:36 INFO - "basedir": "/builds/slave/test", 05:37:36 INFO - "nightly_build": "True", 05:37:36 INFO - "buildnumber": 241, 05:37:36 INFO - "slavename": "t-yosemite-r7-0005", 05:37:36 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 05:37:36 INFO - "platform": "yosemite_r7", 05:37:36 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 05:37:36 INFO - "branch": "mozilla-central", 05:37:36 INFO - "repo_path": "mozilla-central", 05:37:36 INFO - "revision": "25d777f7efb357fc5478251913548521986abaa0", 05:37:36 INFO - "pgo_build": "False", 05:37:36 INFO - "builduid": "bfaa4dc7b7814e41bfbe87ce2cfb4e5b", 05:37:36 INFO - "slavebuilddir": "test" 05:37:36 INFO - } 05:37:36 INFO - Found installer url https://queue.taskcluster.net/v1/task/J1UwYIA1RWS5SSpRKUkQVw/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg. 05:37:36 INFO - Running post-action listener: _resource_record_post_action 05:37:36 INFO - ##### 05:37:36 INFO - ##### Running download-and-extract step. 05:37:36 INFO - ##### 05:37:36 INFO - Running pre-action listener: _resource_record_pre_action 05:37:36 INFO - Running main action method: download_and_extract 05:37:36 INFO - mkdir: /builds/slave/test/build/tests 05:37:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:37:36 INFO - https://queue.taskcluster.net/v1/task/J1UwYIA1RWS5SSpRKUkQVw/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 05:37:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J1UwYIA1RWS5SSpRKUkQVw/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json 05:37:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J1UwYIA1RWS5SSpRKUkQVw/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json 05:37:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J1UwYIA1RWS5SSpRKUkQVw/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.mac.test_packages.json 05:37:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J1UwYIA1RWS5SSpRKUkQVw/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.mac.test_packages.json'}, attempt #1 05:37:37 INFO - Downloaded 1199 bytes. 05:37:37 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.mac.test_packages.json 05:37:37 INFO - Using the following test package requirements: 05:37:37 INFO - {u'common': [u'firefox-49.0a1.en-US.mac.common.tests.zip'], 05:37:37 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 05:37:37 INFO - u'firefox-49.0a1.en-US.mac.cppunittest.tests.zip'], 05:37:37 INFO - u'gtest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 05:37:37 INFO - u'firefox-49.0a1.en-US.mac.gtest.tests.zip'], 05:37:37 INFO - u'jittest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 05:37:37 INFO - u'jsshell-mac.zip'], 05:37:37 INFO - u'mochitest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 05:37:37 INFO - u'firefox-49.0a1.en-US.mac.mochitest.tests.zip'], 05:37:37 INFO - u'mozbase': [u'firefox-49.0a1.en-US.mac.common.tests.zip'], 05:37:37 INFO - u'reftest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 05:37:37 INFO - u'firefox-49.0a1.en-US.mac.reftest.tests.zip'], 05:37:37 INFO - u'talos': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 05:37:37 INFO - u'firefox-49.0a1.en-US.mac.talos.tests.zip'], 05:37:37 INFO - u'web-platform': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 05:37:37 INFO - u'firefox-49.0a1.en-US.mac.web-platform.tests.zip'], 05:37:37 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 05:37:37 INFO - u'firefox-49.0a1.en-US.mac.xpcshell.tests.zip']} 05:37:37 INFO - Downloading packages: [u'firefox-49.0a1.en-US.mac.common.tests.zip'] for test suite category: common 05:37:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:37:37 INFO - https://queue.taskcluster.net/v1/task/J1UwYIA1RWS5SSpRKUkQVw/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 05:37:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J1UwYIA1RWS5SSpRKUkQVw/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 05:37:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J1UwYIA1RWS5SSpRKUkQVw/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 05:37:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J1UwYIA1RWS5SSpRKUkQVw/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip 05:37:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J1UwYIA1RWS5SSpRKUkQVw/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip'}, attempt #1 05:37:38 INFO - Downloaded 18144999 bytes. 05:37:38 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:37:38 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 05:37:41 INFO - Return code: 0 05:37:41 INFO - Downloading packages: [u'firefox-49.0a1.en-US.mac.common.tests.zip', u'firefox-49.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 05:37:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:37:41 INFO - https://queue.taskcluster.net/v1/task/J1UwYIA1RWS5SSpRKUkQVw/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 05:37:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J1UwYIA1RWS5SSpRKUkQVw/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 05:37:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J1UwYIA1RWS5SSpRKUkQVw/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 05:37:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J1UwYIA1RWS5SSpRKUkQVw/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip 05:37:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J1UwYIA1RWS5SSpRKUkQVw/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip'}, attempt #1 05:37:42 INFO - Downloaded 18144999 bytes. 05:37:42 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:37:42 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 05:37:46 INFO - Return code: 0 05:37:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:37:46 INFO - https://queue.taskcluster.net/v1/task/J1UwYIA1RWS5SSpRKUkQVw/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 05:37:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J1UwYIA1RWS5SSpRKUkQVw/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip 05:37:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J1UwYIA1RWS5SSpRKUkQVw/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip 05:37:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J1UwYIA1RWS5SSpRKUkQVw/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.mac.talos.tests.zip 05:37:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J1UwYIA1RWS5SSpRKUkQVw/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.talos.tests.zip'}, attempt #1 05:37:47 INFO - Downloaded 10840152 bytes. 05:37:47 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:37:47 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 05:37:47 INFO - Return code: 0 05:37:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:37:47 INFO - https://queue.taskcluster.net/v1/task/J1UwYIA1RWS5SSpRKUkQVw/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 05:37:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J1UwYIA1RWS5SSpRKUkQVw/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 05:37:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J1UwYIA1RWS5SSpRKUkQVw/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 05:37:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J1UwYIA1RWS5SSpRKUkQVw/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-49.0a1.en-US.mac.dmg 05:37:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J1UwYIA1RWS5SSpRKUkQVw/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.mac.dmg'}, attempt #1 05:37:51 INFO - Downloaded 110537239 bytes. 05:37:51 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/J1UwYIA1RWS5SSpRKUkQVw/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 05:37:51 INFO - mkdir: /builds/slave/test/properties 05:37:51 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:37:51 INFO - Writing to file /builds/slave/test/properties/build_url 05:37:51 INFO - Contents: 05:37:51 INFO - build_url:https://queue.taskcluster.net/v1/task/J1UwYIA1RWS5SSpRKUkQVw/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 05:37:52 INFO - Running post-action listener: _resource_record_post_action 05:37:52 INFO - Running post-action listener: set_extra_try_arguments 05:37:52 INFO - ##### 05:37:52 INFO - ##### Running populate-webroot step. 05:37:52 INFO - ##### 05:37:52 INFO - Running pre-action listener: _resource_record_pre_action 05:37:52 INFO - Running main action method: populate_webroot 05:37:52 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:37:52 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:37:52 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:37:52 INFO - '--tppagecycles', 05:37:52 INFO - '7'], 05:37:52 INFO - 'tests': ['tsvgm']}}, 05:37:52 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:37:52 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:37:52 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:37:52 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:37:52 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:37:52 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:37:52 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:37:52 INFO - 'talos_options': ['--disable-e10s'], 05:37:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:37:52 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:37:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:37:52 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:37:52 INFO - 'talos_options': ['--disable-e10s'], 05:37:52 INFO - 'tests': ['damp', 'tps']}, 05:37:52 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:37:52 INFO - 'tests': ['damp', 'tps']}, 05:37:52 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:37:52 INFO - 'tests': ['dromaeo_dom']}, 05:37:52 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:37:52 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:37:52 INFO - 'tests': ['a11yr', 05:37:52 INFO - 'ts_paint', 05:37:52 INFO - 'tpaint', 05:37:52 INFO - 'sessionrestore', 05:37:52 INFO - 'sessionrestore_no_auto_restore', 05:37:52 INFO - 'tabpaint']}, 05:37:52 INFO - 'other-e10s': {'tests': ['a11yr', 05:37:52 INFO - 'ts_paint', 05:37:52 INFO - 'tpaint', 05:37:52 INFO - 'sessionrestore', 05:37:52 INFO - 'sessionrestore_no_auto_restore', 05:37:52 INFO - 'tabpaint']}, 05:37:52 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:37:52 INFO - 'ts_paint', 05:37:52 INFO - 'tpaint', 05:37:52 INFO - 'sessionrestore', 05:37:52 INFO - 'sessionrestore_no_auto_restore', 05:37:52 INFO - 'tabpaint']}, 05:37:52 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:37:52 INFO - 'ts_paint', 05:37:52 INFO - 'tpaint', 05:37:52 INFO - 'sessionrestore', 05:37:52 INFO - 'sessionrestore_no_auto_restore', 05:37:52 INFO - 'tabpaint']}, 05:37:52 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:37:52 INFO - 'tests': ['a11yr', 05:37:52 INFO - 'ts_paint', 05:37:52 INFO - 'tpaint', 05:37:52 INFO - 'sessionrestore', 05:37:52 INFO - 'sessionrestore_no_auto_restore', 05:37:52 INFO - 'tabpaint']}, 05:37:52 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:37:52 INFO - 'tests': ['a11yr', 05:37:52 INFO - 'ts_paint', 05:37:52 INFO - 'tpaint', 05:37:52 INFO - 'sessionrestore', 05:37:52 INFO - 'sessionrestore_no_auto_restore', 05:37:52 INFO - 'tabpaint']}, 05:37:52 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:37:52 INFO - 'tests': ['tsvgx', 05:37:52 INFO - 'tsvgr_opacity', 05:37:52 INFO - 'tart', 05:37:52 INFO - 'tscrollx', 05:37:52 INFO - 'cart']}, 05:37:52 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:37:52 INFO - 'tsvgr_opacity', 05:37:52 INFO - 'tart', 05:37:52 INFO - 'tscrollx', 05:37:52 INFO - 'cart']}, 05:37:52 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:37:52 INFO - 'talos_options': ['--disable-e10s'], 05:37:52 INFO - 'tests': ['tp5o']}, 05:37:52 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:37:52 INFO - 'tests': ['tp5o']}, 05:37:52 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:37:52 INFO - 'talos_options': ['--disable-e10s', 05:37:52 INFO - '--xperf_path', 05:37:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:37:52 INFO - 'tests': ['tp5n']}, 05:37:52 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:37:52 INFO - 'talos_options': ['--xperf_path', 05:37:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:37:52 INFO - 'tests': ['tp5n']}}, 05:37:52 INFO - 'talos.zip': {'path': '', 05:37:52 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:37:52 INFO - Running post-action listener: _resource_record_post_action 05:37:52 INFO - ##### 05:37:52 INFO - ##### Running create-virtualenv step. 05:37:52 INFO - ##### 05:37:52 INFO - Running pre-action listener: _resource_record_pre_action 05:37:52 INFO - Running main action method: create_virtualenv 05:37:52 INFO - Creating virtualenv /builds/slave/test/build/venv 05:37:52 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 05:37:52 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:37:52 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:37:52 INFO - Using real prefix '/tools/python27' 05:37:52 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:37:53 INFO - Installing distribute.............................................................................................................................................................................................done. 05:37:56 INFO - Installing pip.................done. 05:37:56 INFO - Return code: 0 05:37:56 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:37:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:37:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:37:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:37:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:37:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:37:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:37:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10db42a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10db52420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc091d7d850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d9e1e00>, '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 0x10d80adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d9dcb20>, '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.UVPBUXOF0G/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.jIyRGdoMhQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:37:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 05:37:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:37:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UVPBUXOF0G/Render', 05:37:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:37:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:37:56 INFO - 'HOME': '/Users/cltbld', 05:37:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:37:56 INFO - 'LOGNAME': 'cltbld', 05:37:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:37:56 INFO - 'MOZ_NO_REMOTE': '1', 05:37:56 INFO - 'NO_EM_RESTART': '1', 05:37:56 INFO - 'PAGER': '/bin/cat', 05:37:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:37:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:37:56 INFO - 'PWD': '/builds/slave/test', 05:37:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:37:56 INFO - 'SHELL': '/bin/bash', 05:37:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jIyRGdoMhQ/Listeners', 05:37:56 INFO - 'TMPDIR': '/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/', 05:37:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:37:56 INFO - 'USER': 'cltbld', 05:37:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:37:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:37:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:37:56 INFO - 'XPC_FLAGS': '0x0', 05:37:56 INFO - 'XPC_SERVICE_NAME': '0', 05:37:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:37:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:37:56 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 05:37:56 INFO - Cleaning up... 05:37:56 INFO - Return code: 0 05:37:56 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 05:37:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:37:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:37:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:37:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:37:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:37:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:37:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10db42a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10db52420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc091d7d850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d9e1e00>, '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 0x10d80adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d9dcb20>, '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.UVPBUXOF0G/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.jIyRGdoMhQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:37:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 05:37:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 05:37:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UVPBUXOF0G/Render', 05:37:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:37:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:37:56 INFO - 'HOME': '/Users/cltbld', 05:37:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:37:56 INFO - 'LOGNAME': 'cltbld', 05:37:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:37:56 INFO - 'MOZ_NO_REMOTE': '1', 05:37:56 INFO - 'NO_EM_RESTART': '1', 05:37:56 INFO - 'PAGER': '/bin/cat', 05:37:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:37:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:37:56 INFO - 'PWD': '/builds/slave/test', 05:37:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:37:56 INFO - 'SHELL': '/bin/bash', 05:37:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jIyRGdoMhQ/Listeners', 05:37:56 INFO - 'TMPDIR': '/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/', 05:37:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:37:56 INFO - 'USER': 'cltbld', 05:37:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:37:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:37:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:37:56 INFO - 'XPC_FLAGS': '0x0', 05:37:56 INFO - 'XPC_SERVICE_NAME': '0', 05:37:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:37:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:37:56 INFO - Downloading/unpacking psutil>=0.7.1 05:37:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:37:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:37:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:37:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:37:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:37:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:37:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:37:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:37:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:37:59 INFO - Installing collected packages: psutil 05:37:59 INFO - Running setup.py install for psutil 05:37:59 INFO - building 'psutil._psutil_osx' extension 05:37:59 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 05:38:00 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 05:38:00 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 05:38:00 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 05:38:00 INFO - building 'psutil._psutil_posix' extension 05:38:00 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 05:38:00 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 05:38:00 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 05:38:00 INFO - ^ 05:38:00 INFO - 1 warning generated. 05:38:00 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 05:38:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:38:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:38:00 INFO - Successfully installed psutil 05:38:00 INFO - Cleaning up... 05:38:00 INFO - Return code: 0 05:38:00 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 05:38:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:38:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:38:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:38:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:38:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:38:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:38:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10db42a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10db52420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc091d7d850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d9e1e00>, '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 0x10d80adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d9dcb20>, '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.UVPBUXOF0G/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.jIyRGdoMhQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:38:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 05:38:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 05:38:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UVPBUXOF0G/Render', 05:38:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:38:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:38:00 INFO - 'HOME': '/Users/cltbld', 05:38:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:38:00 INFO - 'LOGNAME': 'cltbld', 05:38:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:38:00 INFO - 'MOZ_NO_REMOTE': '1', 05:38:00 INFO - 'NO_EM_RESTART': '1', 05:38:00 INFO - 'PAGER': '/bin/cat', 05:38:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:38:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:38:00 INFO - 'PWD': '/builds/slave/test', 05:38:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:38:00 INFO - 'SHELL': '/bin/bash', 05:38:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jIyRGdoMhQ/Listeners', 05:38:00 INFO - 'TMPDIR': '/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/', 05:38:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:38:00 INFO - 'USER': 'cltbld', 05:38:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:38:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:38:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:38:00 INFO - 'XPC_FLAGS': '0x0', 05:38:00 INFO - 'XPC_SERVICE_NAME': '0', 05:38:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:38:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:38:00 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:38:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:38:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:38:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:38:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:38:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:38:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:38:03 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:38:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:38:03 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 05:38:03 INFO - Installing collected packages: mozsystemmonitor 05:38:03 INFO - Running setup.py install for mozsystemmonitor 05:38:03 INFO - Successfully installed mozsystemmonitor 05:38:03 INFO - Cleaning up... 05:38:03 INFO - Return code: 0 05:38:03 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:38: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')]} 05:38:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:38:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:38: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')]} 05:38:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:38:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:38:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10db42a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10db52420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc091d7d850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d9e1e00>, '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 0x10d80adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d9dcb20>, '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.UVPBUXOF0G/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.jIyRGdoMhQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:38:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:38:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:38:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UVPBUXOF0G/Render', 05:38:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:38:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:38:03 INFO - 'HOME': '/Users/cltbld', 05:38:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:38:03 INFO - 'LOGNAME': 'cltbld', 05:38:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:38:03 INFO - 'MOZ_NO_REMOTE': '1', 05:38:03 INFO - 'NO_EM_RESTART': '1', 05:38:03 INFO - 'PAGER': '/bin/cat', 05:38:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:38:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:38:03 INFO - 'PWD': '/builds/slave/test', 05:38:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:38:03 INFO - 'SHELL': '/bin/bash', 05:38:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jIyRGdoMhQ/Listeners', 05:38:03 INFO - 'TMPDIR': '/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/', 05:38:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:38:03 INFO - 'USER': 'cltbld', 05:38:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:38:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:38:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:38:03 INFO - 'XPC_FLAGS': '0x0', 05:38:03 INFO - 'XPC_SERVICE_NAME': '0', 05:38:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:38:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:38:03 INFO - Downloading/unpacking blobuploader==1.2.4 05:38:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:38:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:38:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:38:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:38:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:38:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:38:06 INFO - Downloading blobuploader-1.2.4.tar.gz 05:38:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:38:06 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:38:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:38:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:38:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:38:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:38:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:38:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:38:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:38:07 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:38:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:38:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:38:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:38:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:38:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:38:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:38:07 INFO - Downloading docopt-0.6.1.tar.gz 05:38:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:38:07 INFO - Installing collected packages: blobuploader, requests, docopt 05:38:07 INFO - Running setup.py install for blobuploader 05:38:07 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:38:07 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:38:07 INFO - Running setup.py install for requests 05:38:08 INFO - Running setup.py install for docopt 05:38:08 INFO - Successfully installed blobuploader requests docopt 05:38:08 INFO - Cleaning up... 05:38:08 INFO - Return code: 0 05:38:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:38:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:38:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:38:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:38:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:38:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:38:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:38:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10db42a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10db52420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc091d7d850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d9e1e00>, '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 0x10d80adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d9dcb20>, '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.UVPBUXOF0G/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.jIyRGdoMhQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:38:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:38:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:38:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UVPBUXOF0G/Render', 05:38:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:38:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:38:08 INFO - 'HOME': '/Users/cltbld', 05:38:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:38:08 INFO - 'LOGNAME': 'cltbld', 05:38:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:38:08 INFO - 'MOZ_NO_REMOTE': '1', 05:38:08 INFO - 'NO_EM_RESTART': '1', 05:38:08 INFO - 'PAGER': '/bin/cat', 05:38:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:38:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:38:08 INFO - 'PWD': '/builds/slave/test', 05:38:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:38:08 INFO - 'SHELL': '/bin/bash', 05:38:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jIyRGdoMhQ/Listeners', 05:38:08 INFO - 'TMPDIR': '/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/', 05:38:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:38:08 INFO - 'USER': 'cltbld', 05:38:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:38:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:38:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:38:08 INFO - 'XPC_FLAGS': '0x0', 05:38:08 INFO - 'XPC_SERVICE_NAME': '0', 05:38:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:38:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:38:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:38:08 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-ECXI0Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:38:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:38:08 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-ckHSp7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:38:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:38:08 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-W2F6wI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:38:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:38:09 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-RPMlYd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:38:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:38:09 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-1zpI9B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:38:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:38:09 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-8i7x7U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:38:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:38:09 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-xGZvOK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:38:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:38:09 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-Qekxf4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:38:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:38:09 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-4yCSmF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:38:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:38:09 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-IHsoLo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:38:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:38:09 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-wMaTu7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:38:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:38:09 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-HIsdWU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:38:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:38:10 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-4J7dPw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:38:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:38:10 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-0ktW_e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:38:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:38:10 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-b9M3gE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:38:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:38:10 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-BiZz3z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:38:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:38:10 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-K9fBAr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:38:10 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:38:10 INFO - Running setup.py install for manifestparser 05:38:10 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:38:10 INFO - Running setup.py install for mozcrash 05:38:10 INFO - Running setup.py install for mozdebug 05:38:10 INFO - Running setup.py install for mozdevice 05:38:11 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:38:11 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:38:11 INFO - Running setup.py install for mozfile 05:38:11 INFO - Running setup.py install for mozhttpd 05:38:11 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:38:11 INFO - Running setup.py install for mozinfo 05:38:11 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:38:11 INFO - Running setup.py install for mozInstall 05:38:11 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:38:11 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:38:11 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:38:11 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:38:11 INFO - Running setup.py install for mozleak 05:38:11 INFO - Running setup.py install for mozlog 05:38:12 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:38:12 INFO - Running setup.py install for moznetwork 05:38:12 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:38:12 INFO - Running setup.py install for mozprocess 05:38:12 INFO - Running setup.py install for mozprofile 05:38:12 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:38:12 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:38:12 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:38:12 INFO - Running setup.py install for mozrunner 05:38:12 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:38:12 INFO - Running setup.py install for mozscreenshot 05:38:12 INFO - Running setup.py install for moztest 05:38:12 INFO - Running setup.py install for mozversion 05:38:13 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:38:13 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:38:13 INFO - Cleaning up... 05:38:13 INFO - Return code: 0 05:38:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:38:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:38:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:38:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:38:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:38:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:38:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:38:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10db42a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10db52420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc091d7d850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d9e1e00>, '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 0x10d80adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d9dcb20>, '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.UVPBUXOF0G/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.jIyRGdoMhQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:38:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:38:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:38:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UVPBUXOF0G/Render', 05:38:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:38:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:38:13 INFO - 'HOME': '/Users/cltbld', 05:38:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:38:13 INFO - 'LOGNAME': 'cltbld', 05:38:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:38:13 INFO - 'MOZ_NO_REMOTE': '1', 05:38:13 INFO - 'NO_EM_RESTART': '1', 05:38:13 INFO - 'PAGER': '/bin/cat', 05:38:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:38:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:38:13 INFO - 'PWD': '/builds/slave/test', 05:38:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:38:13 INFO - 'SHELL': '/bin/bash', 05:38:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jIyRGdoMhQ/Listeners', 05:38:13 INFO - 'TMPDIR': '/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/', 05:38:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:38:13 INFO - 'USER': 'cltbld', 05:38:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:38:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:38:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:38:13 INFO - 'XPC_FLAGS': '0x0', 05:38:13 INFO - 'XPC_SERVICE_NAME': '0', 05:38:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:38:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:38:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:38:13 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-Qil2Wy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:38:13 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 05:38:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:38:13 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-70yHXg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:38:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:38:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:38:13 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-p46ysb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:38:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:38:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:38:13 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-NkiEL_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:38:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:38:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:38:13 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-a2ymjm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:38:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 05:38:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:38:13 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-hJVTzp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:38:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 05:38:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:38:14 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-oIkif8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:38:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 05:38:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:38:14 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-IW1e8q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:38:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 05:38:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:38:14 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-GDOQaF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:38:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 05:38:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:38:14 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-RjSDem-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:38:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:38:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:38:14 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-ESEZee-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:38:14 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 05:38:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:38:14 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-xCEQY3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:38:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 05:38:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:38:14 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-gTkLx4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:38:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 05:38:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:38:14 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-zPMDmp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:38:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 05:38:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:38:14 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-LPlKsM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:38:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 05:38:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:38:14 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-ChEG6k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:38:15 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 05:38:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:38:15 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-Jw8v5F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:38:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 05:38:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:38:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:38:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:38:15 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:38:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:38:15 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:38:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:38:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:38:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:38:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:38:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:38:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:38:17 INFO - Downloading blessings-1.6.tar.gz 05:38:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:38:17 INFO - Installing collected packages: blessings 05:38:17 INFO - Running setup.py install for blessings 05:38:17 INFO - Successfully installed blessings 05:38:17 INFO - Cleaning up... 05:38:17 INFO - Return code: 0 05:38:17 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:38:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:38:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:38:18 INFO - Reading from file tmpfile_stdout 05:38:18 INFO - Current package versions: 05:38:18 INFO - blessings == 1.6 05:38:18 INFO - blobuploader == 1.2.4 05:38:18 INFO - docopt == 0.6.1 05:38:18 INFO - manifestparser == 1.1 05:38:18 INFO - mozInstall == 1.12 05:38:18 INFO - mozcrash == 0.17 05:38:18 INFO - mozdebug == 0.1 05:38:18 INFO - mozdevice == 0.48 05:38:18 INFO - mozfile == 1.2 05:38:18 INFO - mozhttpd == 0.7 05:38:18 INFO - mozinfo == 0.9 05:38:18 INFO - mozleak == 0.1 05:38:18 INFO - mozlog == 3.1 05:38:18 INFO - moznetwork == 0.27 05:38:18 INFO - mozprocess == 0.22 05:38:18 INFO - mozprofile == 0.28 05:38:18 INFO - mozrunner == 6.11 05:38:18 INFO - mozscreenshot == 0.1 05:38:18 INFO - mozsystemmonitor == 0.0 05:38:18 INFO - moztest == 0.7 05:38:18 INFO - mozversion == 1.4 05:38:18 INFO - psutil == 3.1.1 05:38:18 INFO - requests == 1.2.3 05:38:18 INFO - wsgiref == 0.1.2 05:38:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:38:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:38:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:38:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:38:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:38:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:38:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:38:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10db42a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10db52420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc091d7d850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d9e1e00>, '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 0x10d80adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d9dcb20>, '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.UVPBUXOF0G/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.jIyRGdoMhQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:38:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 05:38:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:38:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UVPBUXOF0G/Render', 05:38:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:38:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:38:18 INFO - 'HOME': '/Users/cltbld', 05:38:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:38:18 INFO - 'LOGNAME': 'cltbld', 05:38:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:38:18 INFO - 'MOZ_NO_REMOTE': '1', 05:38:18 INFO - 'NO_EM_RESTART': '1', 05:38:18 INFO - 'PAGER': '/bin/cat', 05:38:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:38:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:38:18 INFO - 'PWD': '/builds/slave/test', 05:38:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:38:18 INFO - 'SHELL': '/bin/bash', 05:38:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jIyRGdoMhQ/Listeners', 05:38:18 INFO - 'TMPDIR': '/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/', 05:38:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:38:18 INFO - 'USER': 'cltbld', 05:38:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:38:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:38:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:38:18 INFO - 'XPC_FLAGS': '0x0', 05:38:18 INFO - 'XPC_SERVICE_NAME': '0', 05:38:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:38:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:38:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:38:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 05:38:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 05:38:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:38:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 05:38:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 05:38:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 05:38:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 05:38:18 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 05:38:18 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:38:18 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:38:18 INFO - Cleaning up... 05:38:18 INFO - Return code: 0 05:38:18 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:38:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:38:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:38:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:38:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:38:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:38:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:38:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10db42a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10db52420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc091d7d850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d9e1e00>, '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 0x10d80adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d9dcb20>, '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.UVPBUXOF0G/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.jIyRGdoMhQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:38:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 05:38:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:38:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UVPBUXOF0G/Render', 05:38:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:38:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:38:18 INFO - 'HOME': '/Users/cltbld', 05:38:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:38:18 INFO - 'LOGNAME': 'cltbld', 05:38:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:38:18 INFO - 'MOZ_NO_REMOTE': '1', 05:38:18 INFO - 'NO_EM_RESTART': '1', 05:38:18 INFO - 'PAGER': '/bin/cat', 05:38:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:38:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:38:18 INFO - 'PWD': '/builds/slave/test', 05:38:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:38:18 INFO - 'SHELL': '/bin/bash', 05:38:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jIyRGdoMhQ/Listeners', 05:38:18 INFO - 'TMPDIR': '/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/', 05:38:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:38:18 INFO - 'USER': 'cltbld', 05:38:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:38:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:38:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:38:18 INFO - 'XPC_FLAGS': '0x0', 05:38:18 INFO - 'XPC_SERVICE_NAME': '0', 05:38:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:38:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:38:18 INFO - Downloading/unpacking jsonschema 05:38: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 05:38: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 05:38: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 05:38: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 05:38: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 05:38: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 05:38:21 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:38:21 INFO - Downloading/unpacking functools32 (from jsonschema) 05:38:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:38:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:38:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:38:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:38:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:38:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:38:21 INFO - Downloading functools32-3.2.3-2.tar.gz 05:38:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:38:21 INFO - warning: no files found matching '*.txt' 05:38:21 INFO - no previously-included directories found matching 'build' 05:38:21 INFO - no previously-included directories found matching 'dist' 05:38:21 INFO - no previously-included directories found matching '.git*' 05:38:21 INFO - Installing collected packages: jsonschema, functools32 05:38:21 INFO - Running setup.py install for functools32 05:38:21 INFO - warning: no files found matching '*.txt' 05:38:21 INFO - no previously-included directories found matching 'build' 05:38:21 INFO - no previously-included directories found matching 'dist' 05:38:21 INFO - no previously-included directories found matching '.git*' 05:38:21 INFO - Successfully installed jsonschema functools32 05:38:21 INFO - Cleaning up... 05:38:21 INFO - Return code: 0 05:38:21 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 05:38:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:38:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:38:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:38:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:38:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:38:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:38:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10db42a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10db52420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc091d7d850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d9e1e00>, '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 0x10d80adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d9dcb20>, '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.UVPBUXOF0G/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.jIyRGdoMhQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:38:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 05:38:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 05:38:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UVPBUXOF0G/Render', 05:38:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:38:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:38:21 INFO - 'HOME': '/Users/cltbld', 05:38:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:38:21 INFO - 'LOGNAME': 'cltbld', 05:38:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:38:21 INFO - 'MOZ_NO_REMOTE': '1', 05:38:21 INFO - 'NO_EM_RESTART': '1', 05:38:21 INFO - 'PAGER': '/bin/cat', 05:38:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:38:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:38:21 INFO - 'PWD': '/builds/slave/test', 05:38:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:38:21 INFO - 'SHELL': '/bin/bash', 05:38:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jIyRGdoMhQ/Listeners', 05:38:21 INFO - 'TMPDIR': '/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/', 05:38:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:38:21 INFO - 'USER': 'cltbld', 05:38:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:38:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:38:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:38:21 INFO - 'XPC_FLAGS': '0x0', 05:38:21 INFO - 'XPC_SERVICE_NAME': '0', 05:38:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:38:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:38:22 INFO - Downloading/unpacking flake8 05:38: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 05:38: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 05:38: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 05:38: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 05:38: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 05:38: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 05:38:24 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:38:24 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:38:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:38:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:38:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:38:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:38:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:38:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:38:24 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:38:24 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:38:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:38:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:38:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:38:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:38:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:38:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:38:25 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:38: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 05:38: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 05:38: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 05:38: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 05:38: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 05:38: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 05:38:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 05:38:25 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:38:25 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:38:25 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:38:25 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:38:25 INFO - no previously-included directories found matching 'docs/_build' 05:38:25 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:38:25 INFO - Running setup.py install for pep8 05:38:25 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:38:25 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:38:25 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:38:25 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:38:25 INFO - no previously-included directories found matching 'docs/_build' 05:38:26 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 05:38:26 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:38:26 INFO - Cleaning up... 05:38:26 INFO - Return code: 0 05:38:26 INFO - Running post-action listener: _resource_record_post_action 05:38:26 INFO - Running post-action listener: _start_resource_monitoring 05:38:26 INFO - Starting resource monitoring. 05:38:26 INFO - ##### 05:38:26 INFO - ##### Running install step. 05:38:26 INFO - ##### 05:38:26 INFO - Running pre-action listener: _resource_record_pre_action 05:38:26 INFO - Running main action method: install 05:38:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:38:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:38:26 INFO - Reading from file tmpfile_stdout 05:38:26 INFO - Detecting whether we're running mozinstall >=1.0... 05:38:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:38:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:38:26 INFO - Reading from file tmpfile_stdout 05:38:26 INFO - Output received: 05:38:26 INFO - Usage: mozinstall [options] installer 05:38:26 INFO - Options: 05:38:26 INFO - -h, --help show this help message and exit 05:38:26 INFO - -d DEST, --destination=DEST 05:38:26 INFO - Directory to install application into. [default: 05:38:26 INFO - "/builds/slave/test"] 05:38:26 INFO - --app=APP Application being installed. [default: firefox] 05:38:26 INFO - mkdir: /builds/slave/test/build/application 05:38:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 05:38:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 05:39:00 INFO - Reading from file tmpfile_stdout 05:39:00 INFO - Output received: 05:39:00 INFO - /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox 05:39:00 INFO - Running post-action listener: _resource_record_post_action 05:39:00 INFO - ##### 05:39:00 INFO - ##### Running run-tests step. 05:39:00 INFO - ##### 05:39:00 INFO - Running pre-action listener: _resource_record_pre_action 05:39:00 INFO - Running main action method: run_tests 05:39:00 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:39:00 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:39:00 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:39:00 INFO - 2016-05-06 05:39:00.756 screenresolution[1649:7803] starting screenresolution argv=screenresolution get 05:39:00 INFO - 2016-05-06 05:39:00.759 screenresolution[1649:7803] Display 0: 1600x1200x32@60 05:39:00 INFO - 2016-05-06 05:39:00.765 screenresolution[1650:7805] starting screenresolution argv=screenresolution list 05:39:00 INFO - Available Modes on Display 0 05:39:00 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:39:00 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:39:00 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:39:00 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:39:00 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:39:00 INFO - Intel Iris: 05:39:00 INFO - Chipset Model: Intel Iris 05:39:00 INFO - Type: GPU 05:39:00 INFO - Bus: Built-In 05:39:00 INFO - VRAM (Dynamic, Max): 1536 MB 05:39:00 INFO - Vendor: Intel (0x8086) 05:39:00 INFO - Device ID: 0x0a2e 05:39:00 INFO - Revision ID: 0x0009 05:39:00 INFO - Displays: 05:39:00 INFO - Display: 05:39:00 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:39:00 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:39:00 INFO - Display Serial Number: 1600x1200 60 05:39:00 INFO - Main Display: Yes 05:39:00 INFO - Mirror: Off 05:39:00 INFO - Online: Yes 05:39:00 INFO - Rotation: Supported 05:39:00 INFO - Return code: 0 05:39:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:39:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:39:01 INFO - Python 2.7.3 05:39:01 INFO - Return code: 0 05:39:01 INFO - grabbing minidump binary from tooltool 05:39:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:39:01 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 0x10d9e1e00>, '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 0x10d80adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d9dcb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:39:01 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 05:39:01 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 05:39:01 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:39:01 INFO - Return code: 0 05:39:01 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 05:39:01 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:39:01 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:39:01 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 05:39:01 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:39:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 05:39:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 05:39:02 INFO - Return code: 0 05:39:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/J1UwYIA1RWS5SSpRKUkQVw/artifacts/public/build/firefox-49.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0005', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 05:39:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/J1UwYIA1RWS5SSpRKUkQVw/artifacts/public/build/firefox-49.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0005 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 05:39:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UVPBUXOF0G/Render', 05:39:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:39:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:39:02 INFO - 'HOME': '/Users/cltbld', 05:39:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:39:02 INFO - 'LOGNAME': 'cltbld', 05:39:02 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:39:02 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 05:39:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:39:02 INFO - 'MOZ_NO_REMOTE': '1', 05:39:02 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:39:02 INFO - 'NO_EM_RESTART': '1', 05:39:02 INFO - 'PAGER': '/bin/cat', 05:39:02 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:39:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:39:02 INFO - 'PWD': '/builds/slave/test', 05:39:02 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:39:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:39:02 INFO - 'SHELL': '/bin/bash', 05:39:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jIyRGdoMhQ/Listeners', 05:39:02 INFO - 'TMPDIR': '/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/', 05:39:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:39:02 INFO - 'USER': 'cltbld', 05:39:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:39:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:39:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:39:02 INFO - 'XPC_FLAGS': '0x0', 05:39:02 INFO - 'XPC_SERVICE_NAME': '0', 05:39:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:39:02 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/J1UwYIA1RWS5SSpRKUkQVw/artifacts/public/build/firefox-49.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0005', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 05:39:02 INFO - mozversion application_buildid: 20160506030222 05:39:02 INFO - mozversion application_changeset: 25d777f7efb357fc5478251913548521986abaa0 05:39:02 INFO - mozversion application_display_name: Nightly 05:39:02 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:39:02 INFO - mozversion application_name: Firefox 05:39:02 INFO - mozversion application_remotingname: firefox 05:39:02 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:39:02 INFO - mozversion application_vendor: Mozilla 05:39:02 INFO - mozversion application_version: 49.0a1 05:39:02 INFO - mozversion platform_buildid: 20160506030222 05:39:02 INFO - mozversion platform_changeset: 25d777f7efb357fc5478251913548521986abaa0 05:39:02 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:39:02 INFO - mozversion platform_version: 49.0a1 05:39:02 INFO - using testdate: 1462538342 05:39:02 INFO - actual date: 1462538342 05:39:02 INFO - starting webserver on 'localhost:49275' 05:39:02 INFO - SUITE-START | Running 2 tests 05:39:02 INFO - TEST-START | dromaeo_css 05:39:02 INFO - operating with platform_type : mac_ 05:39:02 INFO - Initialising browser for dromaeo_css test... 05:39:02 INFO - TEST-INFO | started process 1668 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/tmppLXp4G/profile http://localhost:49275/getInfo.html) 05:39:04 INFO - PROCESS | 1668 | __metrics Screen width/height:1600/1200 05:39:04 INFO - PROCESS | 1668 | colorDepth:24 05:39:04 INFO - PROCESS | 1668 | Browser inner width/height: 1024/689 05:39:04 INFO - PROCESS | 1668 | __metrics 05:39:05 INFO - PROCESS | 1668 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 05:39:05 ERROR - PROCESS | 1668 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 05:39:05 INFO - TEST-INFO | 1668: exit 0 05:39:05 INFO - Browser initialized. 05:39:05 INFO - Running cycle 1/1 for dromaeo_css test... 05:39:05 INFO - TEST-INFO | started process 1672 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/tmppLXp4G/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:39:17 INFO - PROCESS | 1672 | RSS: Main: 238919680 05:39:17 INFO - PROCESS | 1672 | 05:40:08 INFO - PROCESS | 1672 | 1462538408652 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 05:42:19 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49275/tests/dromaeo/cssquery-ext.html) 05:42:21 INFO - PROCESS | 1672 | RSS: Main: 403197952 05:42:21 INFO - PROCESS | 1672 | 05:45:24 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-ext.html (next: http://localhost:49275/tests/dromaeo/cssquery-jquery.html) 05:45:25 INFO - PROCESS | 1672 | RSS: Main: 376303616 05:45:25 INFO - PROCESS | 1672 | 05:48:27 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49275/tests/dromaeo/cssquery-mootools.html) 05:48:28 INFO - PROCESS | 1672 | RSS: Main: 367292416 05:48:28 INFO - PROCESS | 1672 | 05:51:30 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49275/tests/dromaeo/cssquery-prototype.html) 05:51:31 INFO - PROCESS | 1672 | RSS: Main: 362893312 05:51:31 INFO - PROCESS | 1672 | 05:54:34 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49275/tests/dromaeo/cssquery-yui.html) 05:54:35 INFO - PROCESS | 1672 | RSS: Main: 333344768 05:54:35 INFO - PROCESS | 1672 | 05:57:38 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-yui.html (next: http://localhost:49275/tests/dromaeo/cssquery-dojo.html) 05:57:38 INFO - PROCESS | 1672 | RSS: Main: 380026880 05:57:38 INFO - PROCESS | 1672 | 05:57:38 INFO - PROCESS | 1672 | __start_tp_report 05:57:38 INFO - PROCESS | 1672 | _x_x_mozilla_page_load 05:57:38 INFO - PROCESS | 1672 | _x_x_mozilla_page_load_details 05:57:38 INFO - PROCESS | 1672 | |i|pagename|runs| 05:57:38 INFO - PROCESS | 1672 | |0;dojo.html;3475.0617333320006;3509.9298014039737;3512.3326567952085;3545.698615617672;3579.7673151245167;5101.54086132248;5417.674939503632;5760.279965004374;5819.33077696064;5954.017587098129;5853.619514731539;5870.970645146768;5977.790777322794;6031.72857221425;6037.516998640109;5229.111051121318;5271.815486457975;5322.733863306838;5346.144616861303;5432.239486471897;5425.864353391177;5462.317210348707;5487.670739755627;5488.313960754906;5493.395726470085;5017.724025178613;5197.454267301917;5232.607554433433;5238.371395432534;5340.092184328654;5292.941411717672;5298.311219541473;5300.708461034642;5317.548008419289;5319.494648008433;5258.789648414059;5283.709395983219;5283.894322113575;5286.550643195333;5377.623566350357;5800.24596802413;5842.824715258506;5872.265966754156;5917;5918.408159184047;6101.035369328037;6238.656873871935;6240.469560087398;6251.281102673205;6256.061590761422;6158.414950579688;6195.4424101831055;6215.87568248637;6281.057841323838;6303;4973.925391119136;6037.1246169305205;6065.909011364833;6098.54260930432;6104.084387341934;6239.220097487814;6289.685515724287;6471.805845824632;6490.415862572297;6490.415862572391;6172.475339596095;6214.316425193225;6223.502119830403;6230.968845155836;6257.2804127525915;6277.560570760094;6291.339409362043;6291.591046581958;6300.180976473029;6347.809565713036;6144.2319710036245;6220.502359811204;6242.2509298883515;6246.187995560548;6271.874562508724;6172.444479996821;6190.41191086855;6220.284667263232;6227.314995350508;6227.813165605039;5057.519535644108;5059.266406371055;5059.696418214919;5063;5082.796688132507;3911.530616326059;4530.637548996138;4575.816967321336;4609.331646911179;4613.653975951817;5937.643741375445;5941.1088336749835;5994.610350327215;6000.21997140369;6019.578629495893;6272.027835685476;6273.7176827042895;6293.622382657055;6317.147185129948;6318.083877837687;5742.684152371576;5851.824445266649;5901.380355062743;5956.702164891738;6024.246969128859;5509;5547.2511210986;5569.55443564522;5591.217229587861;5601.719914004283;6511.837204069936;6569.014647802772;6571.408573228432;6601.3728695773825;6602.900956485657;6192.566520343533;6315.052742088724;6316.431521163117;6319.778807741707;6322.873542529215;6403.64779937108;6505.0567667688865;6508.316626754312;6577.671116444254;6591.373819487141;6180;6181.134641150333;6216.378362163748;6233.75064997395;6249.187605611423;6167.136600875791;6225.159603453476;6287.654179020198;6302.180716507009;6305.873882522415;6047.274327080779;6182.412670796267;6182.6599537025895;6198.6280823150755;6201.131841542097;6146.58628515435;6157.84605384869;6180.907286390618;6224.315325314121;6253.937460625336;6110.977996086511;6131.080337949344;6139.048447490646;6140.355262697352;6174.197354343906;6113.449789518964;6207.472364849038;6226.034964580497;6230.252369715663;6244;6049.032154855378;6095.196536865277;6100.633961962297;6117.583823141572;6172.4136207060255 05:57:38 INFO - PROCESS | 1672 | |1;ext.html;511.1642464570426;525.8659041944306;527.3697930972487;567.2710566921505;567.9659220446777;30624.234394140156;34399.65600343999;38366;44092.33861492072;46195.53804461954;45317;45379.319310210376;45467.77266113673;45545.54454455454;45704;8469.280111190525;9525;9656.179224765869;9656.324057315991;9671.806563868719;8466.238038576526;11538.538458461651;11787.528498860078;11799.587014454495;11957.521699132025;11680.532778688885;11737.706557336049;11740.41297935104;11755.235909665844;11763.882361176407;8541.786455338604;9787.412755234709;11648.767024659503;11744.647660570154;11758;11284.717882052932;11454.541818327258;11467.19729618927;11478.655640330804;11479.368634725086;41624;42025;42111.947201319905;42118;42211.155776884596;3310.9503357449657;3425.383430982422;3471.444568868969;3530.8234588270484;3622.89131326058;29342.559861602094;29509.557356639667;29679.70320296791;29899.850500747358;29908;2721.863906804652;2736.138116493298;2744.423671029086;2766.529689952713;2824.2939265183704;476096;478365;478543.9999999965;478615;479222;62924.37075629277;63460;63802.6809865957;63812.68093659595;63915.04127438092;37446.812765935996;37896.621033789306;37991.62008379936;67794.66102669554;67967.32032679609;17667.38164164248;17776.9111154446;17829.554261143316;17885.28458861657;17897.910510447364;12286.877131228752;12477.939375153032;13316.267605281802;13378.46486140563;13506.797398039038;20488.487787805425;20587.8970605149;20623.793762062487;20650.483737906674;20667.379978600668;7041.683124259421;7669.734493808459;7823;8366.736972580698;8373.246407823324;921.1709461484718;1014.3609525998573;1040.8907064758243;1058.4707646176912;1109.2734259060328;30363.392732145232;30557.23606909845;30752.077437676904;30924.763009479368;31210.21974450657;975.3221511049894;1090.6727981605645;1124.3366413815725;1195.7847587434346;1291.6964513339358;15751.68496630084;15806.20968951548;16028.358865645243;16141.185405777922;16301.51095467138;668058;1000197;1017301;1018774;1020179;63304;63417;64106.35893641097;64161;64196.03705944415;1371.8422381426265;1410.6825964157983;1503.8420965798653;1511.380334063051;1530.9540713778604;30140.54789178208;30942.535861961638;31540;32048.47466778606;32579;57566.424335756106;57928.13107803302;58090;58242;58315.416845831;549636;557777;565012;565068;565617;24701.50596988086;25173.24480265595;26030.869845651407;27759;28260.71739282663;45461.54538454573;45981;46741.53258467372;46791.766041169576;47238.055238895715;31417.842910786214;34098.829505852314;37607.43588846115;38856;39651.20697585974;37596;37937.86186414412;38201;38912.832615021594;38961.805190973864;37900.81049594734;38854;40140.38385585578;40770.776876693744;42289.365659515744;27626.861865691346;34001;34067;35209.82395088008;35234.11914702153;24407.38981525405;25250.116245931305;25356.366090847878;25591.104311349012;26153 05:57:38 INFO - PROCESS | 1672 | |2;jquery.html;393.8956176613197;399.2872722190889;401.4740689696498;406.090357598978;425.3810705423609;19873;20017.299394521193;20881.477963050933;21137.47156321093;21155.365339039814;11903.702407439796;12231.694207644814;17608.735868961976;20905.895470522628;20935.68596471054;5100.438951715309;5223.033738758332;5361.490658387447;5367.597430192732;5383.353997520303;3871.993281746752;4051.149258655686;5317;5370.248165256867;7039.6480175991255;7522.059742532184;7565.054368203974;7580.317771400573;7602.961985190094;7603.695852165934;7098.787036388917;7199.712011519533;7506.887396689;7522.210167932343;7541.849163016709;7240.891386629205;7259.092613423322;7260.092488438945;7264.891026634605;7266.600336981464;25791.742082579123;26431.20706378812;27090;29222.85388573065;29245.122646320644;2132.296342207068;2326.406766274606;2399.5800734871327;2440.0849681369486;2465.0632759551436;15118.773218401733;15351.385944562204;15879.285432155466;16494.42269520561;16556.66886662272;1600.2398860541266;1869.130854152812;1888.0182305201217;1949.4638974282045;1960.137539482623;93206;124120;124610;125333;125438.11842822457;16556.83443165577;18335.633287334178;19137.23451061942;20562.38312850587;21139.365819025454;29319;34792.82603586966;35440.11399715028;35492;35542.11144721351;10808.621698240524;11308.604198853001;11317.320960742381;11339.546418143347;11463.484143213574;7677.500962437423;9260.689916414607;9330.673426430043;9339.766505837408;9501.049895010581;7928;9574.856377154349;9635.036496350449;9766.706998790047;9767.413955162712;2559.3345730110304;3078.3689343684937;3277.6558461361215;3746.6628003479273;3747.3442147624055;683.8769021576164;731.2668974530397;796.4862663581957;888.2094935507404;965.32909627808;18964.43106706801;19490.415287541397;20157.99210039492;20549.69175462369;20594.485137871372;866.7226487524058;959.1367769007949;964.5514835601339;1029.315505189041;1062.0759938853248;10415.309729673194;10491.370517768959;10661.987111224422;10707.1434285257;10769.946150269356;444818;479954;503371;506695;513869;69806;89903;135608;135673.96489052672;140411;1014.2595904989399;1033.7105610428941;1057.4395570347574;1066.6426747039673;1070.0797314309686;17844.669964776793;18355.908220458812;18488.630227395646;18668.7199692002;19099.90450047741;47652.2852157211;50309.74845125751;51175.48824511707;51799.48200517947;53217.46782532125;60811;73619.26380736125;78078.6096069516;79943.60028199822;80189.1981080205;6155.384461553809;7135.286471353031;7819.609019549113;7836.608169591612;8291.046529648926;8029.5583742894705;9975.800483990424;10966.232363734782;11244.381559014333;12309.44607492647;10849.945750271514;10857.782844343226;11044;11167.44162791841;11337.546498139982;5021.6735912165595;9450.149486546245;10400.375977441377;10663.680089597325;11126.332420054823;4700.905981880412;10809.270516717288;11268.661940141808;11359.091272697999;11448.42757862087;6838.2136054352395;8038.919610803817;8083.797905052421;8339.041010283894;8353.832923341377;9455.14903658674;10138.18894488454;11042.944785276022;11326.660200194008;11353.829692554784 05:57:38 INFO - PROCESS | 1672 | |3;mootools.html;1258.0878862824447;1611.1380411479856;1633.591602099475;1865.5615930256388;1961.539038325993;7696.961515192424;8517.872231916519;8766.298696104312;8785.516796576194;8858.689945851896;8492.447990880604;8686.869696954534;8711.91288087119;8721.258693011101;8730.214280714734;2141.325482473016;2214.2471559669707;2216.5788500184995;2406.8676222807694;2441.7192022917325;2196.615592271354;2379.202967006055;2469.469064151207;2475.2945410557995;2478.157426474998;2384.7496012918655;2419.2621250518587;2427.7693619106158;2434.537437886796;2438.1588352018525;2115.7249557557575;2393.5212957408503;2401.6997875265592;2402.1952645863657;2406.2059520358325;2360.3037104054347;2440.7803297703113;2445.327534927891;2446.2538925627678;2449.289705985262;8573.228409443118;8624.008239052464;8629.568521573896;8641.395102342838;8644.438111522732;5182.922256166161;5359.437259087778;5367.5169234769055;5403.432639572867;5414.7834086636485;3430.5711786026745;3541.94687079694;3580.7493475456727;3598.748087633867;3603.1892824114625;1034.9586016559329;1045.5869931377063;1047.361109723076;1052.394872948058;1054.752133248686;11563;11591.304521728638;11592.826107608393;11604.535818567247;11612.6516204514;4691.108689349013;4694.413198350207;4831.685940413862;4833.951660483421;4835.516448355207;9820.803583928424;9826.557804898797;9840.3603765755;9868.358556693793;9868.901310986941;5331.253624492574;5353.57171426285;5365.865853353619;5367.114426119724;5377.085895397791;4764.4282686077195;4838.806447742121;4924.162892308316;4928.605711543068;4973.104841128559;3811.5616704079384;3824.541055073409;3847.788371639587;3891.280113179071;3917.5494818095713;1205.0961778666;1206.776746301937;1215.9574414895437;1216.7627312674122;1218.9146759726912;765.2882818978403;911.968081117171;912.4434095202055;928.7213835849218;977.5454413697664;5559.249501317351;5598.496135347838;5812.099124635688;5846;5946.405359464019;458.44070234314086;465.28578631800025;467.46942220579206;972.4894430424084;1044.498640652491;3397.779144355609;3812.961870381316;3860.208657225262;3903.590123037097;3944.3294639911283;10466.319689220176;10591.205659575562;10791.352518848895;10798.67603971882;10834.458277086114;10623.893761062445;10654.62708805188;10733.516991735234;10766.192535559865;10814.94592527048;8231;8287.171282871665;8364.665413383396;8372.832543349099;8392.958035209786;5736.368999410145;5742.16738572913;5754.712264386848;5902.793402230901;5980.9401905980385;9705;9998.250131240331;10232.795344092927;10233.334833235816;10287.485625718833;9025.684101056431;9146.496942668216;9906.108450239513;10169.694909152737;10306.948465257627;6650.20197576294;6847.554908930903;7081.7167313308955;7088.539244949268;7158.642067896689;8183.895174151413;8195.303399211134;8207.917920820715;8214.507129572245;8237.46456480327;7402.9629851850395;7454.701811927679;7498.475106742476;7587.2412758723685;7616.314531692175;7177.246389129066;7319.4144468443465;7323.890141647773;7390.076240469942;7459.701611935679;6747.966260168668;7026.683799228945;7114.715411383487;7121.181064177686;7131.144262688511;4630.83792067276;4736.952630473651;4863.294822250683;4929.704217746947;5033.521815427529;4460.955390446184;4943.77753001123;5008.524190201925;5022.773975171199;5243.737813109406 05:57:38 INFO - PROCESS | 1672 | |4;prototype.html;307.4358552056975;314.976376771742;319.95360672702463;322.6257541252148;326.53142740167846;4390.385346051556;4574.382458368119;5011.22326039464;5057.418396884359;5211.400688920775;4507.887302817423;4777.355057067295;5231.136862417697;5240.423553409122;5287.947120528803;3111.937761244774;3648.5074514940543;3779.9811000944956;3933.9016524586827;4003.5395929468045;3389.4237979543536;3493.266414053052;3547.9001509532127;3763.9247215055684;3953.9209215815667;3378.864845406181;3623.420252759559;3873.69010479161;3931.19410520844;3937.1731936293268;3252.251982044143;3339.3989081965237;3393.423118069934;3402.6427225141497;3802.638749318824;3076.953835695852;3080.4147212029866;3481.930361392783;3513.5256740339983;3515.6484351564895;4940.357753492023;4950.851474455736;4955.40535135786;4979.925301120486;4997.775100120503;4348.543402942677;4539.387182730356;4539.955810163681;4551.886202844956;4583.289590113538;4817.686850354751;5312.973435132838;5403.81145636018;5412.484504338791;5429.592780541475;3152.952705709416;3856.3444214483607;3860.9227815443533;3868.613138686137;3871.593482684334;4850.345203397532;5106.540226613337;5638.633488823254;5682.488576028136;5691.089425691911;3930.427828868418;3953.446517487554;3964.3458829292845;3980.9402858957137;3994.6804255659476;3318.634950155481;3451.8964431067106;4035.515738111387;4039.8788036358956;4044.1911617676583;4546.681732278775;4587.683219973892;4588;4604.30935359692;4607.216773148572;5123.590112791042;5167;5192.1173400522;5483.4501956590375;5487;1152.233764546567;1167.9416029198505;1260.7100366915477;1267.2776517385187;1313.7766579681477;788.412632588725;802.4423025996992;809.7368355284439;815.9877601835977;912.7353067610319;3891.8443262269193;4055.3299264165976;4282.379055037002;4312.54718254585;4805.780127314708;5193.727536753444;5194.22086687;5256.290400795843;5263.315768950012;5298.602604804655;3769.754965927206;4272.5086615039045;4370.055325380175;4434.889127771831;4768.403949506312;2407.482391285882;2420.4916967436684;2425.1390756281617;2496.7003959524973;2605;4599.816007359668;4970.627202959792;5404.675854415694;5465.6335916021;5495.642783219078;4962.528559786814;4963.726995015237;5103.693778373309;5315.325672413178;5375.81184658535;4698.553637404441;4769.618430525549;5245.59036626196;5482.506574408243;5486.588505862076;4983.626228032839;5198.662086964335;5232.005918875401;5249.291345668438;5260.605454590845;4861.003494283593;4864.610831133572;5152.187381337858;5178.249153872592;5656.208130861601;4690.319903614025;4924;5436.592255580768;5720.940461433964;5949.791757288474;3346.8661253549585;3373.7301015919156;3662.3265016537543;3794.463242386838;3801.9619803801606;4370.344448332648;4801.4958429364415;5214.504622060898;5355.30381050461;5751.913721294268;4906.975465122651;5020.644426004885;5183.377994640668;5420.241166236651;5477.233996831575;4460.085682435158;4649.697769644962;5000.974995125001;5403.540699040625;5459.235707001102;4351.933776224845;4917.508249175054;4950.900981980269;4997.8255110048385;5306.54894333986;4559.583420786988;4696.953030469652;5265.447128051653;5458.263134476795;5481.382992017444;4717.410323709536;4967.3542439482635;5366.597505187048;5395.67625942429;5444.945550544444 05:57:38 INFO - PROCESS | 1672 | |5;yui.html;666.7499687617144;742.5247841381516;746.0450623202303;747.7845265358956;754.3173428047619;11892.940535297323;14872.405103795834;15286.006409583384;15619.140947247897;15639.530814075568;11717.589884354049;14350.282485875716;14379.424823007093;14391.280435978211;14437.42250309989;722.2813300765746;742.5210739073294;902.6705252582809;919.7792529792835;920.089111779337;881.8633111867671;906.3881879731188;907.4918045894287;914.9542522873863;915.9679411220609;898.8202359528087;910.5811326789685;973.4694591447643;974.2887691984855;975.2393133355994;753.2279413601048;934.4066517761271;963.7253382785873;963.9325247232697;966.2608104799833;715.899774031636;717.8026042838209;718.4288490649893;718.5688586847901;719.5934297122109;14732.18972956487;14749;14771.778423323658;14773.33519991603;14817.259137043213;12157.817632735516;12159.392030398532;12336.75326493465;12367.62897113088;12432;10869.565217391295;10887.782244355149;10892.128629709683;10940;11374.60188893393;4029.97985010076;4032.697547683935;4036.6568841648495;4144.316187829005;4182.53992060873;76459;77259.8411023835;77272.84090738643;77709;78769.60615196945;9235.076492350845;9351.39215950961;9462.384944978554;9670.081342272473;9694.660686875926;20958.266460673804;20977.475563111046;21010.684839727415;21036.368908932756;21099.578008440054;7259.600721960237;7320.377767889682;7322.890156647654;7343.63281835906;7423.838075763382;3972.1261322509004;4031.4759081319826;4038.273110840077;4038.7778672172726;4042.514898212233;3479.443289073736;3569.464580312974;3573.3032058748295;3575.4636804479014;3585.1395665040723;563.9266895303584;647.2233320015905;658.1641315529251;672.7140965089817;676.7403836179418;466.4239664014939;507.64211231082;524.5305451620778;545.6126150433237;579.568221674855;7684.731034413769;7881.645325960346;7938.563379014095;7997.240262175201;8184;484.382412424162;569.2912324156451;574.3337728235227;600.099850224663;606.2452246952572;3710;3726.64596863303;3748.2878253131817;3796.6203379662365;3944.6055394460323;87784;90307;90979;91016.544917275;91863;74372;76120;77365;78377.0405739861;81601.59199203966;54243.72878135584;70133.64933175403;70312.6484367585;70558.29441705518;71341.28658713347;7245.637718114179;7255.347018768336;7445.92554074474;7456.813579660552;7562.810929726801;42553.361699573914;43457;43789.786812097176;45459;45588.7720561395;54879.981601012325;62525;62719;62804.42988925314;62901.37098629138;9315.39449935752;9708.029197080517;9903.603855845973;10000.04999525044;10043.196544276587;10402;10502.212334074822;10637.042666160083;10656;10681.19891008193;8301.58492075406;10088;10179.796404072025;10366.688999330032;10404.219683523615;10009;10021.799564008534;10041.648542300984;10277.023682750127;10374.066334029974;9920.305578609717;9952.154066904393;10029.29794914349;10200.591976320864;10282.383057016603;8349.749507514784;8519.914800851911;8704.564771761514;8739.91260087391;8788;8294.543800091053;8457.238848503664;8530.616122274636;8663.91336086631;8675.826483470422 05:57:38 INFO - PROCESS | 1672 | __end_tp_report 05:57:38 INFO - PROCESS | 1672 | __start_cc_report 05:57:38 INFO - PROCESS | 1672 | _x_x_mozilla_cycle_collect,1595 05:57:38 INFO - PROCESS | 1672 | __end_cc_report 05:57:38 INFO - PROCESS | 1672 | __startTimestamp1462539458483__endTimestamp 05:57:38 INFO - PROCESS | 1672 | 05:57:38 INFO - PROCESS | 1672 | ------- Summary: start ------- 05:57:38 INFO - PROCESS | 1672 | Number of tests: 6 05:57:38 INFO - PROCESS | 1672 | 05:57:38 INFO - PROCESS | 1672 | [#0] dojo.html Cycles:165 Average:5852.05 Median:6117.58 stddev:638.71 (10.4%) stddev-sans-first:612.84 05:57:38 INFO - PROCESS | 1672 | Values: 3475.1 3509.9 3512.3 3545.7 3579.8 5101.5 5417.7 5760.3 5819.3 5954.0 5853.6 5871.0 5977.8 6031.7 6037.5 5229.1 5271.8 5322.7 5346.1 5432.2 5425.9 5462.3 5487.7 5488.3 5493.4 5017.7 5197.5 5232.6 5238.4 5340.1 5292.9 5298.3 5300.7 5317.5 5319.5 5258.8 5283.7 5283.9 5286.6 5377.6 5800.2 5842.8 5872.3 5917.0 5918.4 6101.0 6238.7 6240.5 6251.3 6256.1 6158.4 6195.4 6215.9 6281.1 6303.0 4973.9 6037.1 6065.9 6098.5 6104.1 6239.2 6289.7 6471.8 6490.4 6490.4 6172.5 6214.3 6223.5 6231.0 6257.3 6277.6 6291.3 6291.6 6300.2 6347.8 6144.2 6220.5 6242.3 6246.2 6271.9 6172.4 6190.4 6220.3 6227.3 6227.8 5057.5 5059.3 5059.7 5063.0 5082.8 3911.5 4530.6 4575.8 4609.3 4613.7 5937.6 5941.1 5994.6 6000.2 6019.6 6272.0 6273.7 6293.6 6317.1 6318.1 5742.7 5851.8 5901.4 5956.7 6024.2 5509.0 5547.3 5569.6 5591.2 5601.7 6511.8 6569.0 6571.4 6601.4 6602.9 6192.6 6315.1 6316.4 6319.8 6322.9 6403.6 6505.1 6508.3 6577.7 6591.4 6180.0 6181.1 6216.4 6233.8 6249.2 6167.1 6225.2 6287.7 6302.2 6305.9 6047.3 6182.4 6182.7 6198.6 6201.1 6146.6 6157.8 6180.9 6224.3 6253.9 6111.0 6131.1 6139.0 6140.4 6174.2 6113.4 6207.5 6226.0 6230.3 6244.0 6049.0 6095.2 6100.6 6117.6 6172.4 05:57:38 INFO - PROCESS | 1672 | 05:57:38 INFO - PROCESS | 1672 | [#1] ext.html Cycles:180 Average:78421.17 Median:18762.11 stddev:188115.52 (1002.6%) stddev-sans-first:188552.29 05:57:38 INFO - PROCESS | 1672 | Values: 511.2 525.9 527.4 567.3 568.0 30624.2 34399.7 38366.0 44092.3 46195.5 45317.0 45379.3 45467.8 45545.5 45704.0 8469.3 9525.0 9656.2 9656.3 9671.8 8466.2 11538.5 11787.5 11799.6 11957.5 11680.5 11737.7 11740.4 11755.2 11763.9 8541.8 9787.4 11648.8 11744.6 11758.0 11284.7 11454.5 11467.2 11478.7 11479.4 41624.0 42025.0 42111.9 42118.0 42211.2 3311.0 3425.4 3471.4 3530.8 3622.9 29342.6 29509.6 29679.7 29899.9 29908.0 2721.9 2736.1 2744.4 2766.5 2824.3 476096.0 478365.0 478544.0 478615.0 479222.0 62924.4 63460.0 63802.7 63812.7 63915.0 37446.8 37896.6 37991.6 67794.7 67967.3 17667.4 17776.9 17829.6 17885.3 17897.9 12286.9 12477.9 13316.3 13378.5 13506.8 20488.5 20587.9 20623.8 20650.5 20667.4 7041.7 7669.7 7823.0 8366.7 8373.2 921.2 1014.4 1040.9 1058.5 1109.3 30363.4 30557.2 30752.1 30924.8 31210.2 975.3 1090.7 1124.3 1195.8 1291.7 15751.7 15806.2 16028.4 16141.2 16301.5 668058.0 1000197.0 1017301.0 1018774.0 1020179.0 63304.0 63417.0 64106.4 64161.0 64196.0 1371.8 1410.7 1503.8 1511.4 1531.0 30140.5 30942.5 31540.0 32048.5 32579.0 57566.4 57928.1 58090.0 58242.0 58315.4 549636.0 557777.0 565012.0 565068.0 565617.0 24701.5 25173.2 26030.9 27759.0 28260.7 45461.5 45981.0 46741.5 46791.8 47238.1 31417.8 34098.8 37607.4 38856.0 39651.2 37596.0 37937.9 38201.0 38912.8 38961.8 37900.8 38854.0 40140.4 40770.8 42289.4 27626.9 34001.0 34067.0 35209.8 35234.1 24407.4 25250.1 25356.4 25591.1 26153.0 05:57:38 INFO - PROCESS | 1672 | 05:57:38 INFO - PROCESS | 1672 | [#2] jquery.html Cycles:180 Average:32522.54 Median:3178.01 stddev:82562.70 (2597.9%) stddev-sans-first:82759.07 05:57:38 INFO - PROCESS | 1672 | Values: 393.9 399.3 401.5 406.1 425.4 19873.0 20017.3 20881.5 21137.5 21155.4 11903.7 12231.7 17608.7 20905.9 20935.7 5100.4 5223.0 5361.5 5367.6 5383.4 3872.0 4051.1 5317.0 5370.2 7039.6 7522.1 7565.1 7580.3 7603.0 7603.7 7098.8 7199.7 7506.9 7522.2 7541.8 7240.9 7259.1 7260.1 7264.9 7266.6 25791.7 26431.2 27090.0 29222.9 29245.1 2132.3 2326.4 2399.6 2440.1 2465.1 15118.8 15351.4 15879.3 16494.4 16556.7 1600.2 1869.1 1888.0 1949.5 1960.1 93206.0 124120.0 124610.0 125333.0 125438.1 16556.8 18335.6 19137.2 20562.4 21139.4 29319.0 34792.8 35440.1 35492.0 35542.1 10808.6 11308.6 11317.3 11339.5 11463.5 7677.5 9260.7 9330.7 9339.8 9501.0 7928.0 9574.9 9635.0 9766.7 9767.4 2559.3 3078.4 3277.7 3746.7 3747.3 683.9 731.3 796.5 888.2 965.3 18964.4 19490.4 20158.0 20549.7 20594.5 866.7 959.1 964.6 1029.3 1062.1 10415.3 10491.4 10662.0 10707.1 10769.9 444818.0 479954.0 503371.0 506695.0 513869.0 69806.0 89903.0 135608.0 135674.0 140411.0 1014.3 1033.7 1057.4 1066.6 1070.1 17844.7 18355.9 18488.6 18668.7 19099.9 47652.3 50309.7 51175.5 51799.5 53217.5 60811.0 73619.3 78078.6 79943.6 80189.2 6155.4 7135.3 7819.6 7836.6 8291.0 8029.6 9975.8 10966.2 11244.4 12309.4 10849.9 10857.8 11044.0 11167.4 11337.5 5021.7 9450.1 10400.4 10663.7 11126.3 4700.9 10809.3 11268.7 11359.1 11448.4 6838.2 8038.9 8083.8 8339.0 8353.8 9455.1 10138.2 11042.9 11326.7 11353.8 05:57:38 INFO - PROCESS | 1672 | 05:57:38 INFO - PROCESS | 1672 | [#3] mootools.html Cycles:180 Average:5670.67 Median:4926.38 stddev:3182.47 (64.6%) stddev-sans-first:3174.12 05:57:38 INFO - PROCESS | 1672 | Values: 1258.1 1611.1 1633.6 1865.6 1961.5 7697.0 8517.9 8766.3 8785.5 8858.7 8492.4 8686.9 8711.9 8721.3 8730.2 2141.3 2214.2 2216.6 2406.9 2441.7 2196.6 2379.2 2469.5 2475.3 2478.2 2384.7 2419.3 2427.8 2434.5 2438.2 2115.7 2393.5 2401.7 2402.2 2406.2 2360.3 2440.8 2445.3 2446.3 2449.3 8573.2 8624.0 8629.6 8641.4 8644.4 5182.9 5359.4 5367.5 5403.4 5414.8 3430.6 3541.9 3580.7 3598.7 3603.2 1035.0 1045.6 1047.4 1052.4 1054.8 11563.0 11591.3 11592.8 11604.5 11612.7 4691.1 4694.4 4831.7 4834.0 4835.5 9820.8 9826.6 9840.4 9868.4 9868.9 5331.3 5353.6 5365.9 5367.1 5377.1 4764.4 4838.8 4924.2 4928.6 4973.1 3811.6 3824.5 3847.8 3891.3 3917.5 1205.1 1206.8 1216.0 1216.8 1218.9 765.3 912.0 912.4 928.7 977.5 5559.2 5598.5 5812.1 5846.0 5946.4 458.4 465.3 467.5 972.5 1044.5 3397.8 3813.0 3860.2 3903.6 3944.3 10466.3 10591.2 10791.4 10798.7 10834.5 10623.9 10654.6 10733.5 10766.2 10814.9 8231.0 8287.2 8364.7 8372.8 8393.0 5736.4 5742.2 5754.7 5902.8 5980.9 9705.0 9998.3 10232.8 10233.3 10287.5 9025.7 9146.5 9906.1 10169.7 10306.9 6650.2 6847.6 7081.7 7088.5 7158.6 8183.9 8195.3 8207.9 8214.5 8237.5 7403.0 7454.7 7498.5 7587.2 7616.3 7177.2 7319.4 7323.9 7390.1 7459.7 6748.0 7026.7 7114.7 7121.2 7131.1 4630.8 4737.0 4863.3 4929.7 5033.5 4461.0 4943.8 5008.5 5022.8 5243.7 05:57:38 INFO - PROCESS | 1672 | 05:57:38 INFO - PROCESS | 1672 | [#4] prototype.html Cycles:180 Average:4252.24 Median:4742.91 stddev:1304.67 (27.5%) stddev-sans-first:1274.29 05:57:38 INFO - PROCESS | 1672 | Values: 307.4 315.0 320.0 322.6 326.5 4390.4 4574.4 5011.2 5057.4 5211.4 4507.9 4777.4 5231.1 5240.4 5287.9 3111.9 3648.5 3780.0 3933.9 4003.5 3389.4 3493.3 3547.9 3763.9 3953.9 3378.9 3623.4 3873.7 3931.2 3937.2 3252.3 3339.4 3393.4 3402.6 3802.6 3077.0 3080.4 3481.9 3513.5 3515.6 4940.4 4950.9 4955.4 4979.9 4997.8 4348.5 4539.4 4540.0 4551.9 4583.3 4817.7 5313.0 5403.8 5412.5 5429.6 3153.0 3856.3 3860.9 3868.6 3871.6 4850.3 5106.5 5638.6 5682.5 5691.1 3930.4 3953.4 3964.3 3980.9 3994.7 3318.6 3451.9 4035.5 4039.9 4044.2 4546.7 4587.7 4588.0 4604.3 4607.2 5123.6 5167.0 5192.1 5483.5 5487.0 1152.2 1167.9 1260.7 1267.3 1313.8 788.4 802.4 809.7 816.0 912.7 3891.8 4055.3 4282.4 4312.5 4805.8 5193.7 5194.2 5256.3 5263.3 5298.6 3769.8 4272.5 4370.1 4434.9 4768.4 2407.5 2420.5 2425.1 2496.7 2605.0 4599.8 4970.6 5404.7 5465.6 5495.6 4962.5 4963.7 5103.7 5315.3 5375.8 4698.6 4769.6 5245.6 5482.5 5486.6 4983.6 5198.7 5232.0 5249.3 5260.6 4861.0 4864.6 5152.2 5178.2 5656.2 4690.3 4924.0 5436.6 5720.9 5949.8 3346.9 3373.7 3662.3 3794.5 3802.0 4370.3 4801.5 5214.5 5355.3 5751.9 4907.0 5020.6 5183.4 5420.2 5477.2 4460.1 4649.7 5001.0 5403.5 5459.2 4351.9 4917.5 4950.9 4997.8 5306.5 4559.6 4697.0 5265.4 5458.3 5481.4 4717.4 4967.4 5366.6 5395.7 5444.9 05:57:38 INFO - PROCESS | 1672 | 05:57:38 INFO - PROCESS | 1672 | [#5] yui.html Cycles:180 Average:17435.79 Median:31774.30 stddev:24710.88 (77.8%) stddev-sans-first:24748.12 05:57:38 INFO - PROCESS | 1672 | Values: 666.7 742.5 746.0 747.8 754.3 11892.9 14872.4 15286.0 15619.1 15639.5 11717.6 14350.3 14379.4 14391.3 14437.4 722.3 742.5 902.7 919.8 920.1 881.9 906.4 907.5 915.0 916.0 898.8 910.6 973.5 974.3 975.2 753.2 934.4 963.7 963.9 966.3 715.9 717.8 718.4 718.6 719.6 14732.2 14749.0 14771.8 14773.3 14817.3 12157.8 12159.4 12336.8 12367.6 12432.0 10869.6 10887.8 10892.1 10940.0 11374.6 4030.0 4032.7 4036.7 4144.3 4182.5 76459.0 77259.8 77272.8 77709.0 78769.6 9235.1 9351.4 9462.4 9670.1 9694.7 20958.3 20977.5 21010.7 21036.4 21099.6 7259.6 7320.4 7322.9 7343.6 7423.8 3972.1 4031.5 4038.3 4038.8 4042.5 3479.4 3569.5 3573.3 3575.5 3585.1 563.9 647.2 658.2 672.7 676.7 466.4 507.6 524.5 545.6 579.6 7684.7 7881.6 7938.6 7997.2 8184.0 484.4 569.3 574.3 600.1 606.2 3710.0 3726.6 3748.3 3796.6 3944.6 87784.0 90307.0 90979.0 91016.5 91863.0 74372.0 76120.0 77365.0 78377.0 81601.6 54243.7 70133.6 70312.6 70558.3 71341.3 7245.6 7255.3 7445.9 7456.8 7562.8 42553.4 43457.0 43789.8 45459.0 45588.8 54880.0 62525.0 62719.0 62804.4 62901.4 9315.4 9708.0 9903.6 10000.0 10043.2 10402.0 10502.2 10637.0 10656.0 10681.2 8301.6 10088.0 10179.8 10366.7 10404.2 10009.0 10021.8 10041.6 10277.0 10374.1 9920.3 9952.2 10029.3 10200.6 10282.4 8349.7 8519.9 8704.6 8739.9 8788.0 8294.5 8457.2 8530.6 8663.9 8675.8 05:57:38 INFO - PROCESS | 1672 | -------- Summary: end -------- 05:57:38 INFO - PROCESS | 1672 | 05:57:39 INFO - TEST-INFO | 1672: exit 0 05:57:39 INFO - TEST-OK | dromaeo_css | took 1116801ms 05:57:39 INFO - TEST-START | kraken 05:57:39 INFO - operating with platform_type : mac_ 05:57:39 INFO - Initialising browser for kraken test... 05:57:39 INFO - TEST-INFO | started process 1678 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/tmpAJ8Sjh/profile http://localhost:49275/getInfo.html) 05:57:41 INFO - PROCESS | 1678 | __metrics Screen width/height:1600/1200 05:57:41 INFO - PROCESS | 1678 | colorDepth:24 05:57:41 INFO - PROCESS | 1678 | Browser inner width/height: 1024/689 05:57:41 INFO - PROCESS | 1678 | __metrics 05:57:41 INFO - PROCESS | 1678 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 05:57:41 ERROR - PROCESS | 1678 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 05:57:42 INFO - TEST-INFO | 1678: exit 0 05:57:42 INFO - Browser initialized. 05:57:42 INFO - Running cycle 1/1 for kraken test... 05:57:42 INFO - TEST-INFO | started process 1681 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/tmpAJ8Sjh/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:57:54 INFO - PROCESS | 1681 | RSS: Main: 238931968 05:57:54 INFO - PROCESS | 1681 | 05:57:57 INFO - PROCESS | 1681 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-beat-detection) 05:57:58 INFO - PROCESS | 1681 | RSS: Main: 286650368 05:57:58 INFO - PROCESS | 1681 | 05:58:01 INFO - PROCESS | 1681 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-dft) 05:58:01 INFO - PROCESS | 1681 | RSS: Main: 295415808 05:58:01 INFO - PROCESS | 1681 | 05:58:05 INFO - PROCESS | 1681 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-fft) 05:58:05 INFO - PROCESS | 1681 | RSS: Main: 382877696 05:58:05 INFO - PROCESS | 1681 | 05:58:07 INFO - PROCESS | 1681 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-oscillator) 05:58:08 INFO - PROCESS | 1681 | RSS: Main: 280756224 05:58:08 INFO - PROCESS | 1681 | 05:58:10 INFO - PROCESS | 1681 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:58:11 INFO - PROCESS | 1681 | RSS: Main: 284643328 05:58:11 INFO - PROCESS | 1681 | 05:58:13 INFO - PROCESS | 1681 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-darkroom) 05:58:14 INFO - PROCESS | 1681 | RSS: Main: 322179072 05:58:14 INFO - PROCESS | 1681 | 05:58:17 INFO - PROCESS | 1681 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-desaturate) 05:58:18 INFO - PROCESS | 1681 | RSS: Main: 322953216 05:58:18 INFO - PROCESS | 1681 | 05:58:21 INFO - PROCESS | 1681 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49275/tests/kraken/driver.html?testName=json-parse-financial) 05:58:21 INFO - PROCESS | 1681 | RSS: Main: 323948544 05:58:21 INFO - PROCESS | 1681 | 05:58:23 INFO - PROCESS | 1681 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49275/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:58:24 INFO - PROCESS | 1681 | RSS: Main: 314560512 05:58:24 INFO - PROCESS | 1681 | 05:58:25 INFO - PROCESS | 1681 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:58:26 INFO - PROCESS | 1681 | RSS: Main: 322449408 05:58:26 INFO - PROCESS | 1681 | 05:58:28 INFO - PROCESS | 1681 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:58:29 INFO - PROCESS | 1681 | RSS: Main: 323510272 05:58:29 INFO - PROCESS | 1681 | 05:58:32 INFO - PROCESS | 1681 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:58:33 INFO - PROCESS | 1681 | RSS: Main: 328433664 05:58:33 INFO - PROCESS | 1681 | 05:58:36 INFO - PROCESS | 1681 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:58:36 INFO - PROCESS | 1681 | RSS: Main: 326479872 05:58:36 INFO - PROCESS | 1681 | 05:58:38 INFO - PROCESS | 1681 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49275/tests/kraken/driver.html?testName=ai-astar) 05:58:38 INFO - PROCESS | 1681 | RSS: Main: 372936704 05:58:38 INFO - PROCESS | 1681 | 05:58:38 INFO - PROCESS | 1681 | __start_tp_report 05:58:38 INFO - PROCESS | 1681 | _x_x_mozilla_page_load 05:58:38 INFO - PROCESS | 1681 | _x_x_mozilla_page_load_details 05:58:38 INFO - PROCESS | 1681 | |i|pagename|runs| 05:58:38 INFO - PROCESS | 1681 | |0;ai-astar;113;106;114;117;163;162;112;112;113;112 05:58:38 INFO - PROCESS | 1681 | |1;audio-beat-detection;151;120;145;163;122;153;158;141;166;119 05:58:38 INFO - PROCESS | 1681 | |2;audio-dft;186;187;185;184;184;183;182;185;179;184 05:58:38 INFO - PROCESS | 1681 | |3;audio-fft;82;73;58;106;58;60;57;58;114;55 05:58:38 INFO - PROCESS | 1681 | |4;audio-oscillator;93;100;99;80;76;77;103;80;79;100 05:58:38 INFO - PROCESS | 1681 | |5;imaging-gaussian-blur;84;89;132;129;86;83;87;84;87;84 05:58:38 INFO - PROCESS | 1681 | |6;imaging-darkroom;93;94;94;94;92;93;93;94;106;146 05:58:38 INFO - PROCESS | 1681 | |7;imaging-desaturate;99;130;132;87;83;82;102;130;71;138 05:58:38 INFO - PROCESS | 1681 | |8;json-parse-financial;59;58;58;57;57;57;57;74;49;51 05:58:38 INFO - PROCESS | 1681 | |9;json-stringify-tinderbox;65;72;80;68;73;73;70;69;69;74 05:58:38 INFO - PROCESS | 1681 | |10;stanford-crypto-aes;86;86;86;81;86;102;86;86;85;87 05:58:38 INFO - PROCESS | 1681 | |11;stanford-crypto-ccm;125;157;148;132;149;146;150;135;193;152 05:58:38 INFO - PROCESS | 1681 | |12;stanford-crypto-pbkdf2;168;223;169;169;169;170;169;167;169;164 05:58:38 INFO - PROCESS | 1681 | |13;stanford-crypto-sha256-iterative;69;67;67;67;66;67;71;86;75;65 05:58:38 INFO - PROCESS | 1681 | __end_tp_report 05:58:38 INFO - PROCESS | 1681 | __start_cc_report 05:58:38 INFO - PROCESS | 1681 | _x_x_mozilla_cycle_collect,2071 05:58:38 INFO - PROCESS | 1681 | __end_cc_report 05:58:38 INFO - PROCESS | 1681 | __startTimestamp1462539518665__endTimestamp 05:58:38 INFO - PROCESS | 1681 | 05:58:38 INFO - PROCESS | 1681 | ------- Summary: start ------- 05:58:38 INFO - PROCESS | 1681 | Number of tests: 14 05:58:38 INFO - PROCESS | 1681 | 05:58:38 INFO - PROCESS | 1681 | [#0] ai-astar Cycles:10 Average:122.40 Median:113.50 stddev:21.31 (18.8%) stddev-sans-first:22.33 05:58:38 INFO - PROCESS | 1681 | Values: 113.0 106.0 114.0 117.0 163.0 162.0 112.0 112.0 113.0 112.0 05:58:38 INFO - PROCESS | 1681 | 05:58:38 INFO - PROCESS | 1681 | [#1] audio-beat-detection Cycles:10 Average:143.80 Median:152.00 stddev:17.84 (11.7%) stddev-sans-first:18.73 05:58:38 INFO - PROCESS | 1681 | Values: 151.0 120.0 145.0 163.0 122.0 153.0 158.0 141.0 166.0 119.0 05:58:38 INFO - PROCESS | 1681 | 05:58:38 INFO - PROCESS | 1681 | [#2] audio-dft Cycles:10 Average:183.90 Median:184.50 stddev:2.23 (1.2%) stddev-sans-first:2.24 05:58:38 INFO - PROCESS | 1681 | Values: 186.0 187.0 185.0 184.0 184.0 183.0 182.0 185.0 179.0 184.0 05:58:38 INFO - PROCESS | 1681 | 05:58:38 INFO - PROCESS | 1681 | [#3] audio-fft Cycles:10 Average:72.10 Median:58.00 stddev:21.77 (37.5%) stddev-sans-first:22.80 05:58:38 INFO - PROCESS | 1681 | Values: 82.0 73.0 58.0 106.0 58.0 60.0 57.0 58.0 114.0 55.0 05:58:38 INFO - PROCESS | 1681 | 05:58:38 INFO - PROCESS | 1681 | [#4] audio-oscillator Cycles:10 Average:88.70 Median:79.50 stddev:11.20 (14.1%) stddev-sans-first:11.77 05:58:38 INFO - PROCESS | 1681 | Values: 93.0 100.0 99.0 80.0 76.0 77.0 103.0 80.0 79.0 100.0 05:58:38 INFO - PROCESS | 1681 | 05:58:38 INFO - PROCESS | 1681 | [#5] imaging-gaussian-blur Cycles:10 Average:94.50 Median:85.00 stddev:19.07 (22.4%) stddev-sans-first:19.85 05:58:38 INFO - PROCESS | 1681 | Values: 84.0 89.0 132.0 129.0 86.0 83.0 87.0 84.0 87.0 84.0 05:58:38 INFO - PROCESS | 1681 | 05:58:38 INFO - PROCESS | 1681 | [#6] imaging-darkroom Cycles:10 Average:99.90 Median:93.50 stddev:16.69 (17.8%) stddev-sans-first:17.51 05:58:38 INFO - PROCESS | 1681 | Values: 93.0 94.0 94.0 94.0 92.0 93.0 93.0 94.0 106.0 146.0 05:58:38 INFO - PROCESS | 1681 | 05:58:38 INFO - PROCESS | 1681 | [#7] imaging-desaturate Cycles:10 Average:105.40 Median:76.50 stddev:24.95 (32.6%) stddev-sans-first:26.36 05:58:38 INFO - PROCESS | 1681 | Values: 99.0 130.0 132.0 87.0 83.0 82.0 102.0 130.0 71.0 138.0 05:58:38 INFO - PROCESS | 1681 | 05:58:38 INFO - PROCESS | 1681 | [#8] json-parse-financial Cycles:10 Average:57.70 Median:57.50 stddev:6.58 (11.4%) stddev-sans-first:6.97 05:58:38 INFO - PROCESS | 1681 | Values: 59.0 58.0 58.0 57.0 57.0 57.0 57.0 74.0 49.0 51.0 05:58:38 INFO - PROCESS | 1681 | 05:58:38 INFO - PROCESS | 1681 | [#9] json-stringify-tinderbox Cycles:10 Average:71.30 Median:72.50 stddev:4.11 (5.7%) stddev-sans-first:3.67 05:58:38 INFO - PROCESS | 1681 | Values: 65.0 72.0 80.0 68.0 73.0 73.0 70.0 69.0 69.0 74.0 05:58:38 INFO - PROCESS | 1681 | 05:58:38 INFO - PROCESS | 1681 | [#10] stanford-crypto-aes Cycles:10 Average:87.10 Median:86.00 stddev:5.49 (6.4%) stddev-sans-first:5.80 05:58:38 INFO - PROCESS | 1681 | Values: 86.0 86.0 86.0 81.0 86.0 102.0 86.0 86.0 85.0 87.0 05:58:38 INFO - PROCESS | 1681 | 05:58:38 INFO - PROCESS | 1681 | [#11] stanford-crypto-ccm Cycles:10 Average:148.70 Median:149.50 stddev:18.50 (12.4%) stddev-sans-first:17.52 05:58:38 INFO - PROCESS | 1681 | Values: 125.0 157.0 148.0 132.0 149.0 146.0 150.0 135.0 193.0 152.0 05:58:38 INFO - PROCESS | 1681 | 05:58:38 INFO - PROCESS | 1681 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.70 Median:169.00 stddev:17.40 (10.3%) stddev-sans-first:18.34 05:58:38 INFO - PROCESS | 1681 | Values: 168.0 223.0 169.0 169.0 169.0 170.0 169.0 167.0 169.0 164.0 05:58:38 INFO - PROCESS | 1681 | 05:58:38 INFO - PROCESS | 1681 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.00 Median:68.00 stddev:6.32 (9.3%) stddev-sans-first:6.70 05:58:38 INFO - PROCESS | 1681 | Values: 69.0 67.0 67.0 67.0 66.0 67.0 71.0 86.0 75.0 65.0 05:58:38 INFO - PROCESS | 1681 | -------- Summary: end -------- 05:58:38 INFO - PROCESS | 1681 | 05:58:39 INFO - TEST-INFO | 1681: exit 0 05:58:39 INFO - TEST-OK | kraken | took 60256ms 05:58:39 INFO - SUITE-END | took 1177s 05:58:39 INFO - Completed test suite (00:19:37) 05:58:39 INFO - javascript benchmark 05:58:39 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3475.0617333320006, 3509.9298014039737, 3512.3326567952085, 3545.698615617672, 3579.7673151245167, 5101.54086132248, 5417.674939503632, 5760.279965004374, 5819.33077696064, 5954.017587098129, 5853.619514731539, 5870.970645146768, 5977.790777322794, 6031.72857221425, 6037.516998640109, 5229.111051121318, 5271.815486457975, 5322.733863306838, 5346.144616861303, 5432.239486471897, 5425.864353391177, 5462.317210348707, 5487.670739755627, 5488.313960754906, 5493.395726470085, 5017.724025178613, 5197.454267301917, 5232.607554433433, 5238.371395432534, 5340.092184328654, 5292.941411717672, 5298.311219541473, 5300.708461034642, 5317.548008419289, 5319.494648008433, 5258.789648414059, 5283.709395983219, 5283.894322113575, 5286.550643195333, 5377.623566350357, 5800.24596802413, 5842.824715258506, 5872.265966754156, 5917.0, 5918.408159184047, 6101.035369328037, 6238.656873871935, 6240.469560087398, 6251.281102673205, 6256.061590761422, 6158.414950579688, 6195.4424101831055, 6215.87568248637, 6281.057841323838, 6303.0, 4973.925391119136, 6037.1246169305205, 6065.909011364833, 6098.54260930432, 6104.084387341934, 6239.220097487814, 6289.685515724287, 6471.805845824632, 6490.415862572297, 6490.415862572391, 6172.475339596095, 6214.316425193225, 6223.502119830403, 6230.968845155836, 6257.2804127525915, 6277.560570760094, 6291.339409362043, 6291.591046581958, 6300.180976473029, 6347.809565713036, 6144.2319710036245, 6220.502359811204, 6242.2509298883515, 6246.187995560548, 6271.874562508724, 6172.444479996821, 6190.41191086855, 6220.284667263232, 6227.314995350508, 6227.813165605039, 5057.519535644108, 5059.266406371055, 5059.696418214919, 5063.0, 5082.796688132507, 3911.530616326059, 4530.637548996138, 4575.816967321336, 4609.331646911179, 4613.653975951817, 5937.643741375445, 5941.1088336749835, 5994.610350327215, 6000.21997140369, 6019.578629495893, 6272.027835685476, 6273.7176827042895, 6293.622382657055, 6317.147185129948, 6318.083877837687, 5742.684152371576, 5851.824445266649, 5901.380355062743, 5956.702164891738, 6024.246969128859, 5509.0, 5547.2511210986, 5569.55443564522, 5591.217229587861, 5601.719914004283, 6511.837204069936, 6569.014647802772, 6571.408573228432, 6601.3728695773825, 6602.900956485657, 6192.566520343533, 6315.052742088724, 6316.431521163117, 6319.778807741707, 6322.873542529215, 6403.64779937108, 6505.0567667688865, 6508.316626754312, 6577.671116444254, 6591.373819487141, 6180.0, 6181.134641150333, 6216.378362163748, 6233.75064997395, 6249.187605611423, 6167.136600875791, 6225.159603453476, 6287.654179020198, 6302.180716507009, 6305.873882522415, 6047.274327080779, 6182.412670796267, 6182.6599537025895, 6198.6280823150755, 6201.131841542097, 6146.58628515435, 6157.84605384869, 6180.907286390618, 6224.315325314121, 6253.937460625336, 6110.977996086511, 6131.080337949344, 6139.048447490646, 6140.355262697352, 6174.197354343906, 6113.449789518964, 6207.472364849038, 6226.034964580497, 6230.252369715663, 6244.0, 6049.032154855378, 6095.196536865277, 6100.633961962297, 6117.583823141572, 6172.4136207060255], "value": 5812.362068263849, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [511.1642464570426, 525.8659041944306, 527.3697930972487, 567.2710566921505, 567.9659220446777, 30624.234394140156, 34399.65600343999, 38366.0, 44092.33861492072, 46195.53804461954, 45317.0, 45379.319310210376, 45467.77266113673, 45545.54454455454, 45704.0, 8469.280111190525, 9525.0, 9656.179224765869, 9656.324057315991, 9671.806563868719, 8466.238038576526, 11538.538458461651, 11787.528498860078, 11799.587014454495, 11957.521699132025, 11680.532778688885, 11737.706557336049, 11740.41297935104, 11755.235909665844, 11763.882361176407, 8541.786455338604, 9787.412755234709, 11648.767024659503, 11744.647660570154, 11758.0, 11284.717882052932, 11454.541818327258, 11467.19729618927, 11478.655640330804, 11479.368634725086, 41624.0, 42025.0, 42111.947201319905, 42118.0, 42211.155776884596, 3310.9503357449657, 3425.383430982422, 3471.444568868969, 3530.8234588270484, 3622.89131326058, 29342.559861602094, 29509.557356639667, 29679.70320296791, 29899.850500747358, 29908.0, 2721.863906804652, 2736.138116493298, 2744.423671029086, 2766.529689952713, 2824.2939265183704, 476096.0, 478365.0, 478543.9999999965, 478615.0, 479222.0, 62924.37075629277, 63460.0, 63802.6809865957, 63812.68093659595, 63915.04127438092, 37446.812765935996, 37896.621033789306, 37991.62008379936, 67794.66102669554, 67967.32032679609, 17667.38164164248, 17776.9111154446, 17829.554261143316, 17885.28458861657, 17897.910510447364, 12286.877131228752, 12477.939375153032, 13316.267605281802, 13378.46486140563, 13506.797398039038, 20488.487787805425, 20587.8970605149, 20623.793762062487, 20650.483737906674, 20667.379978600668, 7041.683124259421, 7669.734493808459, 7823.0, 8366.736972580698, 8373.246407823324, 921.1709461484718, 1014.3609525998573, 1040.8907064758243, 1058.4707646176912, 1109.2734259060328, 30363.392732145232, 30557.23606909845, 30752.077437676904, 30924.763009479368, 31210.21974450657, 975.3221511049894, 1090.6727981605645, 1124.3366413815725, 1195.7847587434346, 1291.6964513339358, 15751.68496630084, 15806.20968951548, 16028.358865645243, 16141.185405777922, 16301.51095467138, 668058.0, 1000197.0, 1017301.0, 1018774.0, 1020179.0, 63304.0, 63417.0, 64106.35893641097, 64161.0, 64196.03705944415, 1371.8422381426265, 1410.6825964157983, 1503.8420965798653, 1511.380334063051, 1530.9540713778604, 30140.54789178208, 30942.535861961638, 31540.0, 32048.47466778606, 32579.0, 57566.424335756106, 57928.13107803302, 58090.0, 58242.0, 58315.416845831, 549636.0, 557777.0, 565012.0, 565068.0, 565617.0, 24701.50596988086, 25173.24480265595, 26030.869845651407, 27759.0, 28260.71739282663, 45461.54538454573, 45981.0, 46741.53258467372, 46791.766041169576, 47238.055238895715, 31417.842910786214, 34098.829505852314, 37607.43588846115, 38856.0, 39651.20697585974, 37596.0, 37937.86186414412, 38201.0, 38912.832615021594, 38961.805190973864, 37900.81049594734, 38854.0, 40140.38385585578, 40770.776876693744, 42289.365659515744, 27626.861865691346, 34001.0, 34067.0, 35209.82395088008, 35234.11914702153, 24407.38981525405, 25250.116245931305, 25356.366090847878, 25591.104311349012, 26153.0], "value": 20816.090427250518, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [393.8956176613197, 399.2872722190889, 401.4740689696498, 406.090357598978, 425.3810705423609, 19873.0, 20017.299394521193, 20881.477963050933, 21137.47156321093, 21155.365339039814, 11903.702407439796, 12231.694207644814, 17608.735868961976, 20905.895470522628, 20935.68596471054, 5100.438951715309, 5223.033738758332, 5361.490658387447, 5367.597430192732, 5383.353997520303, 3871.993281746752, 4051.149258655686, 5317.0, 5370.248165256867, 7039.6480175991255, 7522.059742532184, 7565.054368203974, 7580.317771400573, 7602.961985190094, 7603.695852165934, 7098.787036388917, 7199.712011519533, 7506.887396689, 7522.210167932343, 7541.849163016709, 7240.891386629205, 7259.092613423322, 7260.092488438945, 7264.891026634605, 7266.600336981464, 25791.742082579123, 26431.20706378812, 27090.0, 29222.85388573065, 29245.122646320644, 2132.296342207068, 2326.406766274606, 2399.5800734871327, 2440.0849681369486, 2465.0632759551436, 15118.773218401733, 15351.385944562204, 15879.285432155466, 16494.42269520561, 16556.66886662272, 1600.2398860541266, 1869.130854152812, 1888.0182305201217, 1949.4638974282045, 1960.137539482623, 93206.0, 124120.0, 124610.0, 125333.0, 125438.11842822457, 16556.83443165577, 18335.633287334178, 19137.23451061942, 20562.38312850587, 21139.365819025454, 29319.0, 34792.82603586966, 35440.11399715028, 35492.0, 35542.11144721351, 10808.621698240524, 11308.604198853001, 11317.320960742381, 11339.546418143347, 11463.484143213574, 7677.500962437423, 9260.689916414607, 9330.673426430043, 9339.766505837408, 9501.049895010581, 7928.0, 9574.856377154349, 9635.036496350449, 9766.706998790047, 9767.413955162712, 2559.3345730110304, 3078.3689343684937, 3277.6558461361215, 3746.6628003479273, 3747.3442147624055, 683.8769021576164, 731.2668974530397, 796.4862663581957, 888.2094935507404, 965.32909627808, 18964.43106706801, 19490.415287541397, 20157.99210039492, 20549.69175462369, 20594.485137871372, 866.7226487524058, 959.1367769007949, 964.5514835601339, 1029.315505189041, 1062.0759938853248, 10415.309729673194, 10491.370517768959, 10661.987111224422, 10707.1434285257, 10769.946150269356, 444818.0, 479954.0, 503371.0, 506695.0, 513869.0, 69806.0, 89903.0, 135608.0, 135673.96489052672, 140411.0, 1014.2595904989399, 1033.7105610428941, 1057.4395570347574, 1066.6426747039673, 1070.0797314309686, 17844.669964776793, 18355.908220458812, 18488.630227395646, 18668.7199692002, 19099.90450047741, 47652.2852157211, 50309.74845125751, 51175.48824511707, 51799.48200517947, 53217.46782532125, 60811.0, 73619.26380736125, 78078.6096069516, 79943.60028199822, 80189.1981080205, 6155.384461553809, 7135.286471353031, 7819.609019549113, 7836.608169591612, 8291.046529648926, 8029.5583742894705, 9975.800483990424, 10966.232363734782, 11244.381559014333, 12309.44607492647, 10849.945750271514, 10857.782844343226, 11044.0, 11167.44162791841, 11337.546498139982, 5021.6735912165595, 9450.149486546245, 10400.375977441377, 10663.680089597325, 11126.332420054823, 4700.905981880412, 10809.270516717288, 11268.661940141808, 11359.091272697999, 11448.42757862087, 6838.2136054352395, 8038.919610803817, 8083.797905052421, 8339.041010283894, 8353.832923341377, 9455.14903658674, 10138.18894488454, 11042.944785276022, 11326.660200194008, 11353.829692554784], "value": 10338.571626200343, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1258.0878862824447, 1611.1380411479856, 1633.591602099475, 1865.5615930256388, 1961.539038325993, 7696.961515192424, 8517.872231916519, 8766.298696104312, 8785.516796576194, 8858.689945851896, 8492.447990880604, 8686.869696954534, 8711.91288087119, 8721.258693011101, 8730.214280714734, 2141.325482473016, 2214.2471559669707, 2216.5788500184995, 2406.8676222807694, 2441.7192022917325, 2196.615592271354, 2379.202967006055, 2469.469064151207, 2475.2945410557995, 2478.157426474998, 2384.7496012918655, 2419.2621250518587, 2427.7693619106158, 2434.537437886796, 2438.1588352018525, 2115.7249557557575, 2393.5212957408503, 2401.6997875265592, 2402.1952645863657, 2406.2059520358325, 2360.3037104054347, 2440.7803297703113, 2445.327534927891, 2446.2538925627678, 2449.289705985262, 8573.228409443118, 8624.008239052464, 8629.568521573896, 8641.395102342838, 8644.438111522732, 5182.922256166161, 5359.437259087778, 5367.5169234769055, 5403.432639572867, 5414.7834086636485, 3430.5711786026745, 3541.94687079694, 3580.7493475456727, 3598.748087633867, 3603.1892824114625, 1034.9586016559329, 1045.5869931377063, 1047.361109723076, 1052.394872948058, 1054.752133248686, 11563.0, 11591.304521728638, 11592.826107608393, 11604.535818567247, 11612.6516204514, 4691.108689349013, 4694.413198350207, 4831.685940413862, 4833.951660483421, 4835.516448355207, 9820.803583928424, 9826.557804898797, 9840.3603765755, 9868.358556693793, 9868.901310986941, 5331.253624492574, 5353.57171426285, 5365.865853353619, 5367.114426119724, 5377.085895397791, 4764.4282686077195, 4838.806447742121, 4924.162892308316, 4928.605711543068, 4973.104841128559, 3811.5616704079384, 3824.541055073409, 3847.788371639587, 3891.280113179071, 3917.5494818095713, 1205.0961778666, 1206.776746301937, 1215.9574414895437, 1216.7627312674122, 1218.9146759726912, 765.2882818978403, 911.968081117171, 912.4434095202055, 928.7213835849218, 977.5454413697664, 5559.249501317351, 5598.496135347838, 5812.099124635688, 5846.0, 5946.405359464019, 458.44070234314086, 465.28578631800025, 467.46942220579206, 972.4894430424084, 1044.498640652491, 3397.779144355609, 3812.961870381316, 3860.208657225262, 3903.590123037097, 3944.3294639911283, 10466.319689220176, 10591.205659575562, 10791.352518848895, 10798.67603971882, 10834.458277086114, 10623.893761062445, 10654.62708805188, 10733.516991735234, 10766.192535559865, 10814.94592527048, 8231.0, 8287.171282871665, 8364.665413383396, 8372.832543349099, 8392.958035209786, 5736.368999410145, 5742.16738572913, 5754.712264386848, 5902.793402230901, 5980.9401905980385, 9705.0, 9998.250131240331, 10232.795344092927, 10233.334833235816, 10287.485625718833, 9025.684101056431, 9146.496942668216, 9906.108450239513, 10169.694909152737, 10306.948465257627, 6650.20197576294, 6847.554908930903, 7081.7167313308955, 7088.539244949268, 7158.642067896689, 8183.895174151413, 8195.303399211134, 8207.917920820715, 8214.507129572245, 8237.46456480327, 7402.9629851850395, 7454.701811927679, 7498.475106742476, 7587.2412758723685, 7616.314531692175, 7177.246389129066, 7319.4144468443465, 7323.890141647773, 7390.076240469942, 7459.701611935679, 6747.966260168668, 7026.683799228945, 7114.715411383487, 7121.181064177686, 7131.144262688511, 4630.83792067276, 4736.952630473651, 4863.294822250683, 4929.704217746947, 5033.521815427529, 4460.955390446184, 4943.77753001123, 5008.524190201925, 5022.773975171199, 5243.737813109406], "value": 4528.210622085054, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [307.4358552056975, 314.976376771742, 319.95360672702463, 322.6257541252148, 326.53142740167846, 4390.385346051556, 4574.382458368119, 5011.22326039464, 5057.418396884359, 5211.400688920775, 4507.887302817423, 4777.355057067295, 5231.136862417697, 5240.423553409122, 5287.947120528803, 3111.937761244774, 3648.5074514940543, 3779.9811000944956, 3933.9016524586827, 4003.5395929468045, 3389.4237979543536, 3493.266414053052, 3547.9001509532127, 3763.9247215055684, 3953.9209215815667, 3378.864845406181, 3623.420252759559, 3873.69010479161, 3931.19410520844, 3937.1731936293268, 3252.251982044143, 3339.3989081965237, 3393.423118069934, 3402.6427225141497, 3802.638749318824, 3076.953835695852, 3080.4147212029866, 3481.930361392783, 3513.5256740339983, 3515.6484351564895, 4940.357753492023, 4950.851474455736, 4955.40535135786, 4979.925301120486, 4997.775100120503, 4348.543402942677, 4539.387182730356, 4539.955810163681, 4551.886202844956, 4583.289590113538, 4817.686850354751, 5312.973435132838, 5403.81145636018, 5412.484504338791, 5429.592780541475, 3152.952705709416, 3856.3444214483607, 3860.9227815443533, 3868.613138686137, 3871.593482684334, 4850.345203397532, 5106.540226613337, 5638.633488823254, 5682.488576028136, 5691.089425691911, 3930.427828868418, 3953.446517487554, 3964.3458829292845, 3980.9402858957137, 3994.6804255659476, 3318.634950155481, 3451.8964431067106, 4035.515738111387, 4039.8788036358956, 4044.1911617676583, 4546.681732278775, 4587.683219973892, 4588.0, 4604.30935359692, 4607.216773148572, 5123.590112791042, 5167.0, 5192.1173400522, 5483.4501956590375, 5487.0, 1152.233764546567, 1167.9416029198505, 1260.7100366915477, 1267.2776517385187, 1313.7766579681477, 788.412632588725, 802.4423025996992, 809.7368355284439, 815.9877601835977, 912.7353067610319, 3891.8443262269193, 4055.3299264165976, 4282.379055037002, 4312.54718254585, 4805.780127314708, 5193.727536753444, 5194.22086687, 5256.290400795843, 5263.315768950012, 5298.602604804655, 3769.754965927206, 4272.5086615039045, 4370.055325380175, 4434.889127771831, 4768.403949506312, 2407.482391285882, 2420.4916967436684, 2425.1390756281617, 2496.7003959524973, 2605.0, 4599.816007359668, 4970.627202959792, 5404.675854415694, 5465.6335916021, 5495.642783219078, 4962.528559786814, 4963.726995015237, 5103.693778373309, 5315.325672413178, 5375.81184658535, 4698.553637404441, 4769.618430525549, 5245.59036626196, 5482.506574408243, 5486.588505862076, 4983.626228032839, 5198.662086964335, 5232.005918875401, 5249.291345668438, 5260.605454590845, 4861.003494283593, 4864.610831133572, 5152.187381337858, 5178.249153872592, 5656.208130861601, 4690.319903614025, 4924.0, 5436.592255580768, 5720.940461433964, 5949.791757288474, 3346.8661253549585, 3373.7301015919156, 3662.3265016537543, 3794.463242386838, 3801.9619803801606, 4370.344448332648, 4801.4958429364415, 5214.504622060898, 5355.30381050461, 5751.913721294268, 4906.975465122651, 5020.644426004885, 5183.377994640668, 5420.241166236651, 5477.233996831575, 4460.085682435158, 4649.697769644962, 5000.974995125001, 5403.540699040625, 5459.235707001102, 4351.933776224845, 4917.508249175054, 4950.900981980269, 4997.8255110048385, 5306.54894333986, 4559.583420786988, 4696.953030469652, 5265.447128051653, 5458.263134476795, 5481.382992017444, 4717.410323709536, 4967.3542439482635, 5366.597505187048, 5395.67625942429, 5444.945550544444], "value": 3844.1096188619913, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [666.7499687617144, 742.5247841381516, 746.0450623202303, 747.7845265358956, 754.3173428047619, 11892.940535297323, 14872.405103795834, 15286.006409583384, 15619.140947247897, 15639.530814075568, 11717.589884354049, 14350.282485875716, 14379.424823007093, 14391.280435978211, 14437.42250309989, 722.2813300765746, 742.5210739073294, 902.6705252582809, 919.7792529792835, 920.089111779337, 881.8633111867671, 906.3881879731188, 907.4918045894287, 914.9542522873863, 915.9679411220609, 898.8202359528087, 910.5811326789685, 973.4694591447643, 974.2887691984855, 975.2393133355994, 753.2279413601048, 934.4066517761271, 963.7253382785873, 963.9325247232697, 966.2608104799833, 715.899774031636, 717.8026042838209, 718.4288490649893, 718.5688586847901, 719.5934297122109, 14732.18972956487, 14749.0, 14771.778423323658, 14773.33519991603, 14817.259137043213, 12157.817632735516, 12159.392030398532, 12336.75326493465, 12367.62897113088, 12432.0, 10869.565217391295, 10887.782244355149, 10892.128629709683, 10940.0, 11374.60188893393, 4029.97985010076, 4032.697547683935, 4036.6568841648495, 4144.316187829005, 4182.53992060873, 76459.0, 77259.8411023835, 77272.84090738643, 77709.0, 78769.60615196945, 9235.076492350845, 9351.39215950961, 9462.384944978554, 9670.081342272473, 9694.660686875926, 20958.266460673804, 20977.475563111046, 21010.684839727415, 21036.368908932756, 21099.578008440054, 7259.600721960237, 7320.377767889682, 7322.890156647654, 7343.63281835906, 7423.838075763382, 3972.1261322509004, 4031.4759081319826, 4038.273110840077, 4038.7778672172726, 4042.514898212233, 3479.443289073736, 3569.464580312974, 3573.3032058748295, 3575.4636804479014, 3585.1395665040723, 563.9266895303584, 647.2233320015905, 658.1641315529251, 672.7140965089817, 676.7403836179418, 466.4239664014939, 507.64211231082, 524.5305451620778, 545.6126150433237, 579.568221674855, 7684.731034413769, 7881.645325960346, 7938.563379014095, 7997.240262175201, 8184.0, 484.382412424162, 569.2912324156451, 574.3337728235227, 600.099850224663, 606.2452246952572, 3710.0, 3726.64596863303, 3748.2878253131817, 3796.6203379662365, 3944.6055394460323, 87784.0, 90307.0, 90979.0, 91016.544917275, 91863.0, 74372.0, 76120.0, 77365.0, 78377.0405739861, 81601.59199203966, 54243.72878135584, 70133.64933175403, 70312.6484367585, 70558.29441705518, 71341.28658713347, 7245.637718114179, 7255.347018768336, 7445.92554074474, 7456.813579660552, 7562.810929726801, 42553.361699573914, 43457.0, 43789.786812097176, 45459.0, 45588.7720561395, 54879.981601012325, 62525.0, 62719.0, 62804.42988925314, 62901.37098629138, 9315.39449935752, 9708.029197080517, 9903.603855845973, 10000.04999525044, 10043.196544276587, 10402.0, 10502.212334074822, 10637.042666160083, 10656.0, 10681.19891008193, 8301.58492075406, 10088.0, 10179.796404072025, 10366.688999330032, 10404.219683523615, 10009.0, 10021.799564008534, 10041.648542300984, 10277.023682750127, 10374.066334029974, 9920.305578609717, 9952.154066904393, 10029.29794914349, 10200.591976320864, 10282.383057016603, 8349.749507514784, 8519.914800851911, 8704.564771761514, 8739.91260087391, 8788.0, 8294.543800091053, 8457.238848503664, 8530.616122274636, 8663.91336086631, 8675.826483470422], "value": 6637.904684309283, "unit": "score"}], "name": "dromaeo_css", "value": 7244.409517591313, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 106.0, 114.0, 117.0, 163.0, 162.0, 112.0, 112.0, 113.0, 112.0], "value": 122.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 120.0, 145.0, 163.0, 122.0, 153.0, 158.0, 141.0, 166.0, 119.0], "value": 143.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [186.0, 187.0, 185.0, 184.0, 184.0, 183.0, 182.0, 185.0, 179.0, 184.0], "value": 183.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 73.0, 58.0, 106.0, 58.0, 60.0, 57.0, 58.0, 114.0, 55.0], "value": 72.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 100.0, 99.0, 80.0, 76.0, 77.0, 103.0, 80.0, 79.0, 100.0], "value": 88.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 89.0, 132.0, 129.0, 86.0, 83.0, 87.0, 84.0, 87.0, 84.0], "value": 94.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 94.0, 94.0, 94.0, 92.0, 93.0, 93.0, 94.0, 106.0, 146.0], "value": 99.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 130.0, 132.0, 87.0, 83.0, 82.0, 102.0, 130.0, 71.0, 138.0], "value": 105.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 58.0, 58.0, 57.0, 57.0, 57.0, 57.0, 74.0, 49.0, 51.0], "value": 57.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 72.0, 80.0, 68.0, 73.0, 73.0, 70.0, 69.0, 69.0, 74.0], "value": 71.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 86.0, 81.0, 86.0, 102.0, 86.0, 86.0, 85.0, 87.0], "value": 87.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [125.0, 157.0, 148.0, 132.0, 149.0, 146.0, 150.0, 135.0, 193.0, 152.0], "value": 148.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 223.0, 169.0, 169.0, 169.0, 170.0, 169.0, 167.0, 169.0, 164.0], "value": 173.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 67.0, 67.0, 67.0, 66.0, 67.0, 71.0, 86.0, 75.0, 65.0], "value": 70.0, "unit": "score"}], "name": "kraken", "value": 1519.2, "alertThreshold": 2.0}]} 05:58:39 INFO - Return code: 0 05:58:39 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 05:58:39 ERROR - # TBPL SUCCESS # 05:58:39 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:58:39 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:58:39 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:58:39 INFO - 2016-05-06 05:58:39.982 screenresolution[1685:9879] starting screenresolution argv=screenresolution get 05:58:39 INFO - 2016-05-06 05:58:39.984 screenresolution[1685:9879] Display 0: 1600x1200x32@60 05:58:39 INFO - 2016-05-06 05:58:39.990 screenresolution[1686:9882] starting screenresolution argv=screenresolution list 05:58:39 INFO - Available Modes on Display 0 05:58:39 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:58:39 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:58:39 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:58:39 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:58:40 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:58:40 INFO - Intel Iris: 05:58:40 INFO - Chipset Model: Intel Iris 05:58:40 INFO - Type: GPU 05:58:40 INFO - Bus: Built-In 05:58:40 INFO - VRAM (Dynamic, Max): 1536 MB 05:58:40 INFO - Vendor: Intel (0x8086) 05:58:40 INFO - Device ID: 0x0a2e 05:58:40 INFO - Revision ID: 0x0009 05:58:40 INFO - Displays: 05:58:40 INFO - Display: 05:58:40 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:58:40 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:58:40 INFO - Display Serial Number: 1600x1200 60 05:58:40 INFO - Main Display: Yes 05:58:40 INFO - Mirror: Off 05:58:40 INFO - Online: Yes 05:58:40 INFO - Rotation: Supported 05:58:40 INFO - Return code: 0 05:58:40 INFO - Running post-action listener: _resource_record_post_action 05:58:40 INFO - Running post-run listener: _resource_record_post_run 05:58:41 INFO - Total resource usage - Wall time: 1213s; CPU: 54.0%; Read bytes: 32583168; Write bytes: 696331264; Read time: 321; Write time: 1962 05:58:41 INFO - install - Wall time: 35s; CPU: 54.0%; Read bytes: 386337280; Write bytes: 378029568; Read time: 29190; Write time: 706 05:58:41 INFO - run-tests - Wall time: 1179s; CPU: 54.0%; Read bytes: 30817792; Write bytes: 296732160; Read time: 304; Write time: 1186 05:58:41 INFO - Running post-run listener: _upload_blobber_files 05:58:41 INFO - Blob upload gear active. 05:58:41 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:58:41 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 05:58:41 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', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:58:41 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 Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:58:41 INFO - (blobuploader) - INFO - Open directory for files ... 05:58:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:58:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:58:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:58:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:58:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:58:42 INFO - (blobuploader) - INFO - Done attempting. 05:58:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:58:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:58:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:58:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:58:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:58:43 INFO - (blobuploader) - INFO - Done attempting. 05:58:43 INFO - (blobuploader) - INFO - Iteration through files over. 05:58:43 INFO - Return code: 0 05:58:43 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:58:43 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:58:43 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/126419131836d1cc60011ce4d79b9bd0619bd5c756ba193696ce36c1cacf7ac2e339517cea5e17cd900eabe17a2d056b20541b66333362601b7b95a8b30ece72", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/45abb7756f2026e2948960a6c13384751c03408df4024df241bd4b09d9659f56ee287d43df8de9ab06b11bc196d78da3c2f5ce84b77c29f099afa8712709f9ad"} 05:58:43 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:58:43 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:58:43 INFO - Contents: 05:58:43 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/126419131836d1cc60011ce4d79b9bd0619bd5c756ba193696ce36c1cacf7ac2e339517cea5e17cd900eabe17a2d056b20541b66333362601b7b95a8b30ece72", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/45abb7756f2026e2948960a6c13384751c03408df4024df241bd4b09d9659f56ee287d43df8de9ab06b11bc196d78da3c2f5ce84b77c29f099afa8712709f9ad"} 05:58:43 INFO - Running post-run listener: copy_logs_to_upload_dir 05:58:43 INFO - Copying logs to upload dir... 05:58:43 INFO - mkdir: /builds/slave/test/build/upload/logs 05:58:43 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1270.270358 ========= master_lag: 0.07 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2016-05-06 05:58:43.970774) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-06 05:58:43.975713) ========= 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.UVPBUXOF0G/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.jIyRGdoMhQ/Listeners TMPDIR=/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/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/Firefox/sha512/126419131836d1cc60011ce4d79b9bd0619bd5c756ba193696ce36c1cacf7ac2e339517cea5e17cd900eabe17a2d056b20541b66333362601b7b95a8b30ece72", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/45abb7756f2026e2948960a6c13384751c03408df4024df241bd4b09d9659f56ee287d43df8de9ab06b11bc196d78da3c2f5ce84b77c29f099afa8712709f9ad"} build_url:https://queue.taskcluster.net/v1/task/J1UwYIA1RWS5SSpRKUkQVw/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010298 build_url: 'https://queue.taskcluster.net/v1/task/J1UwYIA1RWS5SSpRKUkQVw/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/126419131836d1cc60011ce4d79b9bd0619bd5c756ba193696ce36c1cacf7ac2e339517cea5e17cd900eabe17a2d056b20541b66333362601b7b95a8b30ece72", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/45abb7756f2026e2948960a6c13384751c03408df4024df241bd4b09d9659f56ee287d43df8de9ab06b11bc196d78da3c2f5ce84b77c29f099afa8712709f9ad"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-06 05:58:44.004543) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 05:58:44.004835) ========= 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.UVPBUXOF0G/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.jIyRGdoMhQ/Listeners TMPDIR=/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/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.005012 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 05:58:44.053744) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-06 05:58:44.054018) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-06 05:58:44.054287) ========= ========= Total master_lag: 0.19 =========