builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0054 starttime: 1464801283.79 results: success (0) buildid: 20160601074355 builduid: 777c364a476b45709ad9f4592603f59d revision: bb81bf646c3d92abb37eb6b5b5498cd2dab9175f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-01 10:14:43.787216) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-01 10:14:43.787604) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-01 10:14:43.787889) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-01 10:14:43.814412) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-01 10:14:43.814766) ========= 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.M0J35WJCyP/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.jyQSIvpA7G/Listeners TMPDIR=/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-06-01 10:14:43-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 133M=0s 2016-06-01 10:14:43 (133 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.125736 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-01 10:14:43.960618) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-01 10:14:43.960944) ========= 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.M0J35WJCyP/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.jyQSIvpA7G/Listeners TMPDIR=/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/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.028235 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-01 10:14:44.009556) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-01 10:14:44.009930) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev bb81bf646c3d92abb37eb6b5b5498cd2dab9175f --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev bb81bf646c3d92abb37eb6b5b5498cd2dab9175f --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.M0J35WJCyP/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.jyQSIvpA7G/Listeners TMPDIR=/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-06-01 10:14:44,086 truncating revision to first 12 chars 2016-06-01 10:14:44,087 Setting DEBUG logging. 2016-06-01 10:14:44,087 attempt 1/10 2016-06-01 10:14:44,087 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/bb81bf646c3d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-01 10:14:45,119 unpacking tar archive at: mozilla-aurora-bb81bf646c3d/testing/mozharness/ program finished with exit code 0 elapsedTime=1.292051 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-01 10:14:45.321915) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-01 10:14:45.322234) ========= script_repo_revision: bb81bf646c3d92abb37eb6b5b5498cd2dab9175f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-01 10:14:45.322611) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-01 10:14:45.322889) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-01 10:14:45.339459) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2016-06-01 10:14:45.339802) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.M0J35WJCyP/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.jyQSIvpA7G/Listeners TMPDIR=/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/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 10:14:45 INFO - MultiFileLogger online at 20160601 10:14:45 in /builds/slave/test 10:14:45 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 10:14:45 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:14:45 INFO - {'append_to_log': False, 10:14:45 INFO - 'base_work_dir': '/builds/slave/test', 10:14:45 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 10:14:45 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:14:45 INFO - 'branch': 'Mozilla-Aurora', 10:14:45 INFO - 'buildbot_json_path': 'buildprops.json', 10:14:45 INFO - 'config_files': ('talos/mac_config.py',), 10:14:45 INFO - 'default_actions': ('clobber', 10:14:45 INFO - 'read-buildbot-config', 10:14:45 INFO - 'download-and-extract', 10:14:45 INFO - 'populate-webroot', 10:14:45 INFO - 'create-virtualenv', 10:14:45 INFO - 'install', 10:14:45 INFO - 'run-tests'), 10:14:45 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:14:45 INFO - 'download_minidump_stackwalk': True, 10:14:45 INFO - 'download_symbols': 'ondemand', 10:14:45 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:14:45 INFO - 'tooltool.py': '/tools/tooltool.py', 10:14:45 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:14:45 INFO - '/tools/misc-python/virtualenv.py')}, 10:14:45 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:14:45 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:14:45 INFO - 'installer_path': 'installer.exe', 10:14:45 INFO - 'log_level': 'info', 10:14:45 INFO - 'log_name': 'talos', 10:14:45 INFO - 'log_to_console': True, 10:14:45 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 10:14:45 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 10:14:45 INFO - 'opt_config_files': (), 10:14:45 INFO - 'pip_index': False, 10:14:45 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:14:45 INFO - 'cmd': ('bash', 10:14:45 INFO - '-c', 10:14:45 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:14:45 INFO - 'enabled': True, 10:14:45 INFO - 'halt_on_failure': False, 10:14:45 INFO - 'name': 'check_screen_resolution'},), 10:14:45 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:14:45 INFO - 'cmd': ('bash', 10:14:45 INFO - '-c', 10:14:45 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:14:45 INFO - 'enabled': True, 10:14:45 INFO - 'halt_on_failure': False, 10:14:45 INFO - 'name': 'check_screen_resolution'},), 10:14:45 INFO - 'run_cmd_checks_enabled': True, 10:14:45 INFO - 'sps_profile': False, 10:14:45 INFO - 'sps_profile_interval': 0, 10:14:45 INFO - 'suite': 'dromaeojs', 10:14:45 INFO - 'system_bits': '32', 10:14:45 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:14:45 INFO - 'title': 't-yosemite-r7-0054', 10:14:45 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:14:45 INFO - 'use_talos_json': True, 10:14:45 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:14:45 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:14:45 INFO - 'work_dir': 'build'} 10:14:45 INFO - ##### 10:14:45 INFO - ##### Running clobber step. 10:14:45 INFO - ##### 10:14:45 INFO - Running pre-action listener: _resource_record_pre_action 10:14:45 INFO - Running main action method: clobber 10:14:45 INFO - rmtree: /builds/slave/test/build 10:14:45 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:14:47 INFO - Running post-action listener: _resource_record_post_action 10:14:47 INFO - ##### 10:14:47 INFO - ##### Running read-buildbot-config step. 10:14:47 INFO - ##### 10:14:47 INFO - Running pre-action listener: _resource_record_pre_action 10:14:47 INFO - Running main action method: read_buildbot_config 10:14:47 INFO - Using buildbot properties: 10:14:47 INFO - { 10:14:47 INFO - "project": "", 10:14:47 INFO - "product": "firefox", 10:14:47 INFO - "script_repo_revision": "production", 10:14:47 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 10:14:47 INFO - "repository": "", 10:14:47 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 10:14:47 INFO - "buildid": "20160601074355", 10:14:47 INFO - "pgo_build": "False", 10:14:47 INFO - "basedir": "/builds/slave/test", 10:14:47 INFO - "buildnumber": 367, 10:14:47 INFO - "slavename": "t-yosemite-r7-0054", 10:14:47 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 10:14:47 INFO - "platform": "yosemite_r7", 10:14:47 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 10:14:47 INFO - "branch": "mozilla-aurora", 10:14:47 INFO - "repo_path": "releases/mozilla-aurora", 10:14:47 INFO - "revision": "bb81bf646c3d92abb37eb6b5b5498cd2dab9175f", 10:14:47 INFO - "stage_platform": "macosx64", 10:14:47 INFO - "builduid": "777c364a476b45709ad9f4592603f59d", 10:14:47 INFO - "slavebuilddir": "test" 10:14:47 INFO - } 10:14:47 INFO - Found installer url https://queue.taskcluster.net/v1/task/S_XAoOD-RwCQDHOoKK9imA/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg. 10:14:47 INFO - Running post-action listener: _resource_record_post_action 10:14:47 INFO - ##### 10:14:47 INFO - ##### Running download-and-extract step. 10:14:47 INFO - ##### 10:14:47 INFO - Running pre-action listener: _resource_record_pre_action 10:14:47 INFO - Running main action method: download_and_extract 10:14:47 INFO - mkdir: /builds/slave/test/build/tests 10:14: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')]} 10:14:47 INFO - https://queue.taskcluster.net/v1/task/S_XAoOD-RwCQDHOoKK9imA/artifacts/public/build/firefox-48.0a2.en-US.mac.test_packages.json matches https://queue.taskcluster.net 10:14:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S_XAoOD-RwCQDHOoKK9imA/artifacts/public/build/firefox-48.0a2.en-US.mac.test_packages.json 10:14:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S_XAoOD-RwCQDHOoKK9imA/artifacts/public/build/firefox-48.0a2.en-US.mac.test_packages.json 10:14:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S_XAoOD-RwCQDHOoKK9imA/artifacts/public/build/firefox-48.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-48.0a2.en-US.mac.test_packages.json 10:14:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S_XAoOD-RwCQDHOoKK9imA/artifacts/public/build/firefox-48.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a2.en-US.mac.test_packages.json'}, attempt #1 10:14:48 INFO - Downloaded 1199 bytes. 10:14:48 INFO - Reading from file /builds/slave/test/build/firefox-48.0a2.en-US.mac.test_packages.json 10:14:48 INFO - Using the following test package requirements: 10:14:48 INFO - {u'common': [u'firefox-48.0a2.en-US.mac.common.tests.zip'], 10:14:48 INFO - u'cppunittest': [u'firefox-48.0a2.en-US.mac.common.tests.zip', 10:14:48 INFO - u'firefox-48.0a2.en-US.mac.cppunittest.tests.zip'], 10:14:48 INFO - u'gtest': [u'firefox-48.0a2.en-US.mac.common.tests.zip', 10:14:48 INFO - u'firefox-48.0a2.en-US.mac.gtest.tests.zip'], 10:14:48 INFO - u'jittest': [u'firefox-48.0a2.en-US.mac.common.tests.zip', 10:14:48 INFO - u'jsshell-mac.zip'], 10:14:48 INFO - u'mochitest': [u'firefox-48.0a2.en-US.mac.common.tests.zip', 10:14:48 INFO - u'firefox-48.0a2.en-US.mac.mochitest.tests.zip'], 10:14:48 INFO - u'mozbase': [u'firefox-48.0a2.en-US.mac.common.tests.zip'], 10:14:48 INFO - u'reftest': [u'firefox-48.0a2.en-US.mac.common.tests.zip', 10:14:48 INFO - u'firefox-48.0a2.en-US.mac.reftest.tests.zip'], 10:14:48 INFO - u'talos': [u'firefox-48.0a2.en-US.mac.common.tests.zip', 10:14:48 INFO - u'firefox-48.0a2.en-US.mac.talos.tests.zip'], 10:14:48 INFO - u'web-platform': [u'firefox-48.0a2.en-US.mac.common.tests.zip', 10:14:48 INFO - u'firefox-48.0a2.en-US.mac.web-platform.tests.zip'], 10:14:48 INFO - u'xpcshell': [u'firefox-48.0a2.en-US.mac.common.tests.zip', 10:14:48 INFO - u'firefox-48.0a2.en-US.mac.xpcshell.tests.zip']} 10:14:48 INFO - Downloading packages: [u'firefox-48.0a2.en-US.mac.common.tests.zip'] for test suite category: common 10:14:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:14:48 INFO - https://queue.taskcluster.net/v1/task/S_XAoOD-RwCQDHOoKK9imA/artifacts/public/build/firefox-48.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 10:14:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S_XAoOD-RwCQDHOoKK9imA/artifacts/public/build/firefox-48.0a2.en-US.mac.common.tests.zip 10:14:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S_XAoOD-RwCQDHOoKK9imA/artifacts/public/build/firefox-48.0a2.en-US.mac.common.tests.zip 10:14:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S_XAoOD-RwCQDHOoKK9imA/artifacts/public/build/firefox-48.0a2.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.mac.common.tests.zip 10:14:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S_XAoOD-RwCQDHOoKK9imA/artifacts/public/build/firefox-48.0a2.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.mac.common.tests.zip'}, attempt #1 10:14:50 INFO - Downloaded 18463829 bytes. 10:14:50 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:14:50 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 10:14:53 INFO - Return code: 0 10:14:53 INFO - Downloading packages: [u'firefox-48.0a2.en-US.mac.common.tests.zip', u'firefox-48.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 10:14:53 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')]} 10:14:53 INFO - https://queue.taskcluster.net/v1/task/S_XAoOD-RwCQDHOoKK9imA/artifacts/public/build/firefox-48.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 10:14:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S_XAoOD-RwCQDHOoKK9imA/artifacts/public/build/firefox-48.0a2.en-US.mac.common.tests.zip 10:14:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S_XAoOD-RwCQDHOoKK9imA/artifacts/public/build/firefox-48.0a2.en-US.mac.common.tests.zip 10:14:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S_XAoOD-RwCQDHOoKK9imA/artifacts/public/build/firefox-48.0a2.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.mac.common.tests.zip 10:14:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S_XAoOD-RwCQDHOoKK9imA/artifacts/public/build/firefox-48.0a2.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.mac.common.tests.zip'}, attempt #1 10:14:54 INFO - Downloaded 18463829 bytes. 10:14:54 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:14:54 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 10:14:58 INFO - Return code: 0 10:14:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:14:58 INFO - https://queue.taskcluster.net/v1/task/S_XAoOD-RwCQDHOoKK9imA/artifacts/public/build/firefox-48.0a2.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 10:14:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S_XAoOD-RwCQDHOoKK9imA/artifacts/public/build/firefox-48.0a2.en-US.mac.talos.tests.zip 10:14:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S_XAoOD-RwCQDHOoKK9imA/artifacts/public/build/firefox-48.0a2.en-US.mac.talos.tests.zip 10:14:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S_XAoOD-RwCQDHOoKK9imA/artifacts/public/build/firefox-48.0a2.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.mac.talos.tests.zip 10:14:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S_XAoOD-RwCQDHOoKK9imA/artifacts/public/build/firefox-48.0a2.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.mac.talos.tests.zip'}, attempt #1 10:14:59 INFO - Downloaded 10840145 bytes. 10:14:59 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:14:59 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 10:14:59 INFO - Return code: 0 10:14:59 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')]} 10:14:59 INFO - https://queue.taskcluster.net/v1/task/S_XAoOD-RwCQDHOoKK9imA/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg matches https://queue.taskcluster.net 10:14:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S_XAoOD-RwCQDHOoKK9imA/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg 10:14:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S_XAoOD-RwCQDHOoKK9imA/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg 10:14:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S_XAoOD-RwCQDHOoKK9imA/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0a2.en-US.mac.dmg 10:14:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S_XAoOD-RwCQDHOoKK9imA/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-48.0a2.en-US.mac.dmg'}, attempt #1 10:15:02 INFO - Downloaded 114161797 bytes. 10:15:02 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/S_XAoOD-RwCQDHOoKK9imA/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg 10:15:02 INFO - mkdir: /builds/slave/test/properties 10:15:02 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:15:02 INFO - Writing to file /builds/slave/test/properties/build_url 10:15:02 INFO - Contents: 10:15:02 INFO - build_url:https://queue.taskcluster.net/v1/task/S_XAoOD-RwCQDHOoKK9imA/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg 10:15:03 INFO - Running post-action listener: _resource_record_post_action 10:15:03 INFO - Running post-action listener: set_extra_try_arguments 10:15:03 INFO - ##### 10:15:03 INFO - ##### Running populate-webroot step. 10:15:03 INFO - ##### 10:15:03 INFO - Running pre-action listener: _resource_record_pre_action 10:15:03 INFO - Running main action method: populate_webroot 10:15:03 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:15:03 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:15:03 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:15:03 INFO - '--tppagecycles', 10:15:03 INFO - '7'], 10:15:03 INFO - 'tests': ['tsvgm']}}, 10:15:03 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:15:03 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:15:03 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:15:03 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:15:03 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:15:03 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:15:03 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:15:03 INFO - 'talos_options': ['--disable-e10s'], 10:15:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:15:03 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:15:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:15:03 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:15:03 INFO - 'talos_options': ['--disable-e10s'], 10:15:03 INFO - 'tests': ['damp', 'tps']}, 10:15:03 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:15:03 INFO - 'tests': ['damp', 'tps']}, 10:15:03 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:15:03 INFO - 'tests': ['dromaeo_dom']}, 10:15:03 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:15:03 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:15:03 INFO - 'tests': ['a11yr', 10:15:03 INFO - 'ts_paint', 10:15:03 INFO - 'tpaint', 10:15:03 INFO - 'sessionrestore', 10:15:03 INFO - 'sessionrestore_no_auto_restore', 10:15:03 INFO - 'tabpaint']}, 10:15:03 INFO - 'other-e10s': {'tests': ['a11yr', 10:15:03 INFO - 'ts_paint', 10:15:03 INFO - 'tpaint', 10:15:03 INFO - 'sessionrestore', 10:15:03 INFO - 'sessionrestore_no_auto_restore', 10:15:03 INFO - 'tabpaint']}, 10:15:03 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:15:03 INFO - 'ts_paint', 10:15:03 INFO - 'tpaint', 10:15:03 INFO - 'sessionrestore', 10:15:03 INFO - 'sessionrestore_no_auto_restore', 10:15:03 INFO - 'tabpaint']}, 10:15:03 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:15:03 INFO - 'ts_paint', 10:15:03 INFO - 'tpaint', 10:15:03 INFO - 'sessionrestore', 10:15:03 INFO - 'sessionrestore_no_auto_restore', 10:15:03 INFO - 'tabpaint']}, 10:15:03 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:15:03 INFO - 'tests': ['a11yr', 10:15:03 INFO - 'ts_paint', 10:15:03 INFO - 'tpaint', 10:15:03 INFO - 'sessionrestore', 10:15:03 INFO - 'sessionrestore_no_auto_restore', 10:15:03 INFO - 'tabpaint']}, 10:15:03 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:15:03 INFO - 'tests': ['a11yr', 10:15:03 INFO - 'ts_paint', 10:15:03 INFO - 'tpaint', 10:15:03 INFO - 'sessionrestore', 10:15:03 INFO - 'sessionrestore_no_auto_restore', 10:15:03 INFO - 'tabpaint']}, 10:15:03 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:15:03 INFO - 'tests': ['tsvgx', 10:15:03 INFO - 'tsvgr_opacity', 10:15:03 INFO - 'tart', 10:15:03 INFO - 'tscrollx', 10:15:03 INFO - 'cart']}, 10:15:03 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:15:03 INFO - 'tsvgr_opacity', 10:15:03 INFO - 'tart', 10:15:03 INFO - 'tscrollx', 10:15:03 INFO - 'cart']}, 10:15:03 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:15:03 INFO - 'talos_options': ['--disable-e10s'], 10:15:03 INFO - 'tests': ['tp5o']}, 10:15:03 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:15:03 INFO - 'tests': ['tp5o']}, 10:15:03 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:15:03 INFO - 'talos_options': ['--disable-e10s', 10:15:03 INFO - '--xperf_path', 10:15:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:15:03 INFO - 'tests': ['tp5n']}, 10:15:03 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:15:03 INFO - 'talos_options': ['--xperf_path', 10:15:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:15:03 INFO - 'tests': ['tp5n']}}, 10:15:03 INFO - 'talos.zip': {'path': '', 10:15:03 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:15:03 INFO - Running post-action listener: _resource_record_post_action 10:15:03 INFO - ##### 10:15:03 INFO - ##### Running create-virtualenv step. 10:15:03 INFO - ##### 10:15:03 INFO - Running pre-action listener: _resource_record_pre_action 10:15:03 INFO - Running main action method: create_virtualenv 10:15:03 INFO - Creating virtualenv /builds/slave/test/build/venv 10:15:03 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 10:15:03 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:15:03 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:15:03 INFO - Using real prefix '/tools/python27' 10:15:03 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:15:04 INFO - Installing distribute.............................................................................................................................................................................................done. 10:15:07 INFO - Installing pip.................done. 10:15:07 INFO - Return code: 0 10:15:07 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:15:07 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')]} 10:15:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:15:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:15:07 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')]} 10:15:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:15:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:15:07 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 0x106a3da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106a4d420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc090c94f50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1068dce00>, '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 0x106745db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1068d7b20>, '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.M0J35WJCyP/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.jyQSIvpA7G/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/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 10:15:07 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 10:15:07 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 10:15:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.M0J35WJCyP/Render', 10:15:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:15:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:15:07 INFO - 'HOME': '/Users/cltbld', 10:15:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:15:07 INFO - 'LOGNAME': 'cltbld', 10:15:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:15:07 INFO - 'MOZ_NO_REMOTE': '1', 10:15:07 INFO - 'NO_EM_RESTART': '1', 10:15:07 INFO - 'PAGER': '/bin/cat', 10:15:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:15:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:15:07 INFO - 'PWD': '/builds/slave/test', 10:15:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:15:07 INFO - 'SHELL': '/bin/bash', 10:15:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jyQSIvpA7G/Listeners', 10:15:07 INFO - 'TMPDIR': '/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/', 10:15:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:15:07 INFO - 'USER': 'cltbld', 10:15:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:15:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:15:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:15:07 INFO - 'XPC_FLAGS': '0x0', 10:15:07 INFO - 'XPC_SERVICE_NAME': '0', 10:15:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:15:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:15:07 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 10:15:07 INFO - Cleaning up... 10:15:07 INFO - Return code: 0 10:15:07 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 10:15:07 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')]} 10:15:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:15:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:15:07 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')]} 10:15:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:15:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:15:07 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 0x106a3da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106a4d420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc090c94f50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1068dce00>, '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 0x106745db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1068d7b20>, '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.M0J35WJCyP/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.jyQSIvpA7G/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/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 10:15:07 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 10:15:07 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 10:15:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.M0J35WJCyP/Render', 10:15:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:15:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:15:07 INFO - 'HOME': '/Users/cltbld', 10:15:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:15:07 INFO - 'LOGNAME': 'cltbld', 10:15:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:15:07 INFO - 'MOZ_NO_REMOTE': '1', 10:15:07 INFO - 'NO_EM_RESTART': '1', 10:15:07 INFO - 'PAGER': '/bin/cat', 10:15:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:15:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:15:07 INFO - 'PWD': '/builds/slave/test', 10:15:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:15:07 INFO - 'SHELL': '/bin/bash', 10:15:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jyQSIvpA7G/Listeners', 10:15:07 INFO - 'TMPDIR': '/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/', 10:15:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:15:07 INFO - 'USER': 'cltbld', 10:15:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:15:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:15:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:15:07 INFO - 'XPC_FLAGS': '0x0', 10:15:07 INFO - 'XPC_SERVICE_NAME': '0', 10:15:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:15:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:15:08 INFO - Downloading/unpacking psutil>=0.7.1 10:15:08 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 10:15:08 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 10:15:08 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 10:15:08 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 10:15:08 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 10:15:08 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 10:15:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:15:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:15:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:15:11 INFO - Installing collected packages: psutil 10:15:11 INFO - Running setup.py install for psutil 10:15:11 INFO - building 'psutil._psutil_osx' extension 10:15:11 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 10:15:11 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 10:15:11 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 10:15:11 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 10:15:12 INFO - building 'psutil._psutil_posix' extension 10:15:12 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 10:15:12 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 10:15:12 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 10:15:12 INFO - ^ 10:15:12 INFO - 1 warning generated. 10:15:12 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 10:15:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:15:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:15:12 INFO - Successfully installed psutil 10:15:12 INFO - Cleaning up... 10:15:12 INFO - Return code: 0 10:15:12 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 10:15:12 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')]} 10:15:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:15:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:15:12 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')]} 10:15:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:15:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:15:12 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 0x106a3da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106a4d420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc090c94f50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1068dce00>, '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 0x106745db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1068d7b20>, '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.M0J35WJCyP/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.jyQSIvpA7G/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/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 10:15:12 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 10:15:12 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 10:15:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.M0J35WJCyP/Render', 10:15:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:15:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:15:12 INFO - 'HOME': '/Users/cltbld', 10:15:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:15:12 INFO - 'LOGNAME': 'cltbld', 10:15:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:15:12 INFO - 'MOZ_NO_REMOTE': '1', 10:15:12 INFO - 'NO_EM_RESTART': '1', 10:15:12 INFO - 'PAGER': '/bin/cat', 10:15:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:15:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:15:12 INFO - 'PWD': '/builds/slave/test', 10:15:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:15:12 INFO - 'SHELL': '/bin/bash', 10:15:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jyQSIvpA7G/Listeners', 10:15:12 INFO - 'TMPDIR': '/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/', 10:15:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:15:12 INFO - 'USER': 'cltbld', 10:15:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:15:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:15:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:15:12 INFO - 'XPC_FLAGS': '0x0', 10:15:12 INFO - 'XPC_SERVICE_NAME': '0', 10:15:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:15:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:15:12 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 10:15:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:15:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:15:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:15:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:15:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:15:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:15:15 INFO - Downloading mozsystemmonitor-0.0.tar.gz 10:15:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:15:15 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 10:15:15 INFO - Installing collected packages: mozsystemmonitor 10:15:15 INFO - Running setup.py install for mozsystemmonitor 10:15:15 INFO - Successfully installed mozsystemmonitor 10:15:15 INFO - Cleaning up... 10:15:15 INFO - Return code: 0 10:15:15 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:15:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:15:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:15:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:15:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:15:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:15:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:15:15 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 0x106a3da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106a4d420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc090c94f50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1068dce00>, '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 0x106745db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1068d7b20>, '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.M0J35WJCyP/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.jyQSIvpA7G/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/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 10:15:15 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 10:15:15 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 10:15:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.M0J35WJCyP/Render', 10:15:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:15:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:15:15 INFO - 'HOME': '/Users/cltbld', 10:15:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:15:15 INFO - 'LOGNAME': 'cltbld', 10:15:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:15:15 INFO - 'MOZ_NO_REMOTE': '1', 10:15:15 INFO - 'NO_EM_RESTART': '1', 10:15:15 INFO - 'PAGER': '/bin/cat', 10:15:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:15:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:15:15 INFO - 'PWD': '/builds/slave/test', 10:15:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:15:15 INFO - 'SHELL': '/bin/bash', 10:15:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jyQSIvpA7G/Listeners', 10:15:15 INFO - 'TMPDIR': '/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/', 10:15:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:15:15 INFO - 'USER': 'cltbld', 10:15:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:15:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:15:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:15:15 INFO - 'XPC_FLAGS': '0x0', 10:15:15 INFO - 'XPC_SERVICE_NAME': '0', 10:15:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:15:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:15:15 INFO - Downloading/unpacking blobuploader==1.2.4 10:15: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 10:15: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 10:15: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 10:15: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 10:15: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 10:15: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 10:15:18 INFO - Downloading blobuploader-1.2.4.tar.gz 10:15:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:15:18 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:15: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 10:15: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 10:15: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 10:15: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 10:15: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 10:15: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 10:15:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:15:18 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:15: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 10:15: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 10:15: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 10:15: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 10:15: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 10:15: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 10:15:19 INFO - Downloading docopt-0.6.1.tar.gz 10:15:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:15:19 INFO - Installing collected packages: blobuploader, requests, docopt 10:15:19 INFO - Running setup.py install for blobuploader 10:15:19 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:15:19 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:15:19 INFO - Running setup.py install for requests 10:15:20 INFO - Running setup.py install for docopt 10:15:20 INFO - Successfully installed blobuploader requests docopt 10:15:20 INFO - Cleaning up... 10:15:20 INFO - Return code: 0 10:15:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:15:20 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')]} 10:15:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:15:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:15:20 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')]} 10:15:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:15:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:15:20 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 0x106a3da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106a4d420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc090c94f50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1068dce00>, '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 0x106745db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1068d7b20>, '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.M0J35WJCyP/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.jyQSIvpA7G/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/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 10:15:20 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 10:15:20 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 10:15:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.M0J35WJCyP/Render', 10:15:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:15:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:15:20 INFO - 'HOME': '/Users/cltbld', 10:15:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:15:20 INFO - 'LOGNAME': 'cltbld', 10:15:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:15:20 INFO - 'MOZ_NO_REMOTE': '1', 10:15:20 INFO - 'NO_EM_RESTART': '1', 10:15:20 INFO - 'PAGER': '/bin/cat', 10:15:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:15:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:15:20 INFO - 'PWD': '/builds/slave/test', 10:15:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:15:20 INFO - 'SHELL': '/bin/bash', 10:15:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jyQSIvpA7G/Listeners', 10:15:20 INFO - 'TMPDIR': '/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/', 10:15:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:15:20 INFO - 'USER': 'cltbld', 10:15:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:15:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:15:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:15:20 INFO - 'XPC_FLAGS': '0x0', 10:15:20 INFO - 'XPC_SERVICE_NAME': '0', 10:15:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:15:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:15:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:15:20 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-UHD9Ff-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:15:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:15:20 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-uHZebE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:15:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:15:20 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-2PB_YN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:15:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:15:20 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-rXGNQ6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:15:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:15:20 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-0IDZcR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:15:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:15:21 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-N1Ajlw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:15:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:15:21 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-d8Smd4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:15:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:15:21 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-Xcb0bN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:15:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:15:21 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-D0Bfp_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:15:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:15:21 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-STXDXg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:15:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:15:21 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-LLD4dj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:15:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:15:21 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-8sSPAM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:15:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:15:21 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-6QatIH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:15:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:15:21 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-18pIAP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:15:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:15:21 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-hQtCXS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:15:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:15:22 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-4l619H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:15:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:15:22 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-rF5ENP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:15:22 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:15:22 INFO - Running setup.py install for manifestparser 10:15:22 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:15:22 INFO - Running setup.py install for mozcrash 10:15:22 INFO - Running setup.py install for mozdebug 10:15:22 INFO - Running setup.py install for mozdevice 10:15:22 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:15:22 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:15:22 INFO - Running setup.py install for mozfile 10:15:23 INFO - Running setup.py install for mozhttpd 10:15:23 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:15:23 INFO - Running setup.py install for mozinfo 10:15:23 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:15:23 INFO - Running setup.py install for mozInstall 10:15:23 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:15:23 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:15:23 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:15:23 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:15:23 INFO - Running setup.py install for mozleak 10:15:23 INFO - Running setup.py install for mozlog 10:15:23 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:15:23 INFO - Running setup.py install for moznetwork 10:15:23 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:15:23 INFO - Running setup.py install for mozprocess 10:15:24 INFO - Running setup.py install for mozprofile 10:15:24 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:15:24 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:15:24 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:15:24 INFO - Running setup.py install for mozrunner 10:15:24 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:15:24 INFO - Running setup.py install for mozscreenshot 10:15:24 INFO - Running setup.py install for moztest 10:15:24 INFO - Running setup.py install for mozversion 10:15:24 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:15:24 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:15:24 INFO - Cleaning up... 10:15:24 INFO - Return code: 0 10:15:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:15:24 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')]} 10:15:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:15:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:15:24 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')]} 10:15:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:15:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:15:24 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 0x106a3da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106a4d420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc090c94f50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1068dce00>, '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 0x106745db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1068d7b20>, '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.M0J35WJCyP/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.jyQSIvpA7G/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/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 10:15:24 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 10:15:24 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 10:15:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.M0J35WJCyP/Render', 10:15:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:15:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:15:24 INFO - 'HOME': '/Users/cltbld', 10:15:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:15:24 INFO - 'LOGNAME': 'cltbld', 10:15:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:15:24 INFO - 'MOZ_NO_REMOTE': '1', 10:15:24 INFO - 'NO_EM_RESTART': '1', 10:15:24 INFO - 'PAGER': '/bin/cat', 10:15:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:15:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:15:24 INFO - 'PWD': '/builds/slave/test', 10:15:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:15:24 INFO - 'SHELL': '/bin/bash', 10:15:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jyQSIvpA7G/Listeners', 10:15:24 INFO - 'TMPDIR': '/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/', 10:15:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:15:24 INFO - 'USER': 'cltbld', 10:15:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:15:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:15:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:15:24 INFO - 'XPC_FLAGS': '0x0', 10:15:24 INFO - 'XPC_SERVICE_NAME': '0', 10:15:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:15:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:15:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:15:25 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-phfiMu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:15:25 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)) 10:15:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:15:25 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-1Np6xv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:15:25 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)) 10:15:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:15:25 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-RFAuTP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:15:25 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)) 10:15:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:15:25 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-duSzZh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:15:25 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)) 10:15:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:15:25 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-c67NhA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:15:25 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)) 10:15:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:15:25 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-RP_02d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:15:25 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)) 10:15:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:15:25 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-GkUmQH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:15:25 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)) 10:15:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:15:25 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-wCGIna-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:15:25 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)) 10:15:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:15:25 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-DakWoc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:15:26 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)) 10:15:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:15:26 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-n5FKcu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:15:26 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)) 10:15:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:15:26 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-SlqfXb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:15:26 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)) 10:15:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:15:26 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-NOTPNJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:15:26 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)) 10:15:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:15:26 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-jFlYh1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:15:26 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)) 10:15:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:15:26 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-zZV2o8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:15:26 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)) 10:15:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:15:26 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-gp2TGY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:15:26 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)) 10:15:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:15:26 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-3KIRXU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:15:26 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)) 10:15:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:15:26 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-7YcJMF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:15:26 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)) 10:15:26 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)) 10:15:26 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)) 10:15:26 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)) 10:15:26 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)) 10:15:26 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)) 10:15:26 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:15:26 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 10:15:26 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 10:15:26 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 10:15:26 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 10:15:26 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 10:15:26 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 10:15:29 INFO - Downloading blessings-1.6.tar.gz 10:15:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:15:29 INFO - Installing collected packages: blessings 10:15:29 INFO - Running setup.py install for blessings 10:15:29 INFO - Successfully installed blessings 10:15:29 INFO - Cleaning up... 10:15:29 INFO - Return code: 0 10:15:29 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:15:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:15:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:15:30 INFO - Reading from file tmpfile_stdout 10:15:30 INFO - Current package versions: 10:15:30 INFO - blessings == 1.6 10:15:30 INFO - blobuploader == 1.2.4 10:15:30 INFO - docopt == 0.6.1 10:15:30 INFO - manifestparser == 1.1 10:15:30 INFO - mozInstall == 1.12 10:15:30 INFO - mozcrash == 0.17 10:15:30 INFO - mozdebug == 0.1 10:15:30 INFO - mozdevice == 0.48 10:15:30 INFO - mozfile == 1.2 10:15:30 INFO - mozhttpd == 0.7 10:15:30 INFO - mozinfo == 0.9 10:15:30 INFO - mozleak == 0.1 10:15:30 INFO - mozlog == 3.1 10:15:30 INFO - moznetwork == 0.27 10:15:30 INFO - mozprocess == 0.22 10:15:30 INFO - mozprofile == 0.28 10:15:30 INFO - mozrunner == 6.11 10:15:30 INFO - mozscreenshot == 0.1 10:15:30 INFO - mozsystemmonitor == 0.0 10:15:30 INFO - moztest == 0.7 10:15:30 INFO - mozversion == 1.4 10:15:30 INFO - psutil == 3.1.1 10:15:30 INFO - requests == 1.2.3 10:15:30 INFO - wsgiref == 0.1.2 10:15:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:15:30 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')]} 10:15:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:15:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:15:30 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')]} 10:15:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:15:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:15:30 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 0x106a3da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106a4d420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc090c94f50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1068dce00>, '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 0x106745db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1068d7b20>, '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.M0J35WJCyP/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.jyQSIvpA7G/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/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 10:15:30 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 10:15:30 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 10:15:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.M0J35WJCyP/Render', 10:15:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:15:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:15:30 INFO - 'HOME': '/Users/cltbld', 10:15:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:15:30 INFO - 'LOGNAME': 'cltbld', 10:15:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:15:30 INFO - 'MOZ_NO_REMOTE': '1', 10:15:30 INFO - 'NO_EM_RESTART': '1', 10:15:30 INFO - 'PAGER': '/bin/cat', 10:15:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:15:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:15:30 INFO - 'PWD': '/builds/slave/test', 10:15:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:15:30 INFO - 'SHELL': '/bin/bash', 10:15:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jyQSIvpA7G/Listeners', 10:15:30 INFO - 'TMPDIR': '/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/', 10:15:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:15:30 INFO - 'USER': 'cltbld', 10:15:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:15:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:15:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:15:30 INFO - 'XPC_FLAGS': '0x0', 10:15:30 INFO - 'XPC_SERVICE_NAME': '0', 10:15:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:15:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:15:30 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)) 10:15:30 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)) 10:15:30 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)) 10:15:30 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)) 10:15:30 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)) 10:15:30 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)) 10:15:30 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)) 10:15:30 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)) 10:15:30 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)) 10:15:30 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)) 10:15:30 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)) 10:15:30 INFO - Cleaning up... 10:15:30 INFO - Return code: 0 10:15:30 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:15:30 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')]} 10:15:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:15:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:15:30 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')]} 10:15:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:15:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:15:30 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 0x106a3da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106a4d420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc090c94f50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1068dce00>, '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 0x106745db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1068d7b20>, '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.M0J35WJCyP/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.jyQSIvpA7G/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/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 10:15:30 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 10:15:30 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 10:15:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.M0J35WJCyP/Render', 10:15:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:15:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:15:30 INFO - 'HOME': '/Users/cltbld', 10:15:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:15:30 INFO - 'LOGNAME': 'cltbld', 10:15:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:15:30 INFO - 'MOZ_NO_REMOTE': '1', 10:15:30 INFO - 'NO_EM_RESTART': '1', 10:15:30 INFO - 'PAGER': '/bin/cat', 10:15:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:15:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:15:30 INFO - 'PWD': '/builds/slave/test', 10:15:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:15:30 INFO - 'SHELL': '/bin/bash', 10:15:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jyQSIvpA7G/Listeners', 10:15:30 INFO - 'TMPDIR': '/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/', 10:15:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:15:30 INFO - 'USER': 'cltbld', 10:15:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:15:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:15:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:15:30 INFO - 'XPC_FLAGS': '0x0', 10:15:30 INFO - 'XPC_SERVICE_NAME': '0', 10:15:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:15:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:15:30 INFO - Downloading/unpacking jsonschema 10:15:30 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 10:15:30 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 10:15:30 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 10:15:30 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 10:15:30 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 10:15:30 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 10:15:32 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:15:32 INFO - Downloading/unpacking functools32 (from jsonschema) 10:15:32 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 10:15:32 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 10:15:32 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 10:15:32 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 10:15:32 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 10:15:32 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 10:15:33 INFO - Downloading functools32-3.2.3-2.tar.gz 10:15:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:15:33 INFO - warning: no files found matching '*.txt' 10:15:33 INFO - no previously-included directories found matching 'build' 10:15:33 INFO - no previously-included directories found matching 'dist' 10:15:33 INFO - no previously-included directories found matching '.git*' 10:15:33 INFO - Installing collected packages: jsonschema, functools32 10:15:33 INFO - Running setup.py install for functools32 10:15:33 INFO - warning: no files found matching '*.txt' 10:15:33 INFO - no previously-included directories found matching 'build' 10:15:33 INFO - no previously-included directories found matching 'dist' 10:15:33 INFO - no previously-included directories found matching '.git*' 10:15:33 INFO - Successfully installed jsonschema functools32 10:15:33 INFO - Cleaning up... 10:15:33 INFO - Return code: 0 10:15:33 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 10:15:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:15:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:15:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:15:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:15:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:15:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:15:33 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 0x106a3da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106a4d420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc090c94f50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1068dce00>, '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 0x106745db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1068d7b20>, '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.M0J35WJCyP/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.jyQSIvpA7G/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/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 10:15:33 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 10:15:33 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 10:15:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.M0J35WJCyP/Render', 10:15:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:15:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:15:33 INFO - 'HOME': '/Users/cltbld', 10:15:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:15:33 INFO - 'LOGNAME': 'cltbld', 10:15:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:15:33 INFO - 'MOZ_NO_REMOTE': '1', 10:15:33 INFO - 'NO_EM_RESTART': '1', 10:15:33 INFO - 'PAGER': '/bin/cat', 10:15:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:15:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:15:33 INFO - 'PWD': '/builds/slave/test', 10:15:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:15:33 INFO - 'SHELL': '/bin/bash', 10:15:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jyQSIvpA7G/Listeners', 10:15:33 INFO - 'TMPDIR': '/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/', 10:15:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:15:33 INFO - 'USER': 'cltbld', 10:15:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:15:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:15:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:15:33 INFO - 'XPC_FLAGS': '0x0', 10:15:33 INFO - 'XPC_SERVICE_NAME': '0', 10:15:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:15:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:15:34 INFO - Downloading/unpacking flake8 10:15:34 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 10:15:34 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 10:15:34 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 10:15:34 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 10:15:34 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 10:15:34 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 10:15:36 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 10:15:36 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 10:15:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:15:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:15:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:15:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:15:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:15:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:15:36 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 10:15:36 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 10:15:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:15:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:15:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:15:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:15:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:15:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:15:37 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 10:15:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:15:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:15:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:15:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:15:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:15:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:15:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 10:15:37 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:15:37 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:15:37 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:15:37 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:15:37 INFO - no previously-included directories found matching 'docs/_build' 10:15:37 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 10:15:37 INFO - Running setup.py install for pep8 10:15:37 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:15:37 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:15:37 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:15:37 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:15:37 INFO - no previously-included directories found matching 'docs/_build' 10:15:37 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 10:15:37 INFO - Successfully installed flake8 mccabe pyflakes pep8 10:15:37 INFO - Cleaning up... 10:15:38 INFO - Return code: 0 10:15:38 INFO - Running post-action listener: _resource_record_post_action 10:15:38 INFO - Running post-action listener: _start_resource_monitoring 10:15:38 INFO - Starting resource monitoring. 10:15:38 INFO - ##### 10:15:38 INFO - ##### Running install step. 10:15:38 INFO - ##### 10:15:38 INFO - Running pre-action listener: _resource_record_pre_action 10:15:38 INFO - Running main action method: install 10:15:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:15:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:15:38 INFO - Reading from file tmpfile_stdout 10:15:38 INFO - Detecting whether we're running mozinstall >=1.0... 10:15:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:15:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:15:38 INFO - Reading from file tmpfile_stdout 10:15:38 INFO - Output received: 10:15:38 INFO - Usage: mozinstall [options] installer 10:15:38 INFO - Options: 10:15:38 INFO - -h, --help show this help message and exit 10:15:38 INFO - -d DEST, --destination=DEST 10:15:38 INFO - Directory to install application into. [default: 10:15:38 INFO - "/builds/slave/test"] 10:15:38 INFO - --app=APP Application being installed. [default: firefox] 10:15:38 INFO - mkdir: /builds/slave/test/build/application 10:15:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 10:15:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 10:16:10 INFO - Reading from file tmpfile_stdout 10:16:10 INFO - Output received: 10:16:10 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 10:16:10 INFO - Running post-action listener: _resource_record_post_action 10:16:10 INFO - ##### 10:16:10 INFO - ##### Running run-tests step. 10:16:10 INFO - ##### 10:16:10 INFO - Running pre-action listener: _resource_record_pre_action 10:16:10 INFO - Running main action method: run_tests 10:16:10 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:16:10 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:16:10 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:16:10 INFO - 2016-06-01 10:16:10.270 screenresolution[1640:7318] starting screenresolution argv=screenresolution get 10:16:10 INFO - 2016-06-01 10:16:10.273 screenresolution[1640:7318] Display 0: 1600x1200x32@60 10:16:10 INFO - 2016-06-01 10:16:10.279 screenresolution[1641:7320] starting screenresolution argv=screenresolution list 10:16:10 INFO - Available Modes on Display 0 10:16:10 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:16:10 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:16:10 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:16:10 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:16:10 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:16:10 INFO - Intel Iris: 10:16:10 INFO - Chipset Model: Intel Iris 10:16:10 INFO - Type: GPU 10:16:10 INFO - Bus: Built-In 10:16:10 INFO - VRAM (Dynamic, Max): 1536 MB 10:16:10 INFO - Vendor: Intel (0x8086) 10:16:10 INFO - Device ID: 0x0a2e 10:16:10 INFO - Revision ID: 0x0009 10:16:10 INFO - Displays: 10:16:10 INFO - Display: 10:16:10 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:16:10 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:16:10 INFO - Display Serial Number: 1600x1200 60 10:16:10 INFO - Main Display: Yes 10:16:10 INFO - Mirror: Off 10:16:10 INFO - Online: Yes 10:16:10 INFO - Rotation: Supported 10:16:10 INFO - Return code: 0 10:16:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:16:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:16:10 INFO - Python 2.7.3 10:16:10 INFO - Return code: 0 10:16:10 INFO - grabbing minidump binary from tooltool 10:16:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:16:10 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 0x1068dce00>, '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 0x106745db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1068d7b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:16:10 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 10:16:10 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 10:16:10 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:16:10 INFO - Return code: 0 10:16:10 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 10:16:10 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:16:10 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:16:10 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 10:16:10 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:16:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 10:16:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 10:16:11 INFO - Return code: 0 10:16:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/S_XAoOD-RwCQDHOoKK9imA/artifacts/public/build/firefox-48.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0054', '--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 10:16:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/S_XAoOD-RwCQDHOoKK9imA/artifacts/public/build/firefox-48.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0054 --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 10:16:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.M0J35WJCyP/Render', 10:16:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:16:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:16:11 INFO - 'HOME': '/Users/cltbld', 10:16:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:16:11 INFO - 'LOGNAME': 'cltbld', 10:16:11 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:16:11 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 10:16:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:16:11 INFO - 'MOZ_NO_REMOTE': '1', 10:16:11 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:16:11 INFO - 'NO_EM_RESTART': '1', 10:16:11 INFO - 'PAGER': '/bin/cat', 10:16:11 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:16:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:16:11 INFO - 'PWD': '/builds/slave/test', 10:16:11 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:16:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:16:11 INFO - 'SHELL': '/bin/bash', 10:16:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jyQSIvpA7G/Listeners', 10:16:11 INFO - 'TMPDIR': '/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/', 10:16:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:16:11 INFO - 'USER': 'cltbld', 10:16:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:16:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:16:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:16:11 INFO - 'XPC_FLAGS': '0x0', 10:16:11 INFO - 'XPC_SERVICE_NAME': '0', 10:16:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:16:11 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/S_XAoOD-RwCQDHOoKK9imA/artifacts/public/build/firefox-48.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0054', '--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 10:16:11 INFO - mozversion application_buildid: 20160601074355 10:16:11 INFO - mozversion application_changeset: bb81bf646c3d92abb37eb6b5b5498cd2dab9175f 10:16:11 INFO - mozversion application_display_name: FirefoxDeveloperEdition 10:16:11 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:16:11 INFO - mozversion application_name: Firefox 10:16:11 INFO - mozversion application_remotingname: firefox-dev 10:16:11 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 10:16:11 INFO - mozversion application_vendor: Mozilla 10:16:11 INFO - mozversion application_version: 48.0a2 10:16:11 INFO - mozversion platform_buildid: 20160601074355 10:16:11 INFO - mozversion platform_changeset: bb81bf646c3d92abb37eb6b5b5498cd2dab9175f 10:16:11 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 10:16:11 INFO - mozversion platform_version: 48.0a2 10:16:11 INFO - using testdate: 1464801371 10:16:11 INFO - actual date: 1464801371 10:16:11 INFO - starting webserver on 'localhost:49270' 10:16:11 INFO - SUITE-START | Running 2 tests 10:16:11 INFO - TEST-START | dromaeo_css 10:16:11 INFO - operating with platform_type : mac_ 10:16:11 INFO - Initialising browser for dromaeo_css test... 10:16:11 INFO - TEST-INFO | started process 1659 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/tmpDW4QkL/profile http://localhost:49270/getInfo.html) 10:16:14 INFO - PROCESS | 1659 | __metrics Screen width/height:1600/1200 10:16:14 INFO - PROCESS | 1659 | colorDepth:24 10:16:14 INFO - PROCESS | 1659 | Browser inner width/height: 1024/689 10:16:14 INFO - PROCESS | 1659 | __metrics 10:16:14 INFO - PROCESS | 1659 | 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" 10:16:14 ERROR - PROCESS | 1659 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 10:16:14 INFO - TEST-INFO | 1659: exit 0 10:16:14 INFO - Browser initialized. 10:16:14 INFO - Running cycle 1/1 for dromaeo_css test... 10:16:14 INFO - TEST-INFO | started process 1661 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/tmpDW4QkL/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:16:26 INFO - PROCESS | 1661 | RSS: Main: 211316736 10:16:26 INFO - PROCESS | 1661 | 10:17:18 INFO - PROCESS | 1661 | 1464801438309 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] 10:19:29 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49270/tests/dromaeo/cssquery-ext.html) 10:19:30 INFO - PROCESS | 1661 | RSS: Main: 352235520 10:19:30 INFO - PROCESS | 1661 | 10:22:33 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-ext.html (next: http://localhost:49270/tests/dromaeo/cssquery-jquery.html) 10:22:34 INFO - PROCESS | 1661 | RSS: Main: 358498304 10:22:34 INFO - PROCESS | 1661 | 10:25:36 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49270/tests/dromaeo/cssquery-mootools.html) 10:25:37 INFO - PROCESS | 1661 | RSS: Main: 361156608 10:25:37 INFO - PROCESS | 1661 | 10:28:39 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49270/tests/dromaeo/cssquery-prototype.html) 10:28:40 INFO - PROCESS | 1661 | RSS: Main: 358924288 10:28:40 INFO - PROCESS | 1661 | 10:31:43 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49270/tests/dromaeo/cssquery-yui.html) 10:31:44 INFO - PROCESS | 1661 | RSS: Main: 336392192 10:31:44 INFO - PROCESS | 1661 | 10:34:46 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-yui.html (next: http://localhost:49270/tests/dromaeo/cssquery-dojo.html) 10:34:46 INFO - PROCESS | 1661 | RSS: Main: 367943680 10:34:46 INFO - PROCESS | 1661 | 10:34:46 INFO - PROCESS | 1661 | __start_tp_report 10:34:46 INFO - PROCESS | 1661 | _x_x_mozilla_page_load 10:34:46 INFO - PROCESS | 1661 | _x_x_mozilla_page_load_details 10:34:46 INFO - PROCESS | 1661 | |i|pagename|runs| 10:34:46 INFO - PROCESS | 1661 | |0;dojo.html;3373.7469689773266;3427.5201471793944;3439.8968030959063;3466.930661386774;3502.562179727534;5573.944260557393;5601.719914004294;5608.579356548265;5628.099504079353;5647.943520564793;5590;5629.296337957755;5650.378458369576;5652.208690783294;5658;4176.477631001322;5070.543651071403;5156.613254005955;5210.140326846066;5223.738813059351;5208.114620514521;5237.79048838046;5243.187305967581;5250.028744682246;5250.4487028861995;5140.871478213037;5175.327207463025;5185.429602743695;5198.584113270948;5215.765290561933;5181.274621552986;5195.9480405195845;5208.5572726318305;5223.686578805284;5263.763130659129;4260.850870219528;5081.958198569285;5110.821121260738;5159.922601160985;5174.818881339135;5480.945190548084;5503.394626591072;5529.3364796224305;5534.723263836832;5567.526760225385;6148.200733904609;6176.7838125665385;6186.19579454668;6189.195404597419;6202.441780239755;6007.249093863267;6121.969390153065;6160.260768707739;6245.500359971237;6277.2153480814895;5474.698891561003;5746.569007324468;5749.626274292157;5764.365919748824;5779.768809247583;5583.860403489945;6305.085762564494;6309.274433440121;6326.49388048955;6345.1116843641;5943.55423343251;6029.306629737549;6037.486813620803;6042.848928776728;6051.818445446644;6118.388161183846;6198.597091189058;6209.441150296495;6209.96895015522;6214.471769899519;6136.140940268366;6182.28903676083;6206.844828879314;6215.471684906744;6223.688815559294;6030.909536356959;6130.2030736004035;6195.96902015487;6196.1635179250225;6216.751329946842;4851.126797176472;4859.514048595112;4884.95115048852;4889.339939108175;4900.730459824744;4398.274284743045;4445.977770111193;4468.486124095705;4471.888202794956;4482.125985432809;5632.155176723442;5713;5725.083986562214;5732.684702341411;5737.254156959652;6190.1952746142715;6226.937730622726;6257.186565746515;6269.404406581368;6288.465480434214;5698.572607054488;5715.971420142956;5730.7421166047625;5732.3121225453215;5760.6543607382855;5205.947940520622;5278.076336641073;5288.286081378965;5293.550048245942;5294;6181.443670069715;6248.156498872594;6248.593841400295;6303.3066362700065;6311.558190926591;6270.467010304175;6292.811215663537;6293.779717709858;6297;6311.621302721851;6318.747250109944;6333.619982801047;6337.112804207322;6356.618602883842;6555.96722016406;5124.7950081996305;5988.161657367885;6046.153538504701;6110.877782444238;6134.294556126102;5506.650870536744;5508.228847961209;6205.162303089025;6228.688565571612;6260.561760676709;6008.7296071676;6018.7291571878495;6075.908861366995;6081.695915204311;6089.817305480843;5864.9413505864395;5921.348651648229;5965.552583556164;5988.580799344004;6045.909311360245;5867.765289388377;5884.440978107073;5902.350741418355;5906.350301466921;5909.468147866713;6049.18336024631;6067.484263837447;6087.847803804763;6100.054491553817;6126.816195514141;5659.773609055756;5765;5809.82570522885;5892.734826932712;5919.112133179885 10:34:46 INFO - PROCESS | 1661 | |1;ext.html;511.88226707857194;538.3862396867572;581.3953488372092;582.6387639663409;586.1793489115238;30480;31070.53394199089;31089.68910310896;31103.377932441337;38870.8056459718;42371.57628423715;43034;43049.70850874471;43090.569094309045;43205.13589728204;9614.038596140383;9850.113489785917;9858.556364963593;9874.60501579936;9876.901230987705;8741.562921853914;8902.821943561124;9489.00365461627;9607.183389411908;11818.527258909633;11696;11730.824037639442;11738.823917641243;11756.823647645293;11769.646910592695;9453.480058596775;11507.769844603145;11518.769624607545;11530.250533715282;11535.711607209803;8693.13068693132;11712.180147389687;11834.408279585987;11845;11879.34663593502;38964.415533767016;39606.81179564618;39611.20777584461;39710;39772.60227397718;3264.347130573871;3277.36091462165;3296.5549650797316;3323.302106557626;3323.8504267307785;28179.154625361272;28319.292017699518;28654.570181447296;28904.98832540872;30011.099667010025;2647.1661426650544;2660.8270462419882;2698.5142674318613;2703.4457936123245;2751.339678477171;500135;502356;502455.4877225627;502833;503776.48111759574;35828.46257306143;36791.26417471636;63970;64387.712245754825;64494.35505644977;35933.46099808505;36004.63995360065;36163.276734465166;36176;36250.27499449996;15480.22598870052;15639.296231669603;15643.765343519857;15651.608709782118;15676.764848527282;10670.893291067145;13239.801402978963;13294.20234785916;13302.66743331405;13318.334083295991;7696.153423123452;8257.42198046131;8318.875216871751;8364.079951205484;8398.874016889751;2995.6105706258045;3357.8992630221132;3413.7951722896705;3416.145963509123;3435.862565497402;962.2206013129388;1009.1926458833051;1024.882138554061;1028.9742756430999;1061.474570087796;26618.935242590465;27584.862075689896;28707;28828.855855720587;29189.708102919125;790.632355954484;1044.93938652268;1100.9284396514201;1126.110372805491;1206.6922934651784;13477.932610336886;13832.930835345758;14034.929825351011;14103.929480352737;14384.568462946128;612975;620659;622385;623306;623383;61489.69255153785;61951.690241549404;61980.69009654923;62032.68983655143;62093;1322.543722415765;1461.934212960398;1478.7781832724747;1502.646877983673;1516.9848301517063;21586.244481443075;27016.67272012624;30623.846880765454;30727;30748.770049198676;52329.738351308;52755.73622131865;53099;53123.46876531185;53227;519310;524208;524593;525947;525949;23943.76056239485;27210.91156353803;27517;27805.582916256677;27858.721412785613;41799.7910010448;42643.78678106589;43175.9206019852;43335.783321083196;43662.34506482469;29137.56293655639;29644.258893527833;34168.97493075212;35404.64595354014;35745.64254357527;33896.49155262722;35217.82391088131;35250.823745881105;35965;36729.63270367262;36625.63374366222;37166;37333;37635.81182094072;37658.43512347372;32712.672873271913;32753.637582559277;32997.67002330042;33081.66918330786;33184;24676.876615616806;24876.875615621808;25036.74963250344;25218.74781252164;25236.74763252344 10:34:46 INFO - PROCESS | 1661 | |2;jquery.html;392.73097927919366;393.3647159836863;397.3582663997645;397.63417655756683;410.4540960522505;15480.148591827445;18980.715289270673;20666.586668266646;21372.4656883578;21394.25120120796;13681.794773078413;18248.817511824876;20604.8969755151;21210.36368908935;21257.468563285925;5232.712200828943;5561.388247292794;5563.082091454905;5566.749496272678;5567.248421463111;4019.356902895537;5438.021156191884;5534.972325138368;5535.086710692731;5537.0863807471715;5802.303723553179;6166.969165154168;6175.969120154393;6181.258249010125;6183.690815459231;6145.815625531219;6171.4445699887;6192.659403732793;6274.654893980829;6713.12729345182;4758.928616070762;5949.07789292656;5987.790427335066;5989.55078369124;5991.2510936132985;13893.305334733222;14540.345684444226;18536.62926741471;26780;26826.463470730476;2152.763196048433;2160.7839216078423;2166.2201607421316;2207.701960235364;2235.452314183019;9798.26513011527;9979.700608981742;10401.167906567456;12239.32683702396;15363.385464581403;1717.7337512685428;1724.6723122606666;1750.3261244420862;1787.5977904971278;1816.3551939061706;103665.44501832478;114998.42500787442;117644;122828;128101.43797124099;9879.555420006118;11858.584949526725;11990.640280791591;11993.400329983466;12041.458134383975;15440.227988600525;15488.07071575709;15571.688566228611;15594.29825657848;15631.531054068397;7648.502847314907;7976.282134607914;8925.107489251153;9154.908450915405;9191.862122068174;9194.21849142817;9199.908000919904;9220.03189665089;9262.583183756748;9342.859857102148;4741.359916411309;4818.060478206786;4836.250381190921;4852.17513022787;4906.730129842893;1981.8216360527622;2008.56815784607;2014.8186663200383;2028.4624574487773;2045.4477291131311;913.7898283394857;966.8322814556186;970.2916870684439;984.2175470500969;1054.2198772908146;20997.580048398948;21202.681959770616;21295.254666086923;21405.35783926485;21453;917;972.4845831709206;989.9109080182818;1009.3590569987964;1020.7852655340122;11246.831297530543;11251.423711447904;11318.830217546578;11335.659930202108;11367.772644547063;517252;564799;571584.6235508313;579497;582746;108822;110459.44770276097;112643;116278;116827;1007.9647212347533;1015.4110615842793;1021.7241344836852;1030.4126647810676;1033.0599154769125;18314.908425457787;18684;18912.716309255648;18945.526361841064;19119.904400478466;52943;53288.46711532835;53774.731126344115;55313.89372212614;55937.72031139981;45863.77068114638;71396;74268;81376.59311703403;85600.57199713962;7915.604219788872;8422.578871056545;8544.316454683487;8579.056303806452;8605.182507661762;9261.67584134552;11155.609553665583;11734.823977640513;12265.816012759995;12538.310392928111;9623.470709111067;10731.302465339728;10905.34567925927;11143.777124457627;11536;10884.183686223407;10898.78202435931;11109.222354435113;11155.995960363607;11421.543138274375;6756.628385438848;7661.770146895602;9362.251019918254;11159.218854680095;11502.775535424164;8160.102388737116;8399.496030238206;8411.53736544496;8463.111373305961;8645.95677021611;9468;10011.949940250252;11235.943820280847;11493.195476316578;11520.769584608428 10:34:46 INFO - PROCESS | 1661 | |3;mootools.html;1384.1418320641203;1434.3975530277282;1590.053917918838;1807.1596707530996;1982.7521559805016;8059.637316320765;8723.869141962869;8924.553772311374;8935.195832375093;8962.058983806688;8633.568321583927;8906.332025098127;8909.020007799138;8911.866322005175;8921.687740929068;2156.514784173556;2224.8665080095166;2393.497365553227;2439.4755127647554;2467.383154211447;2471.666325046123;2477.752224777517;2477.9504409911883;2479.5412848622973;2484.1181380609896;2368.6802281691926;2432.74456182101;2455.435249892526;2456.435019945414;2466.802655787533;2161.23276236936;2223.5775202711434;2226.1763147635315;2227.3206671965045;2418.504206637644;2398.9400264993515;2466.9259922202364;2474.480359124586;2475.789557887582;2482.32977096183;8762;8818.779530511725;8826.249768769661;8832.955835220782;8842.602082906285;4658.580727734487;5370.812021579226;5500.4499550045075;5538.947599955995;5550.361708403545;3367.8316084195694;3454.896353109411;3507.8070706111153;3543.1850674345046;3547.5388199534154;967.2020583018967;1041.2138835179392;1041.5625437316346;1041.6927006533092;1062.4581463453694;10135;12199.207051541622;12210.450529726184;12213.877861221452;12227.510899564008;4310.4611923509565;4717.339572459859;4745.813546613346;4866.683665561727;4870.732109733999;10213;10220.846687299696;10223.59105635781;10227.335223210468;10256.794864102676;5499.340079190442;5516.227728118067;5524.226608274845;5527.751251193706;5532.280803495601;4411.602955733999;4547.545245475426;4816.8554943351755;4938.678985865908;4951.653384263067;3574;4032.858849940238;4041.039349031025;4068.5524592294823;4167.624913757776;1334.1461464662623;1356.2337279437086;1361.5506882728675;1367.5692156970522;1367.9179249245078;899.9730008099767;934.5887809363858;950.843110886696;962.0139357158968;988;5937.970310148508;6014.879702405928;6039.033754599243;6064.393560643988;6170.5372097092895;458.532297057;463.2495357520838;472.2137640827983;472.74235541629895;473.4200604259754;3946.9210615787524;3969.206158768258;4015.277250095011;4036.59634036594;4094.8976275592754;10600.416977066181;10967.945160274307;11086.390248536247;11108.055815255631;11115.166362522843;10807.081398081094;10826.729331766768;10937.234393592531;10943.616973405893;10951.069159121405;8359.373047021376;8362.414630975773;8418.915810841936;8422.957885210535;8463.407561470762;5345.636862600168;5352.9732351338;5509.779608815603;5932.377100404568;5982.132590774227;9292.95353523228;9492.382995105296;9925.503724813587;9938.354006989523;9939.453330066915;9960.452175130147;9989.500524973868;10068.345557538736;10238.948805256225;10261.230407719302;6833.4191593715095;7033.261507541839;7317.341439270491;7623.65693543803;7724.420668449777;8362.498250105013;8392.034915984495;8415.410921235454;8422.957885210535;8428.115047920126;7303.233160518282;7492.587907664913;7516;7557.161485551712;7647.808804779925;6123.2652081750475;7233.63831808418;7317.524360916524;7324.48728589015;7433.256674332523;6992.825179370557;7047.647617618996;7100.076989991268;7122.7507037253445;7127.786166415016;4848.272759086165;4901.58336541398;4925.1627223372825;4996.675216111086;5063.26582645507;4936.580390666833;4975.328330675313;5036.194208926554;5101.362329708786;5255.605829562722 10:34:46 INFO - PROCESS | 1661 | |4;prototype.html;315.8657570532523;320.96629853865346;330.1432781930889;330.6775893503836;334.8309103902529;6611.702473388697;6658.76694315699;6776.796696099119;6789.660516974144;6816.591004539725;6208.8466177604705;6675.465962722983;6771.525993180479;6817.897731534031;6818.147731533559;5062.822801201959;5103;5111.335526381575;5120.231965205212;5125.436202017775;5134.897302053957;5144.331236939192;5147.716875571842;5152.69083854968;5155.587552995751;4526.298423744309;4541.409616749818;4816.614670826326;4916.827911023115;4943.950560494403;4946.9010619787405;4985.875353116165;4989.326440930464;4990.925136122979;4992.650514463989;4273.209456250573;4283.507396649394;4301.655867530621;4303.591158839905;4321;6549.836254093638;6587.308332625101;6596.307387724268;6608.86782264352;6612.173478315211;5981.192539007266;5993.490553302974;5994.220751302347;5996.730147143389;6025.517958563304;6954.756583519553;7249.528780629243;7263.854722905565;7267.127944646623;7280.526765760262;4612.146752850734;4798.49615790344;4834.564889159992;4836.056968891067;4848.490908454632;6679.833004174886;7312.670929808171;7579.4694371394025;7663.27198916102;7688.5386876787015;4770.165221086366;4840.927386089212;4854.077725232195;4854.635902307341;4868.391451068616;4963.70217786934;4983.501649834988;5008.774605142778;5011.223260394645;5013.724245166478;5958.225430694069;5961.7615295387695;5969.194158788595;5974.193483879708;5974.492168165754;7250.1299844018;7268;7273.12722473296;7280.68947589439;7292.19785823559;1602.9519114426587;1662.3599914033184;1664.4756901575965;1666.4000959654516;1700.7703959965247;872.2716531695978;1041.7239431550645;1052.9105026072716;1061.0768631290673;1064.6805958212506;6825.453963682893;6840.6921688524135;6848.3494068063455;6862.553933994274;6867.450603951672;7536.434767392468;7550.546967181876;7554.093508778872;7568.318851303409;7580.1661817200065;5622.875424915033;6781.694823732944;6819.352161544645;6820.215675197316;6840.589564626139;3728.198437335986;3836.1176929306416;3955.268275369066;3984.6850539322536;3994.8601798936897;7861.882071768928;7917.564533950688;7925.661929730743;7935.0874649416055;7972;7745.10931242903;7791.922080779233;7800.219978002155;7814.765557033298;7818.68725250995;7897.763067107996;7902.4863383879865;7903.920960790433;7908.01149856268;7911;7250.166230883305;7468.141163766237;7535.510191837513;7550.509216900884;7557.130929943127;7325.6337183141695;7395.926040739739;7396.593187374746;7399.260073992557;7408.444366672629;7872.252136047066;7882.605869706606;7885.29032387088;7894.407919405952;7907.525548467111;4573.81704731807;4680.4149481314835;4683.4614019386845;4767.308740232716;4789.592884604847;7111.608861512666;7404.481686281909;7406.555606663617;7429.7399591014055;7486.8876966844455;6164.537659675632;7127.893081603884;7179.784606461814;7313.268673132644;7324;7270.563766174047;7311.817204569716;7313.524620899837;7315.30504602062;7318.926810731825;6457.999010153434;6531.281559028598;6776.356246156607;7094.290570943071;7170.89243661356;7026.437884969088;7329.863871099988;7334;7350.70597176107;7352.2280160584505;6117;6856.4514838813775;7115.644217789193;7160.8925866113095;7167.211606723361 10:34:46 INFO - PROCESS | 1661 | |5;yui.html;608.9391060893911;692.214336727814;737.7971057959057;758.1357252731887;760.4034996406178;14931.925340373296;15040.473583424582;15344.53966381009;15429.922850385732;15450.61373465664;13601.727965440685;13804.03371763977;13824.585262442142;13876.514321998731;13967.860321396784;726.6112629743088;732.209214048826;883.4390162246988;895.7133717210463;905.8731777551149;889.937704360695;905.9365844390895;910.1080940678139;910.6357457017212;913.5797533134765;938.015084161631;967.8306296398138;968.6173961285288;968.990310096897;970.1365784451843;759.965801538932;933.1182032978837;959.52023988006;960.2318145483586;960.9615615375377;706.1737766812842;706.4524993130314;708.6208878250163;713.4969846258375;723.4574069447914;15243.542693719206;15277.6180595486;15315.693686126215;15339.693206135926;15342.386304547805;12888.291143987077;12926.482940682456;13013;13039.413226404835;13312.733745325038;9988.300818942676;10109.292349535535;10311.639092631796;10512.789744205149;10607.946960265226;3450.102973226954;3525.6121826599056;3541.752077354586;3565.3760591896316;3567.5897271813815;81062;81311.18688813095;81734.9999999994;84236;84866.57566712188;9388.202002829836;9536.86050206552;9678.661246856327;9877.728122531715;10024.997500250063;21451.67822482664;21719.782802171776;21733.45666358322;22166;22211.77788222097;7241.5293005954445;7507.962460187664;7696.307332340116;7781.338586220235;7818.061832580127;4037.6366127048705;4050.3519436889956;4144.606262405066;4145.751254924714;4168.124693814272;3511.701505372072;3751.043483911585;3752.249550089993;3753;3754.4556039374684;557.2950217974266;644.1304239276939;653.8068025852838;654.1659384285075;685.6297599296424;505.33800721055536;540.3461811208482;559.8628336057692;560.5347561523926;580.6661169827366;7761;7883.36933045355;7919.168487308865;7956.840863182704;7994.5203287802915;555.6582701638463;556.8218170185582;558.6340946679932;577.9046457334576;578.9131630255496;3722.683571896419;3784.2242340320718;3791.450239715226;3806.352920003606;3860.285847118236;85825.57087214524;85975;86973;87364.25271494534;87569.56215218882;77128.84306735291;78609.21390786134;80511.98720032047;81153.59423202847;81642.55072347839;69099.65450172717;69833;71500.2849971504;71781.64109179525;72212.63893680499;7426.331630153096;7593;7646.923530764621;7647.961760191163;7779.649915753692;36230.818845905604;46071;46497.53502465067;46939.295910560686;47204.52795472001;63302.41743956438;67871;67978;69418.30581694118;69472.30527694659;9514.524273786421;9640.90359096428;9645.565949532147;9882;9966.302358834811;10238.948805255926;10394.677256418343;10453.9477302613;10593.245636728978;10618.203634727271;9843.360181588174;9871.605135794487;9919.15687166599;9998.600055997678;10309.381437113798;8954.328425367994;9601.951990240284;9967.750806229902;10076.69769906904;10228.693139205836;9710.514474276117;9714.514274286115;9770.658026969022;9814.607415703293;10244.897551024394;8371.95814020926;8449.746507604781;8579.313654907717;8613.526256055726;9048.366614336934;8340.87488687658;8462.153784621734;8617.310615150647;8659.13408659129;8735.737927862174 10:34:46 INFO - PROCESS | 1661 | __end_tp_report 10:34:46 INFO - PROCESS | 1661 | __start_cc_report 10:34:46 INFO - PROCESS | 1661 | _x_x_mozilla_cycle_collect,1276 10:34:46 INFO - PROCESS | 1661 | __end_cc_report 10:34:46 INFO - PROCESS | 1661 | __startTimestamp1464802486862__endTimestamp 10:34:46 INFO - PROCESS | 1661 | 10:34:46 INFO - PROCESS | 1661 | ------- Summary: start ------- 10:34:46 INFO - PROCESS | 1661 | Number of tests: 6 10:34:46 INFO - PROCESS | 1661 | 10:34:46 INFO - PROCESS | 1661 | [#0] dojo.html Cycles:165 Average:5678.60 Median:5864.94 stddev:639.70 (10.9%) stddev-sans-first:615.58 10:34:46 INFO - PROCESS | 1661 | Values: 3373.7 3427.5 3439.9 3466.9 3502.6 5573.9 5601.7 5608.6 5628.1 5647.9 5590.0 5629.3 5650.4 5652.2 5658.0 4176.5 5070.5 5156.6 5210.1 5223.7 5208.1 5237.8 5243.2 5250.0 5250.4 5140.9 5175.3 5185.4 5198.6 5215.8 5181.3 5195.9 5208.6 5223.7 5263.8 4260.9 5082.0 5110.8 5159.9 5174.8 5480.9 5503.4 5529.3 5534.7 5567.5 6148.2 6176.8 6186.2 6189.2 6202.4 6007.2 6122.0 6160.3 6245.5 6277.2 5474.7 5746.6 5749.6 5764.4 5779.8 5583.9 6305.1 6309.3 6326.5 6345.1 5943.6 6029.3 6037.5 6042.8 6051.8 6118.4 6198.6 6209.4 6210.0 6214.5 6136.1 6182.3 6206.8 6215.5 6223.7 6030.9 6130.2 6196.0 6196.2 6216.8 4851.1 4859.5 4885.0 4889.3 4900.7 4398.3 4446.0 4468.5 4471.9 4482.1 5632.2 5713.0 5725.1 5732.7 5737.3 6190.2 6226.9 6257.2 6269.4 6288.5 5698.6 5716.0 5730.7 5732.3 5760.7 5205.9 5278.1 5288.3 5293.6 5294.0 6181.4 6248.2 6248.6 6303.3 6311.6 6270.5 6292.8 6293.8 6297.0 6311.6 6318.7 6333.6 6337.1 6356.6 6556.0 5124.8 5988.2 6046.2 6110.9 6134.3 5506.7 5508.2 6205.2 6228.7 6260.6 6008.7 6018.7 6075.9 6081.7 6089.8 5864.9 5921.3 5965.6 5988.6 6045.9 5867.8 5884.4 5902.4 5906.4 5909.5 6049.2 6067.5 6087.8 6100.1 6126.8 5659.8 5765.0 5809.8 5892.7 5919.1 10:34:46 INFO - PROCESS | 1661 | 10:34:46 INFO - PROCESS | 1661 | [#1] ext.html Cycles:180 Average:66716.79 Median:18655.14 stddev:147501.55 (790.7%) stddev-sans-first:147831.58 10:34:46 INFO - PROCESS | 1661 | Values: 511.9 538.4 581.4 582.6 586.2 30480.0 31070.5 31089.7 31103.4 38870.8 42371.6 43034.0 43049.7 43090.6 43205.1 9614.0 9850.1 9858.6 9874.6 9876.9 8741.6 8902.8 9489.0 9607.2 11818.5 11696.0 11730.8 11738.8 11756.8 11769.6 9453.5 11507.8 11518.8 11530.3 11535.7 8693.1 11712.2 11834.4 11845.0 11879.3 38964.4 39606.8 39611.2 39710.0 39772.6 3264.3 3277.4 3296.6 3323.3 3323.9 28179.2 28319.3 28654.6 28905.0 30011.1 2647.2 2660.8 2698.5 2703.4 2751.3 500135.0 502356.0 502455.5 502833.0 503776.5 35828.5 36791.3 63970.0 64387.7 64494.4 35933.5 36004.6 36163.3 36176.0 36250.3 15480.2 15639.3 15643.8 15651.6 15676.8 10670.9 13239.8 13294.2 13302.7 13318.3 7696.2 8257.4 8318.9 8364.1 8398.9 2995.6 3357.9 3413.8 3416.1 3435.9 962.2 1009.2 1024.9 1029.0 1061.5 26618.9 27584.9 28707.0 28828.9 29189.7 790.6 1044.9 1100.9 1126.1 1206.7 13477.9 13832.9 14034.9 14103.9 14384.6 612975.0 620659.0 622385.0 623306.0 623383.0 61489.7 61951.7 61980.7 62032.7 62093.0 1322.5 1461.9 1478.8 1502.6 1517.0 21586.2 27016.7 30623.8 30727.0 30748.8 52329.7 52755.7 53099.0 53123.5 53227.0 519310.0 524208.0 524593.0 525947.0 525949.0 23943.8 27210.9 27517.0 27805.6 27858.7 41799.8 42643.8 43175.9 43335.8 43662.3 29137.6 29644.3 34169.0 35404.6 35745.6 33896.5 35217.8 35250.8 35965.0 36729.6 36625.6 37166.0 37333.0 37635.8 37658.4 32712.7 32753.6 32997.7 33081.7 33184.0 24676.9 24876.9 25036.7 25218.7 25236.7 10:34:46 INFO - PROCESS | 1661 | 10:34:46 INFO - PROCESS | 1661 | [#2] jquery.html Cycles:180 Average:33313.33 Median:2221.58 stddev:94014.63 (4231.9%) stddev-sans-first:94245.87 10:34:46 INFO - PROCESS | 1661 | Values: 392.7 393.4 397.4 397.6 410.5 15480.1 18980.7 20666.6 21372.5 21394.3 13681.8 18248.8 20604.9 21210.4 21257.5 5232.7 5561.4 5563.1 5566.7 5567.2 4019.4 5438.0 5535.0 5535.1 5537.1 5802.3 6167.0 6176.0 6181.3 6183.7 6145.8 6171.4 6192.7 6274.7 6713.1 4758.9 5949.1 5987.8 5989.6 5991.3 13893.3 14540.3 18536.6 26780.0 26826.5 2152.8 2160.8 2166.2 2207.7 2235.5 9798.3 9979.7 10401.2 12239.3 15363.4 1717.7 1724.7 1750.3 1787.6 1816.4 103665.4 114998.4 117644.0 122828.0 128101.4 9879.6 11858.6 11990.6 11993.4 12041.5 15440.2 15488.1 15571.7 15594.3 15631.5 7648.5 7976.3 8925.1 9154.9 9191.9 9194.2 9199.9 9220.0 9262.6 9342.9 4741.4 4818.1 4836.3 4852.2 4906.7 1981.8 2008.6 2014.8 2028.5 2045.4 913.8 966.8 970.3 984.2 1054.2 20997.6 21202.7 21295.3 21405.4 21453.0 917.0 972.5 989.9 1009.4 1020.8 11246.8 11251.4 11318.8 11335.7 11367.8 517252.0 564799.0 571584.6 579497.0 582746.0 108822.0 110459.4 112643.0 116278.0 116827.0 1008.0 1015.4 1021.7 1030.4 1033.1 18314.9 18684.0 18912.7 18945.5 19119.9 52943.0 53288.5 53774.7 55313.9 55937.7 45863.8 71396.0 74268.0 81376.6 85600.6 7915.6 8422.6 8544.3 8579.1 8605.2 9261.7 11155.6 11734.8 12265.8 12538.3 9623.5 10731.3 10905.3 11143.8 11536.0 10884.2 10898.8 11109.2 11156.0 11421.5 6756.6 7661.8 9362.3 11159.2 11502.8 8160.1 8399.5 8411.5 8463.1 8646.0 9468.0 10011.9 11235.9 11493.2 11520.8 10:34:46 INFO - PROCESS | 1661 | 10:34:46 INFO - PROCESS | 1661 | [#3] mootools.html Cycles:180 Average:5742.48 Median:4868.71 stddev:3251.88 (66.8%) stddev-sans-first:3244.51 10:34:46 INFO - PROCESS | 1661 | Values: 1384.1 1434.4 1590.1 1807.2 1982.8 8059.6 8723.9 8924.6 8935.2 8962.1 8633.6 8906.3 8909.0 8911.9 8921.7 2156.5 2224.9 2393.5 2439.5 2467.4 2471.7 2477.8 2478.0 2479.5 2484.1 2368.7 2432.7 2455.4 2456.4 2466.8 2161.2 2223.6 2226.2 2227.3 2418.5 2398.9 2466.9 2474.5 2475.8 2482.3 8762.0 8818.8 8826.2 8833.0 8842.6 4658.6 5370.8 5500.4 5538.9 5550.4 3367.8 3454.9 3507.8 3543.2 3547.5 967.2 1041.2 1041.6 1041.7 1062.5 10135.0 12199.2 12210.5 12213.9 12227.5 4310.5 4717.3 4745.8 4866.7 4870.7 10213.0 10220.8 10223.6 10227.3 10256.8 5499.3 5516.2 5524.2 5527.8 5532.3 4411.6 4547.5 4816.9 4938.7 4951.7 3574.0 4032.9 4041.0 4068.6 4167.6 1334.1 1356.2 1361.6 1367.6 1367.9 900.0 934.6 950.8 962.0 988.0 5938.0 6014.9 6039.0 6064.4 6170.5 458.5 463.2 472.2 472.7 473.4 3946.9 3969.2 4015.3 4036.6 4094.9 10600.4 10967.9 11086.4 11108.1 11115.2 10807.1 10826.7 10937.2 10943.6 10951.1 8359.4 8362.4 8418.9 8423.0 8463.4 5345.6 5353.0 5509.8 5932.4 5982.1 9293.0 9492.4 9925.5 9938.4 9939.5 9960.5 9989.5 10068.3 10238.9 10261.2 6833.4 7033.3 7317.3 7623.7 7724.4 8362.5 8392.0 8415.4 8423.0 8428.1 7303.2 7492.6 7516.0 7557.2 7647.8 6123.3 7233.6 7317.5 7324.5 7433.3 6992.8 7047.6 7100.1 7122.8 7127.8 4848.3 4901.6 4925.2 4996.7 5063.3 4936.6 4975.3 5036.2 5101.4 5255.6 10:34:46 INFO - PROCESS | 1661 | 10:34:46 INFO - PROCESS | 1661 | [#4] prototype.html Cycles:180 Average:5953.41 Median:6776.58 stddev:1901.16 (28.1%) stddev-sans-first:1858.81 10:34:46 INFO - PROCESS | 1661 | Values: 315.9 321.0 330.1 330.7 334.8 6611.7 6658.8 6776.8 6789.7 6816.6 6208.8 6675.5 6771.5 6817.9 6818.1 5062.8 5103.0 5111.3 5120.2 5125.4 5134.9 5144.3 5147.7 5152.7 5155.6 4526.3 4541.4 4816.6 4916.8 4944.0 4946.9 4985.9 4989.3 4990.9 4992.7 4273.2 4283.5 4301.7 4303.6 4321.0 6549.8 6587.3 6596.3 6608.9 6612.2 5981.2 5993.5 5994.2 5996.7 6025.5 6954.8 7249.5 7263.9 7267.1 7280.5 4612.1 4798.5 4834.6 4836.1 4848.5 6679.8 7312.7 7579.5 7663.3 7688.5 4770.2 4840.9 4854.1 4854.6 4868.4 4963.7 4983.5 5008.8 5011.2 5013.7 5958.2 5961.8 5969.2 5974.2 5974.5 7250.1 7268.0 7273.1 7280.7 7292.2 1603.0 1662.4 1664.5 1666.4 1700.8 872.3 1041.7 1052.9 1061.1 1064.7 6825.5 6840.7 6848.3 6862.6 6867.5 7536.4 7550.5 7554.1 7568.3 7580.2 5622.9 6781.7 6819.4 6820.2 6840.6 3728.2 3836.1 3955.3 3984.7 3994.9 7861.9 7917.6 7925.7 7935.1 7972.0 7745.1 7791.9 7800.2 7814.8 7818.7 7897.8 7902.5 7903.9 7908.0 7911.0 7250.2 7468.1 7535.5 7550.5 7557.1 7325.6 7395.9 7396.6 7399.3 7408.4 7872.3 7882.6 7885.3 7894.4 7907.5 4573.8 4680.4 4683.5 4767.3 4789.6 7111.6 7404.5 7406.6 7429.7 7486.9 6164.5 7127.9 7179.8 7313.3 7324.0 7270.6 7311.8 7313.5 7315.3 7318.9 6458.0 6531.3 6776.4 7094.3 7170.9 7026.4 7329.9 7334.0 7350.7 7352.2 6117.0 6856.5 7115.6 7160.9 7167.2 10:34:46 INFO - PROCESS | 1661 | 10:34:46 INFO - PROCESS | 1661 | [#5] yui.html Cycles:180 Average:17876.70 Median:711.06 stddev:25469.55 (3581.9%) stddev-sans-first:25508.00 10:34:46 INFO - PROCESS | 1661 | Values: 608.9 692.2 737.8 758.1 760.4 14931.9 15040.5 15344.5 15429.9 15450.6 13601.7 13804.0 13824.6 13876.5 13967.9 726.6 732.2 883.4 895.7 905.9 889.9 905.9 910.1 910.6 913.6 938.0 967.8 968.6 969.0 970.1 760.0 933.1 959.5 960.2 961.0 706.2 706.5 708.6 713.5 723.5 15243.5 15277.6 15315.7 15339.7 15342.4 12888.3 12926.5 13013.0 13039.4 13312.7 9988.3 10109.3 10311.6 10512.8 10607.9 3450.1 3525.6 3541.8 3565.4 3567.6 81062.0 81311.2 81735.0 84236.0 84866.6 9388.2 9536.9 9678.7 9877.7 10025.0 21451.7 21719.8 21733.5 22166.0 22211.8 7241.5 7508.0 7696.3 7781.3 7818.1 4037.6 4050.4 4144.6 4145.8 4168.1 3511.7 3751.0 3752.2 3753.0 3754.5 557.3 644.1 653.8 654.2 685.6 505.3 540.3 559.9 560.5 580.7 7761.0 7883.4 7919.2 7956.8 7994.5 555.7 556.8 558.6 577.9 578.9 3722.7 3784.2 3791.5 3806.4 3860.3 85825.6 85975.0 86973.0 87364.3 87569.6 77128.8 78609.2 80512.0 81153.6 81642.6 69099.7 69833.0 71500.3 71781.6 72212.6 7426.3 7593.0 7646.9 7648.0 7779.6 36230.8 46071.0 46497.5 46939.3 47204.5 63302.4 67871.0 67978.0 69418.3 69472.3 9514.5 9640.9 9645.6 9882.0 9966.3 10238.9 10394.7 10453.9 10593.2 10618.2 9843.4 9871.6 9919.2 9998.6 10309.4 8954.3 9602.0 9967.8 10076.7 10228.7 9710.5 9714.5 9770.7 9814.6 10244.9 8372.0 8449.7 8579.3 8613.5 9048.4 8340.9 8462.2 8617.3 8659.1 8735.7 10:34:46 INFO - PROCESS | 1661 | -------- Summary: end -------- 10:34:46 INFO - PROCESS | 1661 | 10:34:47 INFO - TEST-INFO | 1661: exit 0 10:34:47 INFO - TEST-OK | dromaeo_css | took 1115518ms 10:34:47 INFO - TEST-START | kraken 10:34:47 INFO - operating with platform_type : mac_ 10:34:47 INFO - Initialising browser for kraken test... 10:34:47 INFO - TEST-INFO | started process 1672 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/tmpijBBBx/profile http://localhost:49270/getInfo.html) 10:34:49 INFO - PROCESS | 1672 | __metrics Screen width/height:1600/1200 10:34:49 INFO - PROCESS | 1672 | colorDepth:24 10:34:49 INFO - PROCESS | 1672 | Browser inner width/height: 1024/689 10:34:49 INFO - PROCESS | 1672 | __metrics 10:34:49 INFO - PROCESS | 1672 | 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" 10:34:49 ERROR - PROCESS | 1672 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 10:34:50 INFO - TEST-INFO | 1672: exit 0 10:34:50 INFO - Browser initialized. 10:34:50 INFO - Running cycle 1/1 for kraken test... 10:34:50 INFO - TEST-INFO | started process 1674 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/tmpijBBBx/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:35:02 INFO - PROCESS | 1674 | RSS: Main: 210685952 10:35:02 INFO - PROCESS | 1674 | 10:35:05 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-beat-detection) 10:35:05 INFO - PROCESS | 1674 | RSS: Main: 271904768 10:35:05 INFO - PROCESS | 1674 | 10:35:08 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-dft) 10:35:09 INFO - PROCESS | 1674 | RSS: Main: 286011392 10:35:09 INFO - PROCESS | 1674 | 10:35:12 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-fft) 10:35:13 INFO - PROCESS | 1674 | RSS: Main: 373452800 10:35:13 INFO - PROCESS | 1674 | 10:35:15 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-oscillator) 10:35:15 INFO - PROCESS | 1674 | RSS: Main: 279764992 10:35:15 INFO - PROCESS | 1674 | 10:35:17 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:35:18 INFO - PROCESS | 1674 | RSS: Main: 280469504 10:35:18 INFO - PROCESS | 1674 | 10:35:21 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-darkroom) 10:35:21 INFO - PROCESS | 1674 | RSS: Main: 318586880 10:35:21 INFO - PROCESS | 1674 | 10:35:24 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-desaturate) 10:35:25 INFO - PROCESS | 1674 | RSS: Main: 319684608 10:35:25 INFO - PROCESS | 1674 | 10:35:27 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49270/tests/kraken/driver.html?testName=json-parse-financial) 10:35:28 INFO - PROCESS | 1674 | RSS: Main: 317927424 10:35:28 INFO - PROCESS | 1674 | 10:35:30 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49270/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:35:30 INFO - PROCESS | 1674 | RSS: Main: 309403648 10:35:30 INFO - PROCESS | 1674 | 10:35:32 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:35:33 INFO - PROCESS | 1674 | RSS: Main: 316194816 10:35:33 INFO - PROCESS | 1674 | 10:35:35 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:35:36 INFO - PROCESS | 1674 | RSS: Main: 319295488 10:35:36 INFO - PROCESS | 1674 | 10:35:39 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:35:39 INFO - PROCESS | 1674 | RSS: Main: 320954368 10:35:39 INFO - PROCESS | 1674 | 10:35:42 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:35:43 INFO - PROCESS | 1674 | RSS: Main: 318894080 10:35:43 INFO - PROCESS | 1674 | 10:35:44 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49270/tests/kraken/driver.html?testName=ai-astar) 10:35:45 INFO - PROCESS | 1674 | RSS: Main: 383111168 10:35:45 INFO - PROCESS | 1674 | 10:35:45 INFO - PROCESS | 1674 | __start_tp_report 10:35:45 INFO - PROCESS | 1674 | _x_x_mozilla_page_load 10:35:45 INFO - PROCESS | 1674 | _x_x_mozilla_page_load_details 10:35:45 INFO - PROCESS | 1674 | |i|pagename|runs| 10:35:45 INFO - PROCESS | 1674 | |0;ai-astar;112;111;120;111;112;110;110;112;112;133 10:35:45 INFO - PROCESS | 1674 | |1;audio-beat-detection;156;120;161;159;122;143;120;149;157;116 10:35:45 INFO - PROCESS | 1674 | |2;audio-dft;185;187;186;184;183;205;258;253;184;185 10:35:45 INFO - PROCESS | 1674 | |3;audio-fft;70;78;75;151;55;55;57;63;130;54 10:35:45 INFO - PROCESS | 1674 | |4;audio-oscillator;87;90;146;77;79;81;126;78;78;125 10:35:45 INFO - PROCESS | 1674 | |5;imaging-gaussian-blur;89;87;89;87;88;85;88;86;89;84 10:35:45 INFO - PROCESS | 1674 | |6;imaging-darkroom;94;95;95;94;94;94;95;95;94;94 10:35:45 INFO - PROCESS | 1674 | |7;imaging-desaturate;85;85;87;85;83;84;84;83;85;86 10:35:45 INFO - PROCESS | 1674 | |8;json-parse-financial;60;63;65;66;66;64;63;83;58;58 10:35:45 INFO - PROCESS | 1674 | |9;json-stringify-tinderbox;63;63;68;75;75;71;66;66;68;68 10:35:45 INFO - PROCESS | 1674 | |10;stanford-crypto-aes;82;79;81;80;79;81;81;81;81;84 10:35:45 INFO - PROCESS | 1674 | |11;stanford-crypto-ccm;144;137;141;152;130;144;140;141;155;172 10:35:45 INFO - PROCESS | 1674 | |12;stanford-crypto-pbkdf2;164;166;166;180;165;166;164;166;170;166 10:35:45 INFO - PROCESS | 1674 | |13;stanford-crypto-sha256-iterative;68;67;69;69;67;68;73;94;95;95 10:35:45 INFO - PROCESS | 1674 | __end_tp_report 10:35:45 INFO - PROCESS | 1674 | __start_cc_report 10:35:45 INFO - PROCESS | 1674 | _x_x_mozilla_cycle_collect,1976 10:35:45 INFO - PROCESS | 1674 | __end_cc_report 10:35:45 INFO - PROCESS | 1674 | __startTimestamp1464802545228__endTimestamp 10:35:45 INFO - PROCESS | 1674 | 10:35:45 INFO - PROCESS | 1674 | ------- Summary: start ------- 10:35:45 INFO - PROCESS | 1674 | Number of tests: 14 10:35:45 INFO - PROCESS | 1674 | 10:35:45 INFO - PROCESS | 1674 | [#0] ai-astar Cycles:10 Average:114.30 Median:112.00 stddev:7.17 (6.4%) stddev-sans-first:7.55 10:35:45 INFO - PROCESS | 1674 | Values: 112.0 111.0 120.0 111.0 112.0 110.0 110.0 112.0 112.0 133.0 10:35:45 INFO - PROCESS | 1674 | 10:35:45 INFO - PROCESS | 1674 | [#1] audio-beat-detection Cycles:10 Average:140.30 Median:152.50 stddev:18.67 (12.2%) stddev-sans-first:18.92 10:35:45 INFO - PROCESS | 1674 | Values: 156.0 120.0 161.0 159.0 122.0 143.0 120.0 149.0 157.0 116.0 10:35:45 INFO - PROCESS | 1674 | 10:35:45 INFO - PROCESS | 1674 | [#2] audio-dft Cycles:10 Average:201.00 Median:186.50 stddev:29.45 (15.8%) stddev-sans-first:30.66 10:35:45 INFO - PROCESS | 1674 | Values: 185.0 187.0 186.0 184.0 183.0 205.0 258.0 253.0 184.0 185.0 10:35:45 INFO - PROCESS | 1674 | 10:35:45 INFO - PROCESS | 1674 | [#3] audio-fft Cycles:10 Average:78.80 Median:60.00 stddev:33.99 (56.7%) stddev-sans-first:35.91 10:35:45 INFO - PROCESS | 1674 | Values: 70.0 78.0 75.0 151.0 55.0 55.0 57.0 63.0 130.0 54.0 10:35:45 INFO - PROCESS | 1674 | 10:35:45 INFO - PROCESS | 1674 | [#4] audio-oscillator Cycles:10 Average:96.70 Median:78.50 stddev:25.55 (32.6%) stddev-sans-first:26.86 10:35:45 INFO - PROCESS | 1674 | Values: 87.0 90.0 146.0 77.0 79.0 81.0 126.0 78.0 78.0 125.0 10:35:45 INFO - PROCESS | 1674 | 10:35:45 INFO - PROCESS | 1674 | [#5] imaging-gaussian-blur Cycles:10 Average:87.20 Median:88.00 stddev:1.75 (2.0%) stddev-sans-first:1.73 10:35:45 INFO - PROCESS | 1674 | Values: 89.0 87.0 89.0 87.0 88.0 85.0 88.0 86.0 89.0 84.0 10:35:45 INFO - PROCESS | 1674 | 10:35:45 INFO - PROCESS | 1674 | [#6] imaging-darkroom Cycles:10 Average:94.40 Median:94.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 10:35:45 INFO - PROCESS | 1674 | Values: 94.0 95.0 95.0 94.0 94.0 94.0 95.0 95.0 94.0 94.0 10:35:45 INFO - PROCESS | 1674 | 10:35:45 INFO - PROCESS | 1674 | [#7] imaging-desaturate Cycles:10 Average:84.70 Median:85.00 stddev:1.25 (1.5%) stddev-sans-first:1.32 10:35:45 INFO - PROCESS | 1674 | Values: 85.0 85.0 87.0 85.0 83.0 84.0 84.0 83.0 85.0 86.0 10:35:45 INFO - PROCESS | 1674 | 10:35:45 INFO - PROCESS | 1674 | [#8] json-parse-financial Cycles:10 Average:64.60 Median:64.50 stddev:7.12 (11.0%) stddev-sans-first:7.36 10:35:45 INFO - PROCESS | 1674 | Values: 60.0 63.0 65.0 66.0 66.0 64.0 63.0 83.0 58.0 58.0 10:35:45 INFO - PROCESS | 1674 | 10:35:45 INFO - PROCESS | 1674 | [#9] json-stringify-tinderbox Cycles:10 Average:68.30 Median:68.00 stddev:4.27 (6.3%) stddev-sans-first:4.08 10:35:45 INFO - PROCESS | 1674 | Values: 63.0 63.0 68.0 75.0 75.0 71.0 66.0 66.0 68.0 68.0 10:35:45 INFO - PROCESS | 1674 | 10:35:45 INFO - PROCESS | 1674 | [#10] stanford-crypto-aes Cycles:10 Average:80.90 Median:81.00 stddev:1.45 (1.8%) stddev-sans-first:1.48 10:35:45 INFO - PROCESS | 1674 | Values: 82.0 79.0 81.0 80.0 79.0 81.0 81.0 81.0 81.0 84.0 10:35:45 INFO - PROCESS | 1674 | 10:35:45 INFO - PROCESS | 1674 | [#11] stanford-crypto-ccm Cycles:10 Average:145.60 Median:144.00 stddev:11.65 (8.1%) stddev-sans-first:12.35 10:35:45 INFO - PROCESS | 1674 | Values: 144.0 137.0 141.0 152.0 130.0 144.0 140.0 141.0 155.0 172.0 10:35:45 INFO - PROCESS | 1674 | 10:35:45 INFO - PROCESS | 1674 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:167.30 Median:166.00 stddev:4.76 (2.9%) stddev-sans-first:4.90 10:35:45 INFO - PROCESS | 1674 | Values: 164.0 166.0 166.0 180.0 165.0 166.0 164.0 166.0 170.0 166.0 10:35:45 INFO - PROCESS | 1674 | 10:35:45 INFO - PROCESS | 1674 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:76.50 Median:71.00 stddev:12.65 (17.8%) stddev-sans-first:13.04 10:35:45 INFO - PROCESS | 1674 | Values: 68.0 67.0 69.0 69.0 67.0 68.0 73.0 94.0 95.0 95.0 10:35:45 INFO - PROCESS | 1674 | -------- Summary: end -------- 10:35:45 INFO - PROCESS | 1674 | 10:35:45 INFO - TEST-INFO | 1674: exit 0 10:35:46 INFO - TEST-OK | kraken | took 58617ms 10:35:46 INFO - SUITE-END | took 1174s 10:35:46 INFO - Completed test suite (00:19:34) 10:35:46 INFO - javascript benchmark 10:35:46 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3373.7469689773266, 3427.5201471793944, 3439.8968030959063, 3466.930661386774, 3502.562179727534, 5573.944260557393, 5601.719914004294, 5608.579356548265, 5628.099504079353, 5647.943520564793, 5590.0, 5629.296337957755, 5650.378458369576, 5652.208690783294, 5658.0, 4176.477631001322, 5070.543651071403, 5156.613254005955, 5210.140326846066, 5223.738813059351, 5208.114620514521, 5237.79048838046, 5243.187305967581, 5250.028744682246, 5250.4487028861995, 5140.871478213037, 5175.327207463025, 5185.429602743695, 5198.584113270948, 5215.765290561933, 5181.274621552986, 5195.9480405195845, 5208.5572726318305, 5223.686578805284, 5263.763130659129, 4260.850870219528, 5081.958198569285, 5110.821121260738, 5159.922601160985, 5174.818881339135, 5480.945190548084, 5503.394626591072, 5529.3364796224305, 5534.723263836832, 5567.526760225385, 6148.200733904609, 6176.7838125665385, 6186.19579454668, 6189.195404597419, 6202.441780239755, 6007.249093863267, 6121.969390153065, 6160.260768707739, 6245.500359971237, 6277.2153480814895, 5474.698891561003, 5746.569007324468, 5749.626274292157, 5764.365919748824, 5779.768809247583, 5583.860403489945, 6305.085762564494, 6309.274433440121, 6326.49388048955, 6345.1116843641, 5943.55423343251, 6029.306629737549, 6037.486813620803, 6042.848928776728, 6051.818445446644, 6118.388161183846, 6198.597091189058, 6209.441150296495, 6209.96895015522, 6214.471769899519, 6136.140940268366, 6182.28903676083, 6206.844828879314, 6215.471684906744, 6223.688815559294, 6030.909536356959, 6130.2030736004035, 6195.96902015487, 6196.1635179250225, 6216.751329946842, 4851.126797176472, 4859.514048595112, 4884.95115048852, 4889.339939108175, 4900.730459824744, 4398.274284743045, 4445.977770111193, 4468.486124095705, 4471.888202794956, 4482.125985432809, 5632.155176723442, 5713.0, 5725.083986562214, 5732.684702341411, 5737.254156959652, 6190.1952746142715, 6226.937730622726, 6257.186565746515, 6269.404406581368, 6288.465480434214, 5698.572607054488, 5715.971420142956, 5730.7421166047625, 5732.3121225453215, 5760.6543607382855, 5205.947940520622, 5278.076336641073, 5288.286081378965, 5293.550048245942, 5294.0, 6181.443670069715, 6248.156498872594, 6248.593841400295, 6303.3066362700065, 6311.558190926591, 6270.467010304175, 6292.811215663537, 6293.779717709858, 6297.0, 6311.621302721851, 6318.747250109944, 6333.619982801047, 6337.112804207322, 6356.618602883842, 6555.96722016406, 5124.7950081996305, 5988.161657367885, 6046.153538504701, 6110.877782444238, 6134.294556126102, 5506.650870536744, 5508.228847961209, 6205.162303089025, 6228.688565571612, 6260.561760676709, 6008.7296071676, 6018.7291571878495, 6075.908861366995, 6081.695915204311, 6089.817305480843, 5864.9413505864395, 5921.348651648229, 5965.552583556164, 5988.580799344004, 6045.909311360245, 5867.765289388377, 5884.440978107073, 5902.350741418355, 5906.350301466921, 5909.468147866713, 6049.18336024631, 6067.484263837447, 6087.847803804763, 6100.054491553817, 6126.816195514141, 5659.773609055756, 5765.0, 5809.82570522885, 5892.734826932712, 5919.112133179885], "value": 5639.100365058726, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [511.88226707857194, 538.3862396867572, 581.3953488372092, 582.6387639663409, 586.1793489115238, 30480.0, 31070.53394199089, 31089.68910310896, 31103.377932441337, 38870.8056459718, 42371.57628423715, 43034.0, 43049.70850874471, 43090.569094309045, 43205.13589728204, 9614.038596140383, 9850.113489785917, 9858.556364963593, 9874.60501579936, 9876.901230987705, 8741.562921853914, 8902.821943561124, 9489.00365461627, 9607.183389411908, 11818.527258909633, 11696.0, 11730.824037639442, 11738.823917641243, 11756.823647645293, 11769.646910592695, 9453.480058596775, 11507.769844603145, 11518.769624607545, 11530.250533715282, 11535.711607209803, 8693.13068693132, 11712.180147389687, 11834.408279585987, 11845.0, 11879.34663593502, 38964.415533767016, 39606.81179564618, 39611.20777584461, 39710.0, 39772.60227397718, 3264.347130573871, 3277.36091462165, 3296.5549650797316, 3323.302106557626, 3323.8504267307785, 28179.154625361272, 28319.292017699518, 28654.570181447296, 28904.98832540872, 30011.099667010025, 2647.1661426650544, 2660.8270462419882, 2698.5142674318613, 2703.4457936123245, 2751.339678477171, 500135.0, 502356.0, 502455.4877225627, 502833.0, 503776.48111759574, 35828.46257306143, 36791.26417471636, 63970.0, 64387.712245754825, 64494.35505644977, 35933.46099808505, 36004.63995360065, 36163.276734465166, 36176.0, 36250.27499449996, 15480.22598870052, 15639.296231669603, 15643.765343519857, 15651.608709782118, 15676.764848527282, 10670.893291067145, 13239.801402978963, 13294.20234785916, 13302.66743331405, 13318.334083295991, 7696.153423123452, 8257.42198046131, 8318.875216871751, 8364.079951205484, 8398.874016889751, 2995.6105706258045, 3357.8992630221132, 3413.7951722896705, 3416.145963509123, 3435.862565497402, 962.2206013129388, 1009.1926458833051, 1024.882138554061, 1028.9742756430999, 1061.474570087796, 26618.935242590465, 27584.862075689896, 28707.0, 28828.855855720587, 29189.708102919125, 790.632355954484, 1044.93938652268, 1100.9284396514201, 1126.110372805491, 1206.6922934651784, 13477.932610336886, 13832.930835345758, 14034.929825351011, 14103.929480352737, 14384.568462946128, 612975.0, 620659.0, 622385.0, 623306.0, 623383.0, 61489.69255153785, 61951.690241549404, 61980.69009654923, 62032.68983655143, 62093.0, 1322.543722415765, 1461.934212960398, 1478.7781832724747, 1502.646877983673, 1516.9848301517063, 21586.244481443075, 27016.67272012624, 30623.846880765454, 30727.0, 30748.770049198676, 52329.738351308, 52755.73622131865, 53099.0, 53123.46876531185, 53227.0, 519310.0, 524208.0, 524593.0, 525947.0, 525949.0, 23943.76056239485, 27210.91156353803, 27517.0, 27805.582916256677, 27858.721412785613, 41799.7910010448, 42643.78678106589, 43175.9206019852, 43335.783321083196, 43662.34506482469, 29137.56293655639, 29644.258893527833, 34168.97493075212, 35404.64595354014, 35745.64254357527, 33896.49155262722, 35217.82391088131, 35250.823745881105, 35965.0, 36729.63270367262, 36625.63374366222, 37166.0, 37333.0, 37635.81182094072, 37658.43512347372, 32712.672873271913, 32753.637582559277, 32997.67002330042, 33081.66918330786, 33184.0, 24676.876615616806, 24876.875615621808, 25036.74963250344, 25218.74781252164, 25236.74763252344], "value": 18529.193666684307, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [392.73097927919366, 393.3647159836863, 397.3582663997645, 397.63417655756683, 410.4540960522505, 15480.148591827445, 18980.715289270673, 20666.586668266646, 21372.4656883578, 21394.25120120796, 13681.794773078413, 18248.817511824876, 20604.8969755151, 21210.36368908935, 21257.468563285925, 5232.712200828943, 5561.388247292794, 5563.082091454905, 5566.749496272678, 5567.248421463111, 4019.356902895537, 5438.021156191884, 5534.972325138368, 5535.086710692731, 5537.0863807471715, 5802.303723553179, 6166.969165154168, 6175.969120154393, 6181.258249010125, 6183.690815459231, 6145.815625531219, 6171.4445699887, 6192.659403732793, 6274.654893980829, 6713.12729345182, 4758.928616070762, 5949.07789292656, 5987.790427335066, 5989.55078369124, 5991.2510936132985, 13893.305334733222, 14540.345684444226, 18536.62926741471, 26780.0, 26826.463470730476, 2152.763196048433, 2160.7839216078423, 2166.2201607421316, 2207.701960235364, 2235.452314183019, 9798.26513011527, 9979.700608981742, 10401.167906567456, 12239.32683702396, 15363.385464581403, 1717.7337512685428, 1724.6723122606666, 1750.3261244420862, 1787.5977904971278, 1816.3551939061706, 103665.44501832478, 114998.42500787442, 117644.0, 122828.0, 128101.43797124099, 9879.555420006118, 11858.584949526725, 11990.640280791591, 11993.400329983466, 12041.458134383975, 15440.227988600525, 15488.07071575709, 15571.688566228611, 15594.29825657848, 15631.531054068397, 7648.502847314907, 7976.282134607914, 8925.107489251153, 9154.908450915405, 9191.862122068174, 9194.21849142817, 9199.908000919904, 9220.03189665089, 9262.583183756748, 9342.859857102148, 4741.359916411309, 4818.060478206786, 4836.250381190921, 4852.17513022787, 4906.730129842893, 1981.8216360527622, 2008.56815784607, 2014.8186663200383, 2028.4624574487773, 2045.4477291131311, 913.7898283394857, 966.8322814556186, 970.2916870684439, 984.2175470500969, 1054.2198772908146, 20997.580048398948, 21202.681959770616, 21295.254666086923, 21405.35783926485, 21453.0, 917.0, 972.4845831709206, 989.9109080182818, 1009.3590569987964, 1020.7852655340122, 11246.831297530543, 11251.423711447904, 11318.830217546578, 11335.659930202108, 11367.772644547063, 517252.0, 564799.0, 571584.6235508313, 579497.0, 582746.0, 108822.0, 110459.44770276097, 112643.0, 116278.0, 116827.0, 1007.9647212347533, 1015.4110615842793, 1021.7241344836852, 1030.4126647810676, 1033.0599154769125, 18314.908425457787, 18684.0, 18912.716309255648, 18945.526361841064, 19119.904400478466, 52943.0, 53288.46711532835, 53774.731126344115, 55313.89372212614, 55937.72031139981, 45863.77068114638, 71396.0, 74268.0, 81376.59311703403, 85600.57199713962, 7915.604219788872, 8422.578871056545, 8544.316454683487, 8579.056303806452, 8605.182507661762, 9261.67584134552, 11155.609553665583, 11734.823977640513, 12265.816012759995, 12538.310392928111, 9623.470709111067, 10731.302465339728, 10905.34567925927, 11143.777124457627, 11536.0, 10884.183686223407, 10898.78202435931, 11109.222354435113, 11155.995960363607, 11421.543138274375, 6756.628385438848, 7661.770146895602, 9362.251019918254, 11159.218854680095, 11502.775535424164, 8160.102388737116, 8399.496030238206, 8411.53736544496, 8463.111373305961, 8645.95677021611, 9468.0, 10011.949940250252, 11235.943820280847, 11493.195476316578, 11520.769584608428], "value": 9477.673288511274, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1384.1418320641203, 1434.3975530277282, 1590.053917918838, 1807.1596707530996, 1982.7521559805016, 8059.637316320765, 8723.869141962869, 8924.553772311374, 8935.195832375093, 8962.058983806688, 8633.568321583927, 8906.332025098127, 8909.020007799138, 8911.866322005175, 8921.687740929068, 2156.514784173556, 2224.8665080095166, 2393.497365553227, 2439.4755127647554, 2467.383154211447, 2471.666325046123, 2477.752224777517, 2477.9504409911883, 2479.5412848622973, 2484.1181380609896, 2368.6802281691926, 2432.74456182101, 2455.435249892526, 2456.435019945414, 2466.802655787533, 2161.23276236936, 2223.5775202711434, 2226.1763147635315, 2227.3206671965045, 2418.504206637644, 2398.9400264993515, 2466.9259922202364, 2474.480359124586, 2475.789557887582, 2482.32977096183, 8762.0, 8818.779530511725, 8826.249768769661, 8832.955835220782, 8842.602082906285, 4658.580727734487, 5370.812021579226, 5500.4499550045075, 5538.947599955995, 5550.361708403545, 3367.8316084195694, 3454.896353109411, 3507.8070706111153, 3543.1850674345046, 3547.5388199534154, 967.2020583018967, 1041.2138835179392, 1041.5625437316346, 1041.6927006533092, 1062.4581463453694, 10135.0, 12199.207051541622, 12210.450529726184, 12213.877861221452, 12227.510899564008, 4310.4611923509565, 4717.339572459859, 4745.813546613346, 4866.683665561727, 4870.732109733999, 10213.0, 10220.846687299696, 10223.59105635781, 10227.335223210468, 10256.794864102676, 5499.340079190442, 5516.227728118067, 5524.226608274845, 5527.751251193706, 5532.280803495601, 4411.602955733999, 4547.545245475426, 4816.8554943351755, 4938.678985865908, 4951.653384263067, 3574.0, 4032.858849940238, 4041.039349031025, 4068.5524592294823, 4167.624913757776, 1334.1461464662623, 1356.2337279437086, 1361.5506882728675, 1367.5692156970522, 1367.9179249245078, 899.9730008099767, 934.5887809363858, 950.843110886696, 962.0139357158968, 988.0, 5937.970310148508, 6014.879702405928, 6039.033754599243, 6064.393560643988, 6170.5372097092895, 458.532297057, 463.2495357520838, 472.2137640827983, 472.74235541629895, 473.4200604259754, 3946.9210615787524, 3969.206158768258, 4015.277250095011, 4036.59634036594, 4094.8976275592754, 10600.416977066181, 10967.945160274307, 11086.390248536247, 11108.055815255631, 11115.166362522843, 10807.081398081094, 10826.729331766768, 10937.234393592531, 10943.616973405893, 10951.069159121405, 8359.373047021376, 8362.414630975773, 8418.915810841936, 8422.957885210535, 8463.407561470762, 5345.636862600168, 5352.9732351338, 5509.779608815603, 5932.377100404568, 5982.132590774227, 9292.95353523228, 9492.382995105296, 9925.503724813587, 9938.354006989523, 9939.453330066915, 9960.452175130147, 9989.500524973868, 10068.345557538736, 10238.948805256225, 10261.230407719302, 6833.4191593715095, 7033.261507541839, 7317.341439270491, 7623.65693543803, 7724.420668449777, 8362.498250105013, 8392.034915984495, 8415.410921235454, 8422.957885210535, 8428.115047920126, 7303.233160518282, 7492.587907664913, 7516.0, 7557.161485551712, 7647.808804779925, 6123.2652081750475, 7233.63831808418, 7317.524360916524, 7324.48728589015, 7433.256674332523, 6992.825179370557, 7047.647617618996, 7100.076989991268, 7122.7507037253445, 7127.786166415016, 4848.272759086165, 4901.58336541398, 4925.1627223372825, 4996.675216111086, 5063.26582645507, 4936.580390666833, 4975.328330675313, 5036.194208926554, 5101.362329708786, 5255.605829562722], "value": 4543.228324473945, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [315.8657570532523, 320.96629853865346, 330.1432781930889, 330.6775893503836, 334.8309103902529, 6611.702473388697, 6658.76694315699, 6776.796696099119, 6789.660516974144, 6816.591004539725, 6208.8466177604705, 6675.465962722983, 6771.525993180479, 6817.897731534031, 6818.147731533559, 5062.822801201959, 5103.0, 5111.335526381575, 5120.231965205212, 5125.436202017775, 5134.897302053957, 5144.331236939192, 5147.716875571842, 5152.69083854968, 5155.587552995751, 4526.298423744309, 4541.409616749818, 4816.614670826326, 4916.827911023115, 4943.950560494403, 4946.9010619787405, 4985.875353116165, 4989.326440930464, 4990.925136122979, 4992.650514463989, 4273.209456250573, 4283.507396649394, 4301.655867530621, 4303.591158839905, 4321.0, 6549.836254093638, 6587.308332625101, 6596.307387724268, 6608.86782264352, 6612.173478315211, 5981.192539007266, 5993.490553302974, 5994.220751302347, 5996.730147143389, 6025.517958563304, 6954.756583519553, 7249.528780629243, 7263.854722905565, 7267.127944646623, 7280.526765760262, 4612.146752850734, 4798.49615790344, 4834.564889159992, 4836.056968891067, 4848.490908454632, 6679.833004174886, 7312.670929808171, 7579.4694371394025, 7663.27198916102, 7688.5386876787015, 4770.165221086366, 4840.927386089212, 4854.077725232195, 4854.635902307341, 4868.391451068616, 4963.70217786934, 4983.501649834988, 5008.774605142778, 5011.223260394645, 5013.724245166478, 5958.225430694069, 5961.7615295387695, 5969.194158788595, 5974.193483879708, 5974.492168165754, 7250.1299844018, 7268.0, 7273.12722473296, 7280.68947589439, 7292.19785823559, 1602.9519114426587, 1662.3599914033184, 1664.4756901575965, 1666.4000959654516, 1700.7703959965247, 872.2716531695978, 1041.7239431550645, 1052.9105026072716, 1061.0768631290673, 1064.6805958212506, 6825.453963682893, 6840.6921688524135, 6848.3494068063455, 6862.553933994274, 6867.450603951672, 7536.434767392468, 7550.546967181876, 7554.093508778872, 7568.318851303409, 7580.1661817200065, 5622.875424915033, 6781.694823732944, 6819.352161544645, 6820.215675197316, 6840.589564626139, 3728.198437335986, 3836.1176929306416, 3955.268275369066, 3984.6850539322536, 3994.8601798936897, 7861.882071768928, 7917.564533950688, 7925.661929730743, 7935.0874649416055, 7972.0, 7745.10931242903, 7791.922080779233, 7800.219978002155, 7814.765557033298, 7818.68725250995, 7897.763067107996, 7902.4863383879865, 7903.920960790433, 7908.01149856268, 7911.0, 7250.166230883305, 7468.141163766237, 7535.510191837513, 7550.509216900884, 7557.130929943127, 7325.6337183141695, 7395.926040739739, 7396.593187374746, 7399.260073992557, 7408.444366672629, 7872.252136047066, 7882.605869706606, 7885.29032387088, 7894.407919405952, 7907.525548467111, 4573.81704731807, 4680.4149481314835, 4683.4614019386845, 4767.308740232716, 4789.592884604847, 7111.608861512666, 7404.481686281909, 7406.555606663617, 7429.7399591014055, 7486.8876966844455, 6164.537659675632, 7127.893081603884, 7179.784606461814, 7313.268673132644, 7324.0, 7270.563766174047, 7311.817204569716, 7313.524620899837, 7315.30504602062, 7318.926810731825, 6457.999010153434, 6531.281559028598, 6776.356246156607, 7094.290570943071, 7170.89243661356, 7026.437884969088, 7329.863871099988, 7334.0, 7350.70597176107, 7352.2280160584505, 6117.0, 6856.4514838813775, 7115.644217789193, 7160.8925866113095, 7167.211606723361], "value": 5301.179392500644, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [608.9391060893911, 692.214336727814, 737.7971057959057, 758.1357252731887, 760.4034996406178, 14931.925340373296, 15040.473583424582, 15344.53966381009, 15429.922850385732, 15450.61373465664, 13601.727965440685, 13804.03371763977, 13824.585262442142, 13876.514321998731, 13967.860321396784, 726.6112629743088, 732.209214048826, 883.4390162246988, 895.7133717210463, 905.8731777551149, 889.937704360695, 905.9365844390895, 910.1080940678139, 910.6357457017212, 913.5797533134765, 938.015084161631, 967.8306296398138, 968.6173961285288, 968.990310096897, 970.1365784451843, 759.965801538932, 933.1182032978837, 959.52023988006, 960.2318145483586, 960.9615615375377, 706.1737766812842, 706.4524993130314, 708.6208878250163, 713.4969846258375, 723.4574069447914, 15243.542693719206, 15277.6180595486, 15315.693686126215, 15339.693206135926, 15342.386304547805, 12888.291143987077, 12926.482940682456, 13013.0, 13039.413226404835, 13312.733745325038, 9988.300818942676, 10109.292349535535, 10311.639092631796, 10512.789744205149, 10607.946960265226, 3450.102973226954, 3525.6121826599056, 3541.752077354586, 3565.3760591896316, 3567.5897271813815, 81062.0, 81311.18688813095, 81734.9999999994, 84236.0, 84866.57566712188, 9388.202002829836, 9536.86050206552, 9678.661246856327, 9877.728122531715, 10024.997500250063, 21451.67822482664, 21719.782802171776, 21733.45666358322, 22166.0, 22211.77788222097, 7241.5293005954445, 7507.962460187664, 7696.307332340116, 7781.338586220235, 7818.061832580127, 4037.6366127048705, 4050.3519436889956, 4144.606262405066, 4145.751254924714, 4168.124693814272, 3511.701505372072, 3751.043483911585, 3752.249550089993, 3753.0, 3754.4556039374684, 557.2950217974266, 644.1304239276939, 653.8068025852838, 654.1659384285075, 685.6297599296424, 505.33800721055536, 540.3461811208482, 559.8628336057692, 560.5347561523926, 580.6661169827366, 7761.0, 7883.36933045355, 7919.168487308865, 7956.840863182704, 7994.5203287802915, 555.6582701638463, 556.8218170185582, 558.6340946679932, 577.9046457334576, 578.9131630255496, 3722.683571896419, 3784.2242340320718, 3791.450239715226, 3806.352920003606, 3860.285847118236, 85825.57087214524, 85975.0, 86973.0, 87364.25271494534, 87569.56215218882, 77128.84306735291, 78609.21390786134, 80511.98720032047, 81153.59423202847, 81642.55072347839, 69099.65450172717, 69833.0, 71500.2849971504, 71781.64109179525, 72212.63893680499, 7426.331630153096, 7593.0, 7646.923530764621, 7647.961760191163, 7779.649915753692, 36230.818845905604, 46071.0, 46497.53502465067, 46939.295910560686, 47204.52795472001, 63302.41743956438, 67871.0, 67978.0, 69418.30581694118, 69472.30527694659, 9514.524273786421, 9640.90359096428, 9645.565949532147, 9882.0, 9966.302358834811, 10238.948805255926, 10394.677256418343, 10453.9477302613, 10593.245636728978, 10618.203634727271, 9843.360181588174, 9871.605135794487, 9919.15687166599, 9998.600055997678, 10309.381437113798, 8954.328425367994, 9601.951990240284, 9967.750806229902, 10076.69769906904, 10228.693139205836, 9710.514474276117, 9714.514274286115, 9770.658026969022, 9814.607415703293, 10244.897551024394, 8371.95814020926, 8449.746507604781, 8579.313654907717, 8613.526256055726, 9048.366614336934, 8340.87488687658, 8462.153784621734, 8617.310615150647, 8659.13408659129, 8735.737927862174], "value": 6685.710592897439, "unit": "score"}], "name": "dromaeo_css", "value": 7364.013924422158, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 111.0, 120.0, 111.0, 112.0, 110.0, 110.0, 112.0, 112.0, 133.0], "value": 114.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 120.0, 161.0, 159.0, 122.0, 143.0, 120.0, 149.0, 157.0, 116.0], "value": 140.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 187.0, 186.0, 184.0, 183.0, 205.0, 258.0, 253.0, 184.0, 185.0], "value": 201.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 78.0, 75.0, 151.0, 55.0, 55.0, 57.0, 63.0, 130.0, 54.0], "value": 78.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 90.0, 146.0, 77.0, 79.0, 81.0, 126.0, 78.0, 78.0, 125.0], "value": 96.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 87.0, 89.0, 87.0, 88.0, 85.0, 88.0, 86.0, 89.0, 84.0], "value": 87.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 95.0, 94.0, 94.0, 94.0, 95.0, 95.0, 94.0, 94.0], "value": 94.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 87.0, 85.0, 83.0, 84.0, 84.0, 83.0, 85.0, 86.0], "value": 84.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 63.0, 65.0, 66.0, 66.0, 64.0, 63.0, 83.0, 58.0, 58.0], "value": 64.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 68.0, 75.0, 75.0, 71.0, 66.0, 66.0, 68.0, 68.0], "value": 68.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 79.0, 81.0, 80.0, 79.0, 81.0, 81.0, 81.0, 81.0, 84.0], "value": 80.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 137.0, 141.0, 152.0, 130.0, 144.0, 140.0, 141.0, 155.0, 172.0], "value": 145.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 166.0, 166.0, 180.0, 165.0, 166.0, 164.0, 166.0, 170.0, 166.0], "value": 167.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 67.0, 69.0, 69.0, 67.0, 68.0, 73.0, 94.0, 95.0, 95.0], "value": 76.5, "unit": "score"}], "name": "kraken", "value": 1500.6000000000001, "alertThreshold": 2.0}]} 10:35:46 INFO - Return code: 0 10:35:46 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 10:35:46 ERROR - # TBPL SUCCESS # 10:35:46 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:35:46 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:35:46 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:35:46 INFO - 2016-06-01 10:35:46.484 screenresolution[1678:9605] starting screenresolution argv=screenresolution get 10:35:46 INFO - 2016-06-01 10:35:46.487 screenresolution[1678:9605] Display 0: 1600x1200x32@60 10:35:46 INFO - 2016-06-01 10:35:46.492 screenresolution[1679:9608] starting screenresolution argv=screenresolution list 10:35:46 INFO - Available Modes on Display 0 10:35:46 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:35:46 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:35:46 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:35:46 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:35:46 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:35:46 INFO - Intel Iris: 10:35:46 INFO - Chipset Model: Intel Iris 10:35:46 INFO - Type: GPU 10:35:46 INFO - Bus: Built-In 10:35:46 INFO - VRAM (Dynamic, Max): 1536 MB 10:35:46 INFO - Vendor: Intel (0x8086) 10:35:46 INFO - Device ID: 0x0a2e 10:35:46 INFO - Revision ID: 0x0009 10:35:46 INFO - Displays: 10:35:46 INFO - Display: 10:35:46 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:35:46 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:35:46 INFO - Display Serial Number: 1600x1200 60 10:35:46 INFO - Main Display: Yes 10:35:46 INFO - Mirror: Off 10:35:46 INFO - Online: Yes 10:35:46 INFO - Rotation: Supported 10:35:46 INFO - Return code: 0 10:35:46 INFO - Running post-action listener: _resource_record_post_action 10:35:46 INFO - Running post-run listener: _resource_record_post_run 10:35:47 INFO - Total resource usage - Wall time: 1208s; CPU: 53.0%; Read bytes: 37750272; Write bytes: 653081600; Read time: 393; Write time: 1907 10:35:47 INFO - install - Wall time: 32s; CPU: 55.0%; Read bytes: 354808320; Write bytes: 356329472; Read time: 27601; Write time: 729 10:35:47 INFO - run-tests - Wall time: 1176s; CPU: 52.0%; Read bytes: 35907072; Write bytes: 295744512; Read time: 372; Write time: 1175 10:35:47 INFO - Running post-run listener: _upload_blobber_files 10:35:47 INFO - Blob upload gear active. 10:35:47 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:35:47 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 10:35:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 10:35:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 10:35:48 INFO - (blobuploader) - INFO - Open directory for files ... 10:35:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:35:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:35:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:35:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:35:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:35:49 INFO - (blobuploader) - INFO - Done attempting. 10:35:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:35:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:35:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:35:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:35:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:35:50 INFO - (blobuploader) - INFO - Done attempting. 10:35:50 INFO - (blobuploader) - INFO - Iteration through files over. 10:35:50 INFO - Return code: 0 10:35:50 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:35:50 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:35:50 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/46c01d082e18d015b8bfcdef0432ddeca8a2c07857f2ea2931987e9eac94fa62bba92702a7ad329bf1a31d414425dd3e056ea4049479e194c1000a3c1ee2ee7c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f45878afd6682192b42df4f39cc6b22603e8eeab6f706d7c0c8e212bb5bad23d9cb377836630d83aafacfddab566f33f325f8e3a3a8e86088decd994d2e49adf"} 10:35:50 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:35:50 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:35:50 INFO - Contents: 10:35:50 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/46c01d082e18d015b8bfcdef0432ddeca8a2c07857f2ea2931987e9eac94fa62bba92702a7ad329bf1a31d414425dd3e056ea4049479e194c1000a3c1ee2ee7c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f45878afd6682192b42df4f39cc6b22603e8eeab6f706d7c0c8e212bb5bad23d9cb377836630d83aafacfddab566f33f325f8e3a3a8e86088decd994d2e49adf"} 10:35:50 INFO - Running post-run listener: copy_logs_to_upload_dir 10:35:50 INFO - Copying logs to upload dir... 10:35:50 INFO - mkdir: /builds/slave/test/build/upload/logs 10:35:50 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1265.216658 ========= master_lag: 1.55 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2016-06-01 10:35:52.107358) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-01 10:35:52.116143) ========= 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.M0J35WJCyP/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.jyQSIvpA7G/Listeners TMPDIR=/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/46c01d082e18d015b8bfcdef0432ddeca8a2c07857f2ea2931987e9eac94fa62bba92702a7ad329bf1a31d414425dd3e056ea4049479e194c1000a3c1ee2ee7c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f45878afd6682192b42df4f39cc6b22603e8eeab6f706d7c0c8e212bb5bad23d9cb377836630d83aafacfddab566f33f325f8e3a3a8e86088decd994d2e49adf"} build_url:https://queue.taskcluster.net/v1/task/S_XAoOD-RwCQDHOoKK9imA/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011082 build_url: 'https://queue.taskcluster.net/v1/task/S_XAoOD-RwCQDHOoKK9imA/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/46c01d082e18d015b8bfcdef0432ddeca8a2c07857f2ea2931987e9eac94fa62bba92702a7ad329bf1a31d414425dd3e056ea4049479e194c1000a3c1ee2ee7c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f45878afd6682192b42df4f39cc6b22603e8eeab6f706d7c0c8e212bb5bad23d9cb377836630d83aafacfddab566f33f325f8e3a3a8e86088decd994d2e49adf"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-01 10:35:52.152115) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-01 10:35:52.152469) ========= 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.M0J35WJCyP/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.jyQSIvpA7G/Listeners TMPDIR=/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/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.005200 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-01 10:35:52.202364) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-01 10:35:52.202702) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-01 10:35:52.203050) ========= ========= Total master_lag: 1.68 =========