builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0373 starttime: 1463424647.37 results: success (0) buildid: 20160516095902 builduid: 119e0603021d484e8dc9eed77b91182d revision: de80d1838a8db73172f7c09f57a3ecc0267f47e5 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-16 11:50:47.374362) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-16 11:50:47.374774) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-16 11:50:47.375054) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-16 11:50:47.395568) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-16 11:50:47.395913) ========= 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.yQGdPv9ht4/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.ZTaiaekecT/Listeners TMPDIR=/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-05-16 11:50:47-- 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% 156M=0s 2016-05-16 11:50:47 (156 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.115476 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-16 11:50:47.528290) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-16 11:50:47.528623) ========= 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.yQGdPv9ht4/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.ZTaiaekecT/Listeners TMPDIR=/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/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.025503 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-16 11:50:47.577031) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-16 11:50:47.577410) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev de80d1838a8db73172f7c09f57a3ecc0267f47e5 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev de80d1838a8db73172f7c09f57a3ecc0267f47e5 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.yQGdPv9ht4/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.ZTaiaekecT/Listeners TMPDIR=/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-05-16 11:50:47,663 truncating revision to first 12 chars 2016-05-16 11:50:47,663 Setting DEBUG logging. 2016-05-16 11:50:47,663 attempt 1/10 2016-05-16 11:50:47,663 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/de80d1838a8d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-16 11:50:48,619 unpacking tar archive at: fx-team-de80d1838a8d/testing/mozharness/ program finished with exit code 0 elapsedTime=1.202273 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-16 11:50:48.797629) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-16 11:50:48.797978) ========= script_repo_revision: de80d1838a8db73172f7c09f57a3ecc0267f47e5 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-16 11:50:48.798463) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-16 11:50:48.798737) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-16 11:50:48.812712) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2016-05-16 11:50:48.813014) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.yQGdPv9ht4/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.ZTaiaekecT/Listeners TMPDIR=/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/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 11:50:48 INFO - MultiFileLogger online at 20160516 11:50:48 in /builds/slave/test 11:50:48 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 11:50:48 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:50:48 INFO - {'append_to_log': False, 11:50:48 INFO - 'base_work_dir': '/builds/slave/test', 11:50:48 INFO - 'blob_upload_branch': 'Fx-Team', 11:50:48 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:50:48 INFO - 'branch': 'Fx-Team', 11:50:48 INFO - 'buildbot_json_path': 'buildprops.json', 11:50:48 INFO - 'config_files': ('talos/mac_config.py',), 11:50:48 INFO - 'default_actions': ('clobber', 11:50:48 INFO - 'read-buildbot-config', 11:50:48 INFO - 'download-and-extract', 11:50:48 INFO - 'populate-webroot', 11:50:48 INFO - 'create-virtualenv', 11:50:48 INFO - 'install', 11:50:48 INFO - 'run-tests'), 11:50:48 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:50:49 INFO - 'download_minidump_stackwalk': True, 11:50:49 INFO - 'download_symbols': 'ondemand', 11:50:49 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:50:49 INFO - 'tooltool.py': '/tools/tooltool.py', 11:50:49 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:50:49 INFO - '/tools/misc-python/virtualenv.py')}, 11:50:49 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:50:49 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:50:49 INFO - 'installer_path': 'installer.exe', 11:50:49 INFO - 'log_level': 'info', 11:50:49 INFO - 'log_name': 'talos', 11:50:49 INFO - 'log_to_console': True, 11:50:49 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 11:50:49 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 11:50:49 INFO - 'opt_config_files': (), 11:50:49 INFO - 'pip_index': False, 11:50:49 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 11:50:49 INFO - 'cmd': ('bash', 11:50:49 INFO - '-c', 11:50:49 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 11:50:49 INFO - 'enabled': True, 11:50:49 INFO - 'halt_on_failure': False, 11:50:49 INFO - 'name': 'check_screen_resolution'},), 11:50:49 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 11:50:49 INFO - 'cmd': ('bash', 11:50:49 INFO - '-c', 11:50:49 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 11:50:49 INFO - 'enabled': True, 11:50:49 INFO - 'halt_on_failure': False, 11:50:49 INFO - 'name': 'check_screen_resolution'},), 11:50:49 INFO - 'run_cmd_checks_enabled': True, 11:50:49 INFO - 'sps_profile': False, 11:50:49 INFO - 'sps_profile_interval': 0, 11:50:49 INFO - 'suite': 'dromaeojs-e10s', 11:50:49 INFO - 'system_bits': '32', 11:50:49 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:50:49 INFO - 'title': 't-yosemite-r7-0373', 11:50:49 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:50:49 INFO - 'use_talos_json': True, 11:50:49 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:50:49 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:50:49 INFO - 'work_dir': 'build'} 11:50:49 INFO - ##### 11:50:49 INFO - ##### Running clobber step. 11:50:49 INFO - ##### 11:50:49 INFO - Running pre-action listener: _resource_record_pre_action 11:50:49 INFO - Running main action method: clobber 11:50:49 INFO - rmtree: /builds/slave/test/build 11:50:49 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:50:50 INFO - Running post-action listener: _resource_record_post_action 11:50:50 INFO - ##### 11:50:50 INFO - ##### Finished clobber step (success) 11:50:50 INFO - ##### 11:50:50 INFO - ##### 11:50:50 INFO - ##### Running read-buildbot-config step. 11:50:50 INFO - ##### 11:50:50 INFO - Running pre-action listener: _resource_record_pre_action 11:50:50 INFO - Running main action method: read_buildbot_config 11:50:50 INFO - Using buildbot properties: 11:50:50 INFO - { 11:50:50 INFO - "project": "", 11:50:50 INFO - "product": "firefox", 11:50:50 INFO - "script_repo_revision": "production", 11:50:50 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 11:50:50 INFO - "repository": "", 11:50:50 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 11:50:50 INFO - "buildid": "20160516095902", 11:50:50 INFO - "pgo_build": "False", 11:50:50 INFO - "basedir": "/builds/slave/test", 11:50:50 INFO - "buildnumber": 10, 11:50:50 INFO - "slavename": "t-yosemite-r7-0373", 11:50:50 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 11:50:50 INFO - "platform": "yosemite_r7", 11:50:50 INFO - "scheduler": "tests-fx-team-macosx64-talos-7-3600", 11:50:50 INFO - "branch": "fx-team", 11:50:50 INFO - "repo_path": "integration/fx-team", 11:50:50 INFO - "revision": "de80d1838a8db73172f7c09f57a3ecc0267f47e5", 11:50:50 INFO - "stage_platform": "macosx64", 11:50:50 INFO - "builduid": "119e0603021d484e8dc9eed77b91182d", 11:50:50 INFO - "slavebuilddir": "test" 11:50:50 INFO - } 11:50:50 INFO - Found installer url https://queue.taskcluster.net/v1/task/I8C8TsMyTcyE0Dh8RKS1Cg/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg. 11:50:50 INFO - Running post-action listener: _resource_record_post_action 11:50:50 INFO - ##### 11:50:50 INFO - ##### Finished read-buildbot-config step (success) 11:50:50 INFO - ##### 11:50:50 INFO - ##### 11:50:50 INFO - ##### Running download-and-extract step. 11:50:50 INFO - ##### 11:50:50 INFO - Running pre-action listener: _resource_record_pre_action 11:50:50 INFO - Running main action method: download_and_extract 11:50:50 INFO - mkdir: /builds/slave/test/build/tests 11:50:50 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')]} 11:50:50 INFO - https://queue.taskcluster.net/v1/task/I8C8TsMyTcyE0Dh8RKS1Cg/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 11:50:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I8C8TsMyTcyE0Dh8RKS1Cg/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json 11:50:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I8C8TsMyTcyE0Dh8RKS1Cg/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json 11:50:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I8C8TsMyTcyE0Dh8RKS1Cg/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.mac.test_packages.json 11:50:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I8C8TsMyTcyE0Dh8RKS1Cg/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.mac.test_packages.json'}, attempt #1 11:50:52 INFO - Downloaded 1199 bytes. 11:50:52 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.mac.test_packages.json 11:50:52 INFO - Using the following test package requirements: 11:50:52 INFO - {u'common': [u'firefox-49.0a1.en-US.mac.common.tests.zip'], 11:50:52 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 11:50:52 INFO - u'firefox-49.0a1.en-US.mac.cppunittest.tests.zip'], 11:50:52 INFO - u'gtest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 11:50:52 INFO - u'firefox-49.0a1.en-US.mac.gtest.tests.zip'], 11:50:52 INFO - u'jittest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 11:50:52 INFO - u'jsshell-mac.zip'], 11:50:52 INFO - u'mochitest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 11:50:52 INFO - u'firefox-49.0a1.en-US.mac.mochitest.tests.zip'], 11:50:52 INFO - u'mozbase': [u'firefox-49.0a1.en-US.mac.common.tests.zip'], 11:50:52 INFO - u'reftest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 11:50:52 INFO - u'firefox-49.0a1.en-US.mac.reftest.tests.zip'], 11:50:52 INFO - u'talos': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 11:50:52 INFO - u'firefox-49.0a1.en-US.mac.talos.tests.zip'], 11:50:52 INFO - u'web-platform': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 11:50:52 INFO - u'firefox-49.0a1.en-US.mac.web-platform.tests.zip'], 11:50:52 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 11:50:52 INFO - u'firefox-49.0a1.en-US.mac.xpcshell.tests.zip']} 11:50:52 INFO - Downloading packages: [u'firefox-49.0a1.en-US.mac.common.tests.zip'] for test suite category: common 11:50:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:50:52 INFO - https://queue.taskcluster.net/v1/task/I8C8TsMyTcyE0Dh8RKS1Cg/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 11:50:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I8C8TsMyTcyE0Dh8RKS1Cg/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 11:50:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I8C8TsMyTcyE0Dh8RKS1Cg/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 11:50:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I8C8TsMyTcyE0Dh8RKS1Cg/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip 11:50:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I8C8TsMyTcyE0Dh8RKS1Cg/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip'}, attempt #1 11:50:53 INFO - Downloaded 18267620 bytes. 11:50:53 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:50:53 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 11:50:56 INFO - Return code: 0 11:50:56 INFO - Downloading packages: [u'firefox-49.0a1.en-US.mac.common.tests.zip', u'firefox-49.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 11:50:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:50:56 INFO - https://queue.taskcluster.net/v1/task/I8C8TsMyTcyE0Dh8RKS1Cg/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 11:50:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I8C8TsMyTcyE0Dh8RKS1Cg/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 11:50:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I8C8TsMyTcyE0Dh8RKS1Cg/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 11:50:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I8C8TsMyTcyE0Dh8RKS1Cg/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip 11:50:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I8C8TsMyTcyE0Dh8RKS1Cg/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip'}, attempt #1 11:50:57 INFO - Downloaded 18267620 bytes. 11:50:57 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:50:57 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 11:51:00 INFO - Return code: 0 11:51:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:51:00 INFO - https://queue.taskcluster.net/v1/task/I8C8TsMyTcyE0Dh8RKS1Cg/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 11:51:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I8C8TsMyTcyE0Dh8RKS1Cg/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip 11:51:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I8C8TsMyTcyE0Dh8RKS1Cg/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip 11:51:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I8C8TsMyTcyE0Dh8RKS1Cg/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.mac.talos.tests.zip 11:51:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I8C8TsMyTcyE0Dh8RKS1Cg/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.talos.tests.zip'}, attempt #1 11:51:01 INFO - Downloaded 10840194 bytes. 11:51:01 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:51:01 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 11:51:02 INFO - Return code: 0 11:51:02 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')]} 11:51:02 INFO - https://queue.taskcluster.net/v1/task/I8C8TsMyTcyE0Dh8RKS1Cg/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 11:51:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I8C8TsMyTcyE0Dh8RKS1Cg/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 11:51:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I8C8TsMyTcyE0Dh8RKS1Cg/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 11:51:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I8C8TsMyTcyE0Dh8RKS1Cg/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-49.0a1.en-US.mac.dmg 11:51:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I8C8TsMyTcyE0Dh8RKS1Cg/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.mac.dmg'}, attempt #1 11:51:05 INFO - Downloaded 110049116 bytes. 11:51:05 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/I8C8TsMyTcyE0Dh8RKS1Cg/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 11:51:05 INFO - mkdir: /builds/slave/test/properties 11:51:05 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:51:05 INFO - Writing to file /builds/slave/test/properties/build_url 11:51:05 INFO - Contents: 11:51:05 INFO - build_url:https://queue.taskcluster.net/v1/task/I8C8TsMyTcyE0Dh8RKS1Cg/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 11:51:06 INFO - Running post-action listener: _resource_record_post_action 11:51:06 INFO - Running post-action listener: set_extra_try_arguments 11:51:06 INFO - ##### 11:51:06 INFO - ##### Finished download-and-extract step (success) 11:51:06 INFO - ##### 11:51:06 INFO - ##### 11:51:06 INFO - ##### Running populate-webroot step. 11:51:06 INFO - ##### 11:51:06 INFO - Running pre-action listener: _resource_record_pre_action 11:51:06 INFO - Running main action method: populate_webroot 11:51:06 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:51:06 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:51:06 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:51:06 INFO - '--tppagecycles', 11:51:06 INFO - '7'], 11:51:06 INFO - 'tests': ['tsvgm']}}, 11:51:06 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:51:06 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:51:06 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:51:06 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:51:06 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:51:06 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:51:06 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:51:06 INFO - 'talos_options': ['--disable-e10s'], 11:51:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:51:06 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:51:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:51:06 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:51:06 INFO - 'talos_options': ['--disable-e10s'], 11:51:06 INFO - 'tests': ['damp', 'tps']}, 11:51:06 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:51:06 INFO - 'tests': ['damp', 'tps']}, 11:51:06 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:51:06 INFO - 'tests': ['dromaeo_dom']}, 11:51:06 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:51:06 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:51:06 INFO - 'tests': ['a11yr', 11:51:06 INFO - 'ts_paint', 11:51:06 INFO - 'tpaint', 11:51:06 INFO - 'sessionrestore', 11:51:06 INFO - 'sessionrestore_no_auto_restore', 11:51:06 INFO - 'tabpaint']}, 11:51:06 INFO - 'other-e10s': {'tests': ['a11yr', 11:51:06 INFO - 'ts_paint', 11:51:06 INFO - 'tpaint', 11:51:06 INFO - 'sessionrestore', 11:51:06 INFO - 'sessionrestore_no_auto_restore', 11:51:06 INFO - 'tabpaint']}, 11:51:06 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:51:06 INFO - 'ts_paint', 11:51:06 INFO - 'tpaint', 11:51:06 INFO - 'sessionrestore', 11:51:06 INFO - 'sessionrestore_no_auto_restore', 11:51:06 INFO - 'tabpaint']}, 11:51:06 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:51:06 INFO - 'ts_paint', 11:51:06 INFO - 'tpaint', 11:51:06 INFO - 'sessionrestore', 11:51:06 INFO - 'sessionrestore_no_auto_restore', 11:51:06 INFO - 'tabpaint']}, 11:51:06 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:51:06 INFO - 'tests': ['a11yr', 11:51:06 INFO - 'ts_paint', 11:51:06 INFO - 'tpaint', 11:51:06 INFO - 'sessionrestore', 11:51:06 INFO - 'sessionrestore_no_auto_restore', 11:51:06 INFO - 'tabpaint']}, 11:51:06 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:51:06 INFO - 'tests': ['a11yr', 11:51:06 INFO - 'ts_paint', 11:51:06 INFO - 'tpaint', 11:51:06 INFO - 'sessionrestore', 11:51:06 INFO - 'sessionrestore_no_auto_restore', 11:51:06 INFO - 'tabpaint']}, 11:51:06 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:51:06 INFO - 'tests': ['tsvgx', 11:51:06 INFO - 'tsvgr_opacity', 11:51:06 INFO - 'tart', 11:51:06 INFO - 'tscrollx', 11:51:06 INFO - 'cart']}, 11:51:06 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:51:06 INFO - 'tsvgr_opacity', 11:51:06 INFO - 'tart', 11:51:06 INFO - 'tscrollx', 11:51:06 INFO - 'cart']}, 11:51:06 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:51:06 INFO - 'talos_options': ['--disable-e10s'], 11:51:06 INFO - 'tests': ['tp5o']}, 11:51:06 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:51:06 INFO - 'tests': ['tp5o']}, 11:51:06 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:51:06 INFO - 'talos_options': ['--disable-e10s', 11:51:06 INFO - '--xperf_path', 11:51:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:51:06 INFO - 'tests': ['tp5n']}, 11:51:06 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:51:06 INFO - 'talos_options': ['--xperf_path', 11:51:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:51:06 INFO - 'tests': ['tp5n']}}, 11:51:06 INFO - 'talos.zip': {'path': '', 11:51:06 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:51:06 INFO - Running post-action listener: _resource_record_post_action 11:51:06 INFO - ##### 11:51:06 INFO - ##### Finished populate-webroot step (success) 11:51:06 INFO - ##### 11:51:06 INFO - ##### 11:51:06 INFO - ##### Running create-virtualenv step. 11:51:06 INFO - ##### 11:51:06 INFO - Running pre-action listener: _resource_record_pre_action 11:51:06 INFO - Running main action method: create_virtualenv 11:51:06 INFO - Creating virtualenv /builds/slave/test/build/venv 11:51:06 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 11:51:06 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:51:06 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:51:06 INFO - Using real prefix '/tools/python27' 11:51:06 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:51:07 INFO - Installing distribute.............................................................................................................................................................................................done. 11:51:10 INFO - Installing pip.................done. 11:51:10 INFO - Return code: 0 11:51:10 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:51: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')]} 11:51:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:51:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:51: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')]} 11:51:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:51:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:51:10 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 0x105d7aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105d80570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe5225856f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105c1ed30>, '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 0x105a42db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105c15b20>, '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.yQGdPv9ht4/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.ZTaiaekecT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/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 11:51:10 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 11:51:10 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 11:51:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yQGdPv9ht4/Render', 11:51:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:51:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:51:10 INFO - 'HOME': '/Users/cltbld', 11:51:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:51:10 INFO - 'LOGNAME': 'cltbld', 11:51:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:51:10 INFO - 'MOZ_NO_REMOTE': '1', 11:51:10 INFO - 'NO_EM_RESTART': '1', 11:51:10 INFO - 'PAGER': '/bin/cat', 11:51:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:51:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:51:10 INFO - 'PWD': '/builds/slave/test', 11:51:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:51:10 INFO - 'SHELL': '/bin/bash', 11:51:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZTaiaekecT/Listeners', 11:51:10 INFO - 'TMPDIR': '/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/', 11:51:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:51:10 INFO - 'USER': 'cltbld', 11:51:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:51:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:51:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:51:10 INFO - 'XPC_FLAGS': '0x0', 11:51:10 INFO - 'XPC_SERVICE_NAME': '0', 11:51:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:51:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:51:10 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 11:51:10 INFO - Cleaning up... 11:51:10 INFO - Return code: 0 11:51:10 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:51: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')]} 11:51:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:51:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:51: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')]} 11:51:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:51:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:51:10 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>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x105d7aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105d80570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe5225856f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105c1ed30>, '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 0x105a42db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105c15b20>, '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.yQGdPv9ht4/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.ZTaiaekecT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/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 11:51:10 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>=3.1.1'] in /builds/slave/test/build 11:51:10 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>=3.1.1 11:51:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yQGdPv9ht4/Render', 11:51:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:51:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:51:10 INFO - 'HOME': '/Users/cltbld', 11:51:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:51:10 INFO - 'LOGNAME': 'cltbld', 11:51:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:51:10 INFO - 'MOZ_NO_REMOTE': '1', 11:51:10 INFO - 'NO_EM_RESTART': '1', 11:51:10 INFO - 'PAGER': '/bin/cat', 11:51:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:51:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:51:10 INFO - 'PWD': '/builds/slave/test', 11:51:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:51:10 INFO - 'SHELL': '/bin/bash', 11:51:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZTaiaekecT/Listeners', 11:51:10 INFO - 'TMPDIR': '/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/', 11:51:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:51:10 INFO - 'USER': 'cltbld', 11:51:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:51:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:51:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:51:10 INFO - 'XPC_FLAGS': '0x0', 11:51:10 INFO - 'XPC_SERVICE_NAME': '0', 11:51:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:51:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:51:11 INFO - Downloading/unpacking psutil>=3.1.1 11:51:11 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 11:51:11 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 11:51:11 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 11:51:11 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 11:51:11 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 11:51:11 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 11:51:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:51:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:51:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:51:14 INFO - Installing collected packages: psutil 11:51:14 INFO - Running setup.py install for psutil 11:51:14 INFO - building 'psutil._psutil_osx' extension 11:51:14 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 11:51:14 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 11:51:14 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 11:51:14 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 11:51:14 INFO - building 'psutil._psutil_posix' extension 11:51:14 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 11:51:14 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 11:51:14 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 11:51:14 INFO - ^ 11:51:15 INFO - 1 warning generated. 11:51:15 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 11:51:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:51:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:51:15 INFO - Successfully installed psutil 11:51:15 INFO - Cleaning up... 11:51:15 INFO - Return code: 0 11:51:15 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:51: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')]} 11:51:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:51:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:51: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')]} 11:51:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:51:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:51: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x105d7aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105d80570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe5225856f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105c1ed30>, '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 0x105a42db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105c15b20>, '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.yQGdPv9ht4/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.ZTaiaekecT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/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 11:51: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 11:51: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 mozsystemmonitor==0.3 11:51:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yQGdPv9ht4/Render', 11:51:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:51:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:51:15 INFO - 'HOME': '/Users/cltbld', 11:51:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:51:15 INFO - 'LOGNAME': 'cltbld', 11:51:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:51:15 INFO - 'MOZ_NO_REMOTE': '1', 11:51:15 INFO - 'NO_EM_RESTART': '1', 11:51:15 INFO - 'PAGER': '/bin/cat', 11:51:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:51:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:51:15 INFO - 'PWD': '/builds/slave/test', 11:51:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:51:15 INFO - 'SHELL': '/bin/bash', 11:51:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZTaiaekecT/Listeners', 11:51:15 INFO - 'TMPDIR': '/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/', 11:51:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:51:15 INFO - 'USER': 'cltbld', 11:51:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:51:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:51:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:51:15 INFO - 'XPC_FLAGS': '0x0', 11:51:15 INFO - 'XPC_SERVICE_NAME': '0', 11:51:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:51:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:51:15 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:51: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 11:51: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 11:51: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 11:51: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 11:51: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 11:51: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 11:51:17 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:51:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:51:18 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:51:18 INFO - Installing collected packages: mozsystemmonitor 11:51:18 INFO - Running setup.py install for mozsystemmonitor 11:51:18 INFO - Successfully installed mozsystemmonitor 11:51:18 INFO - Cleaning up... 11:51:18 INFO - Return code: 0 11:51:18 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:51:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:51:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:51:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:51:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:51:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:51:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:51:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x105d7aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105d80570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe5225856f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105c1ed30>, '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 0x105a42db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105c15b20>, '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.yQGdPv9ht4/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.ZTaiaekecT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/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 11:51:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 11:51:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 11:51:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yQGdPv9ht4/Render', 11:51:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:51:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:51:18 INFO - 'HOME': '/Users/cltbld', 11:51:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:51:18 INFO - 'LOGNAME': 'cltbld', 11:51:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:51:18 INFO - 'MOZ_NO_REMOTE': '1', 11:51:18 INFO - 'NO_EM_RESTART': '1', 11:51:18 INFO - 'PAGER': '/bin/cat', 11:51:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:51:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:51:18 INFO - 'PWD': '/builds/slave/test', 11:51:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:51:18 INFO - 'SHELL': '/bin/bash', 11:51:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZTaiaekecT/Listeners', 11:51:18 INFO - 'TMPDIR': '/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/', 11:51:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:51:18 INFO - 'USER': 'cltbld', 11:51:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:51:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:51:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:51:18 INFO - 'XPC_FLAGS': '0x0', 11:51:18 INFO - 'XPC_SERVICE_NAME': '0', 11:51:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:51:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:51:18 INFO - Downloading/unpacking blobuploader==1.2.4 11:51: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 11:51: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 11:51: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 11:51: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 11:51: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 11:51: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 11:51:20 INFO - Downloading blobuploader-1.2.4.tar.gz 11:51:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:51:21 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:51:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:51:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:51:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:51:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:51:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:51:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:51:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:51:21 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:51:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:51:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:51:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:51:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:51:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:51:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:51:22 INFO - Downloading docopt-0.6.1.tar.gz 11:51:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:51:22 INFO - Installing collected packages: blobuploader, requests, docopt 11:51:22 INFO - Running setup.py install for blobuploader 11:51:22 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:51:22 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:51:22 INFO - Running setup.py install for requests 11:51:22 INFO - Running setup.py install for docopt 11:51:23 INFO - Successfully installed blobuploader requests docopt 11:51:23 INFO - Cleaning up... 11:51:23 INFO - Return code: 0 11:51:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:51:23 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')]} 11:51:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:51:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:51:23 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')]} 11:51:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:51:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:51:23 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 0x105d7aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105d80570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe5225856f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105c1ed30>, '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 0x105a42db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105c15b20>, '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.yQGdPv9ht4/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.ZTaiaekecT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/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 11:51:23 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 11:51:23 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 11:51:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yQGdPv9ht4/Render', 11:51:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:51:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:51:23 INFO - 'HOME': '/Users/cltbld', 11:51:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:51:23 INFO - 'LOGNAME': 'cltbld', 11:51:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:51:23 INFO - 'MOZ_NO_REMOTE': '1', 11:51:23 INFO - 'NO_EM_RESTART': '1', 11:51:23 INFO - 'PAGER': '/bin/cat', 11:51:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:51:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:51:23 INFO - 'PWD': '/builds/slave/test', 11:51:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:51:23 INFO - 'SHELL': '/bin/bash', 11:51:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZTaiaekecT/Listeners', 11:51:23 INFO - 'TMPDIR': '/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/', 11:51:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:51:23 INFO - 'USER': 'cltbld', 11:51:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:51:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:51:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:51:23 INFO - 'XPC_FLAGS': '0x0', 11:51:23 INFO - 'XPC_SERVICE_NAME': '0', 11:51:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:51:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:51:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:51:23 INFO - Running setup.py (path:/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/pip-lylR1Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:51:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:51:23 INFO - Running setup.py (path:/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/pip-NPbMY2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:51:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:51:23 INFO - Running setup.py (path:/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/pip-Ee_9hd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:51:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:51:23 INFO - Running setup.py (path:/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/pip-0I2h72-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:51:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:51:23 INFO - Running setup.py (path:/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/pip-Fw9Z9r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:51:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:51:24 INFO - Running setup.py (path:/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/pip-VLij6k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:51:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:51:24 INFO - Running setup.py (path:/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/pip-l_bLCh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:51:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:51:24 INFO - Running setup.py (path:/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/pip-zFDNrp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:51:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:51:24 INFO - Running setup.py (path:/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/pip-dfoIy4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:51:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:51:24 INFO - Running setup.py (path:/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/pip-Jfksjy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:51:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:51:24 INFO - Running setup.py (path:/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/pip-nhjrsH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:51:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:51:24 INFO - Running setup.py (path:/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/pip-pT5arS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:51:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:51:24 INFO - Running setup.py (path:/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/pip-ItlNik-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:51:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:51:24 INFO - Running setup.py (path:/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/pip-F2HCJm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:51:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:51:24 INFO - Running setup.py (path:/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/pip-NktLkH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:51:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:51:25 INFO - Running setup.py (path:/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/pip-xxrjBm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:51:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:51:25 INFO - Running setup.py (path:/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/pip-cvjs6Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:51:25 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:51:25 INFO - Running setup.py install for manifestparser 11:51:25 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:51:25 INFO - Running setup.py install for mozcrash 11:51:25 INFO - Running setup.py install for mozdebug 11:51:25 INFO - Running setup.py install for mozdevice 11:51:25 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:51:25 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:51:25 INFO - Running setup.py install for mozfile 11:51:26 INFO - Running setup.py install for mozhttpd 11:51:26 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:51:26 INFO - Running setup.py install for mozinfo 11:51:26 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:51:26 INFO - Running setup.py install for mozInstall 11:51:26 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:51:26 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:51:26 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:51:26 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:51:26 INFO - Running setup.py install for mozleak 11:51:26 INFO - Running setup.py install for mozlog 11:51:26 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:51:26 INFO - Running setup.py install for moznetwork 11:51:26 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:51:26 INFO - Running setup.py install for mozprocess 11:51:27 INFO - Running setup.py install for mozprofile 11:51:27 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:51:27 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:51:27 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:51:27 INFO - Running setup.py install for mozrunner 11:51:27 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:51:27 INFO - Running setup.py install for mozscreenshot 11:51:27 INFO - Running setup.py install for moztest 11:51:27 INFO - Running setup.py install for mozversion 11:51:27 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:51:27 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:51:27 INFO - Cleaning up... 11:51:27 INFO - Return code: 0 11:51:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:51:27 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')]} 11:51:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:51:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:51:27 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')]} 11:51:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:51:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:51:27 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 0x105d7aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105d80570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe5225856f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105c1ed30>, '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 0x105a42db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105c15b20>, '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.yQGdPv9ht4/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.ZTaiaekecT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/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 11:51:27 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 11:51:27 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 11:51:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yQGdPv9ht4/Render', 11:51:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:51:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:51:27 INFO - 'HOME': '/Users/cltbld', 11:51:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:51:27 INFO - 'LOGNAME': 'cltbld', 11:51:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:51:27 INFO - 'MOZ_NO_REMOTE': '1', 11:51:27 INFO - 'NO_EM_RESTART': '1', 11:51:27 INFO - 'PAGER': '/bin/cat', 11:51:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:51:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:51:27 INFO - 'PWD': '/builds/slave/test', 11:51:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:51:27 INFO - 'SHELL': '/bin/bash', 11:51:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZTaiaekecT/Listeners', 11:51:27 INFO - 'TMPDIR': '/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/', 11:51:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:51:27 INFO - 'USER': 'cltbld', 11:51:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:51:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:51:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:51:27 INFO - 'XPC_FLAGS': '0x0', 11:51:27 INFO - 'XPC_SERVICE_NAME': '0', 11:51:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:51:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:51:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:51:28 INFO - Running setup.py (path:/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/pip-tIjgYq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:51:28 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)) 11:51:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:51:28 INFO - Running setup.py (path:/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/pip-WFIDrK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:51:28 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)) 11:51:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:51:28 INFO - Running setup.py (path:/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/pip-nXEYPD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:51:28 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)) 11:51:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:51:28 INFO - Running setup.py (path:/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/pip-_XQlxG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:51:28 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)) 11:51:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:51:28 INFO - Running setup.py (path:/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/pip-kGtXhl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:51:28 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)) 11:51:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:51:28 INFO - Running setup.py (path:/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/pip-w7uWwF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:51:28 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)) 11:51:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:51:28 INFO - Running setup.py (path:/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/pip-FP3xDz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:51:28 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)) 11:51:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:51:28 INFO - Running setup.py (path:/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/pip-6eSjBh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:51:28 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)) 11:51:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:51:28 INFO - Running setup.py (path:/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/pip-CWyC2o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:51:29 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)) 11:51:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:51:29 INFO - Running setup.py (path:/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/pip-Bn0Qpf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:51:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 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)) 11:51:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:51:29 INFO - Running setup.py (path:/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/pip-aYdW70-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:51:29 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)) 11:51:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:51:29 INFO - Running setup.py (path:/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/pip-uvT8Pe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:51:29 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)) 11:51:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:51:29 INFO - Running setup.py (path:/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/pip-UmhHhD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:51:29 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)) 11:51:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:51:29 INFO - Running setup.py (path:/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/pip-No8PWT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:51:29 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)) 11:51:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:51:29 INFO - Running setup.py (path:/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/pip-cd95xx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:51:29 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)) 11:51:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:51:29 INFO - Running setup.py (path:/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/pip-26usaC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:51:29 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)) 11:51:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:51:29 INFO - Running setup.py (path:/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/pip-99L0mN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:51:29 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)) 11:51:29 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)) 11:51:29 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)) 11:51:29 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)) 11:51:29 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)) 11:51:29 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)) 11:51:29 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:51:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:51:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:51:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:51:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:51:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:51:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:51:32 INFO - Downloading blessings-1.6.tar.gz 11:51:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:51:32 INFO - Installing collected packages: blessings 11:51:32 INFO - Running setup.py install for blessings 11:51:32 INFO - Successfully installed blessings 11:51:32 INFO - Cleaning up... 11:51:32 INFO - Return code: 0 11:51:32 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:51:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:51:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:51:32 INFO - Reading from file tmpfile_stdout 11:51:32 INFO - Current package versions: 11:51:32 INFO - blessings == 1.6 11:51:32 INFO - blobuploader == 1.2.4 11:51:32 INFO - docopt == 0.6.1 11:51:32 INFO - manifestparser == 1.1 11:51:32 INFO - mozInstall == 1.12 11:51:32 INFO - mozcrash == 0.17 11:51:32 INFO - mozdebug == 0.1 11:51:32 INFO - mozdevice == 0.48 11:51:32 INFO - mozfile == 1.2 11:51:32 INFO - mozhttpd == 0.7 11:51:32 INFO - mozinfo == 0.9 11:51:32 INFO - mozleak == 0.1 11:51:32 INFO - mozlog == 3.2 11:51:32 INFO - moznetwork == 0.27 11:51:32 INFO - mozprocess == 0.22 11:51:32 INFO - mozprofile == 0.28 11:51:32 INFO - mozrunner == 6.11 11:51:32 INFO - mozscreenshot == 0.1 11:51:32 INFO - mozsystemmonitor == 0.3 11:51:32 INFO - moztest == 0.7 11:51:32 INFO - mozversion == 1.4 11:51:32 INFO - psutil == 3.1.1 11:51:32 INFO - requests == 1.2.3 11:51:32 INFO - wsgiref == 0.1.2 11:51:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:51:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:51:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:51:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:51:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:51:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:51:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:51:32 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 0x105d7aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105d80570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe5225856f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105c1ed30>, '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 0x105a42db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105c15b20>, '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.yQGdPv9ht4/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.ZTaiaekecT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/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 11:51:32 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 11:51:32 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 11:51:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yQGdPv9ht4/Render', 11:51:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:51:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:51:32 INFO - 'HOME': '/Users/cltbld', 11:51:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:51:32 INFO - 'LOGNAME': 'cltbld', 11:51:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:51:32 INFO - 'MOZ_NO_REMOTE': '1', 11:51:32 INFO - 'NO_EM_RESTART': '1', 11:51:32 INFO - 'PAGER': '/bin/cat', 11:51:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:51:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:51:32 INFO - 'PWD': '/builds/slave/test', 11:51:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:51:32 INFO - 'SHELL': '/bin/bash', 11:51:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZTaiaekecT/Listeners', 11:51:32 INFO - 'TMPDIR': '/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/', 11:51:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:51:32 INFO - 'USER': 'cltbld', 11:51:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:51:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:51:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:51:32 INFO - 'XPC_FLAGS': '0x0', 11:51:32 INFO - 'XPC_SERVICE_NAME': '0', 11:51:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:51:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:51:33 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)) 11:51:33 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)) 11:51:33 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)) 11:51:33 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)) 11:51:33 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)) 11:51:33 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)) 11:51:33 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)) 11:51:33 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)) 11:51:33 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)) 11:51:33 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)) 11:51:33 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)) 11:51:33 INFO - Cleaning up... 11:51:33 INFO - Return code: 0 11:51:33 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:51: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')]} 11:51:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:51:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:51: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')]} 11:51:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:51:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:51: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x105d7aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105d80570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe5225856f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105c1ed30>, '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 0x105a42db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105c15b20>, '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.yQGdPv9ht4/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.ZTaiaekecT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/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 11:51: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', 'jsonschema'] in /builds/slave/test/build 11:51: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 jsonschema 11:51:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yQGdPv9ht4/Render', 11:51:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:51:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:51:33 INFO - 'HOME': '/Users/cltbld', 11:51:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:51:33 INFO - 'LOGNAME': 'cltbld', 11:51:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:51:33 INFO - 'MOZ_NO_REMOTE': '1', 11:51:33 INFO - 'NO_EM_RESTART': '1', 11:51:33 INFO - 'PAGER': '/bin/cat', 11:51:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:51:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:51:33 INFO - 'PWD': '/builds/slave/test', 11:51:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:51:33 INFO - 'SHELL': '/bin/bash', 11:51:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZTaiaekecT/Listeners', 11:51:33 INFO - 'TMPDIR': '/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/', 11:51:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:51:33 INFO - 'USER': 'cltbld', 11:51:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:51:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:51:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:51:33 INFO - 'XPC_FLAGS': '0x0', 11:51:33 INFO - 'XPC_SERVICE_NAME': '0', 11:51:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:51:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:51:33 INFO - Downloading/unpacking jsonschema 11:51:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:51:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:51:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:51:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:51:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:51:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:51:35 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:51:35 INFO - Downloading/unpacking functools32 (from jsonschema) 11:51: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 11:51: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 11:51: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 11:51: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 11:51: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 11:51: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 11:51:36 INFO - Downloading functools32-3.2.3-2.tar.gz 11:51:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:51:36 INFO - warning: no files found matching '*.txt' 11:51:36 INFO - no previously-included directories found matching 'build' 11:51:36 INFO - no previously-included directories found matching 'dist' 11:51:36 INFO - no previously-included directories found matching '.git*' 11:51:36 INFO - Installing collected packages: jsonschema, functools32 11:51:36 INFO - Running setup.py install for functools32 11:51:36 INFO - warning: no files found matching '*.txt' 11:51:36 INFO - no previously-included directories found matching 'build' 11:51:36 INFO - no previously-included directories found matching 'dist' 11:51:36 INFO - no previously-included directories found matching '.git*' 11:51:36 INFO - Successfully installed jsonschema functools32 11:51:36 INFO - Cleaning up... 11:51:36 INFO - Return code: 0 11:51:36 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 11:51:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:51:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:51:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:51:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:51:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:51:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:51:36 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 0x105d7aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105d80570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe5225856f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105c1ed30>, '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 0x105a42db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105c15b20>, '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.yQGdPv9ht4/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.ZTaiaekecT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/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 11:51:36 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 11:51:36 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 11:51:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yQGdPv9ht4/Render', 11:51:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:51:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:51:36 INFO - 'HOME': '/Users/cltbld', 11:51:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:51:36 INFO - 'LOGNAME': 'cltbld', 11:51:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:51:36 INFO - 'MOZ_NO_REMOTE': '1', 11:51:36 INFO - 'NO_EM_RESTART': '1', 11:51:36 INFO - 'PAGER': '/bin/cat', 11:51:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:51:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:51:36 INFO - 'PWD': '/builds/slave/test', 11:51:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:51:36 INFO - 'SHELL': '/bin/bash', 11:51:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZTaiaekecT/Listeners', 11:51:36 INFO - 'TMPDIR': '/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/', 11:51:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:51:36 INFO - 'USER': 'cltbld', 11:51:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:51:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:51:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:51:36 INFO - 'XPC_FLAGS': '0x0', 11:51:36 INFO - 'XPC_SERVICE_NAME': '0', 11:51:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:51:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:51:37 INFO - Downloading/unpacking flake8 11:51: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 11:51: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 11:51: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 11:51: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 11:51: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 11:51: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 11:51:40 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 11:51:40 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 11:51:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:51:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:51:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:51:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:51:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:51:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:51:40 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 11:51:41 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 11:51:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:51:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:51:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:51:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:51:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:51:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:51:41 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 11:51:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:51:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:51:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:51:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:51:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:51:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:51:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 11:51:41 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:51:41 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:51:41 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:51:41 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:51:41 INFO - no previously-included directories found matching 'docs/_build' 11:51:42 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 11:51:42 INFO - Running setup.py install for pep8 11:51:42 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:51:42 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:51:42 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:51:42 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:51:42 INFO - no previously-included directories found matching 'docs/_build' 11:51:42 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 11:51:42 INFO - Successfully installed flake8 mccabe pyflakes pep8 11:51:42 INFO - Cleaning up... 11:51:42 INFO - Return code: 0 11:51:42 INFO - Running post-action listener: _resource_record_post_action 11:51:42 INFO - Running post-action listener: _start_resource_monitoring 11:51:42 INFO - Starting resource monitoring. 11:51:42 INFO - ##### 11:51:42 INFO - ##### Finished create-virtualenv step (success) 11:51:42 INFO - ##### 11:51:42 INFO - ##### 11:51:42 INFO - ##### Running install step. 11:51:42 INFO - ##### 11:51:42 INFO - Running pre-action listener: _resource_record_pre_action 11:51:42 INFO - Running main action method: install 11:51:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:51:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:51:42 INFO - Reading from file tmpfile_stdout 11:51:42 INFO - Detecting whether we're running mozinstall >=1.0... 11:51:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:51:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:51:42 INFO - Reading from file tmpfile_stdout 11:51:42 INFO - Output received: 11:51:42 INFO - Usage: mozinstall [options] installer 11:51:42 INFO - Options: 11:51:42 INFO - -h, --help show this help message and exit 11:51:42 INFO - -d DEST, --destination=DEST 11:51:42 INFO - Directory to install application into. [default: 11:51:42 INFO - "/builds/slave/test"] 11:51:42 INFO - --app=APP Application being installed. [default: firefox] 11:51:42 INFO - mkdir: /builds/slave/test/build/application 11:51:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 11:51:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 11:52:16 INFO - Reading from file tmpfile_stdout 11:52:16 INFO - Output received: 11:52:16 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 11:52:16 INFO - Running post-action listener: _resource_record_post_action 11:52:16 INFO - ##### 11:52:16 INFO - ##### Finished install step (success) 11:52:16 INFO - ##### 11:52:16 INFO - ##### 11:52:16 INFO - ##### Running run-tests step. 11:52:16 INFO - ##### 11:52:16 INFO - Running pre-action listener: _resource_record_pre_action 11:52:16 INFO - Running main action method: run_tests 11:52:16 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 11:52:16 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 11:52:16 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 11:52:16 INFO - 2016-05-16 11:52:16.482 screenresolution[1666:7627] starting screenresolution argv=screenresolution get 11:52:16 INFO - 2016-05-16 11:52:16.485 screenresolution[1666:7627] Display 0: 1600x1200x32@60 11:52:16 INFO - 2016-05-16 11:52:16.490 screenresolution[1667:7629] starting screenresolution argv=screenresolution list 11:52:16 INFO - Available Modes on Display 0 11:52:16 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 11:52:16 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 11:52:16 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 11:52:16 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 11:52:16 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 11:52:16 INFO - Intel Iris: 11:52:16 INFO - Chipset Model: Intel Iris 11:52:16 INFO - Type: GPU 11:52:16 INFO - Bus: Built-In 11:52:16 INFO - VRAM (Dynamic, Max): 1536 MB 11:52:16 INFO - Vendor: Intel (0x8086) 11:52:16 INFO - Device ID: 0x0a2e 11:52:16 INFO - Revision ID: 0x0009 11:52:16 INFO - Displays: 11:52:16 INFO - Display: 11:52:16 INFO - Resolution: 1600 x 1200 @ 60 Hz 11:52:16 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 11:52:16 INFO - Display Serial Number: 1600x1200 60 11:52:16 INFO - Main Display: Yes 11:52:16 INFO - Mirror: Off 11:52:16 INFO - Online: Yes 11:52:16 INFO - Rotation: Supported 11:52:16 INFO - Return code: 0 11:52:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:52:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:52:16 INFO - Python 2.7.3 11:52:16 INFO - Return code: 0 11:52:16 INFO - grabbing minidump binary from tooltool 11:52:16 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')]} 11:52:16 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: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105c1ed30>, '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 0x105a42db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105c15b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:52:16 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 11:52:16 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 11:52:16 INFO - Calling ['/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'] with output_timeout 600 11:52:16 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:52:16 INFO - Return code: 0 11:52:16 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 11:52:16 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:52:16 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:52:16 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 11:52:16 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:52:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 11:52:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 11:52:18 INFO - Return code: 0 11:52:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/I8C8TsMyTcyE0Dh8RKS1Cg/artifacts/public/build/firefox-49.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0373', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 11:52:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/I8C8TsMyTcyE0Dh8RKS1Cg/artifacts/public/build/firefox-49.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0373 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 11:52:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yQGdPv9ht4/Render', 11:52:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:52:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:52:18 INFO - 'HOME': '/Users/cltbld', 11:52:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:52:18 INFO - 'LOGNAME': 'cltbld', 11:52:18 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:52:18 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 11:52:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:52:18 INFO - 'MOZ_NO_REMOTE': '1', 11:52:18 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:52:18 INFO - 'NO_EM_RESTART': '1', 11:52:18 INFO - 'PAGER': '/bin/cat', 11:52:18 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:52:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:52:18 INFO - 'PWD': '/builds/slave/test', 11:52:18 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:52:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:52:18 INFO - 'SHELL': '/bin/bash', 11:52:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZTaiaekecT/Listeners', 11:52:18 INFO - 'TMPDIR': '/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/', 11:52:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:52:18 INFO - 'USER': 'cltbld', 11:52:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:52:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:52:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:52:18 INFO - 'XPC_FLAGS': '0x0', 11:52:18 INFO - 'XPC_SERVICE_NAME': '0', 11:52:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:52:18 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/I8C8TsMyTcyE0Dh8RKS1Cg/artifacts/public/build/firefox-49.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0373', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 11:52:18 INFO - mozversion application_buildid: 20160516095902 11:52:18 INFO - mozversion application_changeset: de80d1838a8db73172f7c09f57a3ecc0267f47e5 11:52:18 INFO - mozversion application_display_name: Nightly 11:52:18 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:52:18 INFO - mozversion application_name: Firefox 11:52:18 INFO - mozversion application_remotingname: firefox 11:52:18 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 11:52:18 INFO - mozversion application_vendor: Mozilla 11:52:18 INFO - mozversion application_version: 49.0a1 11:52:18 INFO - mozversion platform_buildid: 20160516095902 11:52:18 INFO - mozversion platform_changeset: de80d1838a8db73172f7c09f57a3ecc0267f47e5 11:52:18 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 11:52:18 INFO - mozversion platform_version: 49.0a1 11:52:18 INFO - using testdate: 1463424738 11:52:18 INFO - actual date: 1463424738 11:52:18 INFO - starting webserver on 'localhost:49285' 11:52:18 INFO - SUITE-START | Running 2 tests 11:52:18 INFO - TEST-START | dromaeo_css 11:52:18 INFO - operating with platform_type : mac_ 11:52:18 INFO - Initialising browser for dromaeo_css test... 11:52:18 INFO - TEST-INFO | started process 1685 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/tmpj5GJSz/profile http://localhost:49285/getInfo.html) 11:52:21 INFO - PROCESS | 1685 | __metrics Screen width/height:1600/1200 11:52:21 INFO - PROCESS | 1685 | colorDepth:24 11:52:21 INFO - PROCESS | 1685 | Browser inner width/height: 1024/689 11:52:21 INFO - PROCESS | 1685 | __metrics 11:52:21 ERROR - PROCESS | 1685 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2946: TypeError: this.tabs is undefined 11:52:21 INFO - TEST-INFO | 1685: exit 0 11:52:21 INFO - Browser initialized. 11:52:21 INFO - Running cycle 1/1 for dromaeo_css test... 11:52:21 INFO - TEST-INFO | started process 1688 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/tmpj5GJSz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:52:33 INFO - PROCESS | 1688 | RSS: Main: 249954304 11:52:33 INFO - PROCESS | 1688 | 11:53:23 INFO - PROCESS | 1688 | 1463424803548 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] 11:55:34 INFO - PROCESS | 1688 | Cycle 1(1): loaded http://localhost:49285/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49285/tests/dromaeo/cssquery-ext.html) 11:55:36 INFO - PROCESS | 1688 | RSS: Main: 261816320 11:55:36 INFO - PROCESS | 1688 | 11:58:38 INFO - PROCESS | 1688 | Cycle 1(1): loaded http://localhost:49285/tests/dromaeo/cssquery-ext.html (next: http://localhost:49285/tests/dromaeo/cssquery-jquery.html) 11:58:39 INFO - PROCESS | 1688 | RSS: Main: 273633280 11:58:39 INFO - PROCESS | 1688 | 12:01:40 INFO - PROCESS | 1688 | Cycle 1(1): loaded http://localhost:49285/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49285/tests/dromaeo/cssquery-mootools.html) 12:01:41 INFO - PROCESS | 1688 | RSS: Main: 275664896 12:01:41 INFO - PROCESS | 1688 | 12:04:43 INFO - PROCESS | 1688 | Cycle 1(1): loaded http://localhost:49285/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49285/tests/dromaeo/cssquery-prototype.html) 12:04:43 INFO - PROCESS | 1688 | RSS: Main: 277241856 12:04:43 INFO - PROCESS | 1688 | 12:07:46 INFO - PROCESS | 1688 | Cycle 1(1): loaded http://localhost:49285/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49285/tests/dromaeo/cssquery-yui.html) 12:07:47 INFO - PROCESS | 1688 | RSS: Main: 280104960 12:07:47 INFO - PROCESS | 1688 | 12:10:49 INFO - PROCESS | 1688 | Cycle 1(1): loaded http://localhost:49285/tests/dromaeo/cssquery-yui.html (next: http://localhost:49285/tests/dromaeo/cssquery-dojo.html) 12:10:50 INFO - PROCESS | 1688 | RSS: Main: 281305088 12:10:50 INFO - PROCESS | 1688 | 12:10:50 INFO - PROCESS | 1688 | __start_tp_report 12:10:50 INFO - PROCESS | 1688 | _x_x_mozilla_page_load 12:10:50 INFO - PROCESS | 1688 | _x_x_mozilla_page_load_details 12:10:50 INFO - PROCESS | 1688 | |i|pagename|runs| 12:10:50 INFO - PROCESS | 1688 | |0;dojo.html;2935.2221661259755;3494.545709057822;3509.2104276537784;3516.0858176874012;3556.2176321209326;5824.271966004249;5934.347221805603;5964.910526342108;5990.790322338719;6068.302145253286;5752.194692743009;5932.495737862287;5936.465718085371;5991.760329586822;6004.099385092239;5223.895522089565;5289.047971365153;5366.221897824813;5373.167159090328;5414.593905457087;241.15455214939706;5220.869478263055;5272.209168624718;5322.308099947001;5338.652987555796;5259.2899958505495;5263.526282634562;5268.947310526884;5309.548688361455;5346.1713434417925;5316.707581083039;5317.2821669074565;5322.175062865262;5360.544353729938;5365.731713414352;5169.870753231162;5176.948230517722;5194.896102077975;5288.206768984644;5317.760700768475;5599.944000559983;5766.855828604318;5768.6250393724695;5780.682062486561;5826.067829147316;6269.185005949243;6305.211848518935;6331.651759153245;6337.397947195009;6347;6198.876022479571;6212.409821066992;6214.25428948529;6275.811725648238;6352.618842869442;6007.369226231226;6033.691269809627;6040.848978775522;6048.727807248684;6080;6232.158658581124;6390.84022899422;6453.290138084807;6454.2577603575255;6471.0940468334475;6230.844228894223;6247.344028876993;6258.249010118815;6267.467265282411;6275.121482992385;6252.5935814171935;6352.237731472253;6353.714082866282;6356.364363563606;6367.745290188341;4622.9768851156205;4946.826861059845;6288.717007734663;6305.117283580303;6311.431971122621;6208.937910620926;6292.119103325538;6296.905546416808;6313.05304204373;6326.905096423558;3987.5613682494904;4996.150654388763;5014.373203349582;5016.648834581544;5033.471485494044;3349.3468773588916;4090.775007374623;4412.183746006999;4493.123840851068;4512.34570987205;4958.9504104959215;5935.109733540004;6010.128531363015;6037.45662890342;6051.485623721945;6324.936750632435;6352.269489008823;6375.521835862329;6389.712462939179;6410.038494225903;5765.654060756368;6023.909641355383;6026.487748541423;6048.092786082035;6099.9085013724825;5487.807926722546;5569.19246709233;5570.2480165177185;5572.609917305831;5605;6582.144321238304;6614.470842332602;6629.966850165718;6645.169353830771;6645.3022432643875;6174.66039367839;6238.189035425366;6291.842703932255;6337.841553961188;6382.585131966407;6595.175603049619;6612;6640.203175618763;6640.800775976729;6654.168228971379;6113.415495409368;6255.687215639109;6271.404216599416;6296.244450665949;6311.211098612674;6243.875122497434;6247.281562620356;6275.96862015687;6284.685765711788;6335.303116657072;5999.400059993965;6188.195534580475;6215.875682486416;6233.2208473940755;6248.781292654735;6118.649636126507;6152.0156774915795;6194.442500175006;6215.720292586754;6226.688665566613;6014.789482368271;6055.909161362495;6146.170267013896;6163.291221509584;6175.011998080286;6197.070439434121;6202.968985155046;6215.906761398673;6217.564770466205;6232.189815323979;5993.760249589967;6078.969605151946;6108.675989702823;6169.105479705508;6169.938300616936 12:10:50 INFO - PROCESS | 1688 | |1;ext.html;517.5523172455826;535.1197280473621;539.8947205294965;565.6492974355897;577.7371296060293;40172;42747.35878961814;42855.78572107139;42931.57068429315;43041;43123.13753724931;43498.130037399314;43882.56117438825;43926.78036609812;43932;8236.588170591476;9543.236541076714;9735.951320243388;9786.608535658565;9795.363301385387;8307.210814972568;9625.663101791439;9691;9721.270904682176;9745.415275083518;9747.268954828416;9769.120779129877;9797.02029797018;9802.852957205647;9804.117629413351;8453.196946290092;9722.854157187649;9764.60941562333;9787.706368808947;9797.922228554853;9464.905350946472;9537.380070295409;9580.473073980927;9597.23222142227;9601.47191904445;34657.30685386303;38785.806070969746;39917.40123898144;40254;40261.798691006356;2875.7699384049433;3094.149108995022;3150.3699260147832;3421.7433692473164;3443.8450269737923;27622.309442264104;28762.856185718938;29113.892626446734;29516.11451656432;29596.408071838658;2623.2130360891656;2689.341111427713;2715.728427157288;2784.5266304728043;2785.902493412741;355449;358326;359381;360259.3974060252;361496;34735.30529389398;34767.4784878227;35747.4637880432;35767.821160894026;35902;37706.8114659425;38047;38065.809670951465;38090;38181.42727859085;15387.461438849587;15416.075035497906;15615.453459129103;15636.2181890905;15656.765148522782;12657.367131643381;12969.092163548461;12975.221486710827;13075.542356017493;13077.738445231042;8042.597870106471;8053.476524025919;8226.383021273308;8245.670173193004;8379.329653627696;3408.1820363112674;3428.708559772397;3432.3135372925017;3444.8794292200155;3464.0993341731332;934.5747684803398;954.6754103604808;961.7451375385389;971.3249291742171;1080.6649938519083;26351.73648263531;30230.09309720712;30427.391452170832;30546.847265763972;30886.536701949488;1067.2315932528722;1088.78768640116;1097.8188598881095;1144.6566030190909;1212.7271363943041;13448.663783405493;14076.718465630835;15088.924555377373;15147.924260378848;15410.075395476308;578593;750020;752951;754751;754998;51496;59195;59220;60759.6962015196;61273;1452.7602945514084;1464.3264098514803;1468.6915747693104;1469.1846025455761;1473.6684246044554;28688.13935581936;28915.7108428913;29375.26561835886;29470;29570.408591828473;53150;59239.70380148244;60854;60908.08637870347;64165.39586510375;621185;626223;627839;629620;630488;42429.57570424256;43248.351274730274;43333.3499997494;43511.34732979071;44226.778866105466;47484.28773568468;48122.759386202844;48205;48290.51709483001;48618.5138148614;39642.405363920145;39648.80175599104;39767;39917.401238980856;40430.59569404386;38980.415293771184;39013;39262.60737392589;39679.00802479961;40039.19921601493;32691.509627356085;38107.618923810405;38722.61277387303;38730.284693979665;39220.80389598034;29256.390898500787;30189.792408303423;34490.82754586211;35459.29081418409;35641.82179089088;24145.034198631856;25344.11295604645;25459.10893118732;25747.613785792855;25837.354066148495 12:10:50 INFO - PROCESS | 1688 | |2;jquery.html;312.8736548425668;365.7145134850999;376.58387481832574;387.7363392892833;394.15847166299943;19605.901970490144;19867.60264794705;20673.276435324766;20931;20950.952452377358;20862.895685521587;20868.895655521737;20892.268770593033;20964.951752412395;21275.14899404022;5812.883742325151;5889.116632505115;6073.331933487313;6086.087086936951;6140.508759299268;6004;6047.3650266722025;6093.146959425684;6111.816645500642;6174.969125154368;5648.632838865481;5871.500922421578;5985.670788106652;6003.1895694081395;6062.393760623946;5760.9711951440395;5994.370591087938;6028.1861948636815;6058.757649694007;6102.084687296897;5886.293644762613;5907.734151963129;5945.554083443759;5950.434708702666;6001.1898393717165;13299.468021279137;13355.065145439823;13633.454661813515;13684.726305473934;20217.281531069875;2059.4542446251753;2130.8508404411696;2175.380016695234;2194.3307291276155;2292.346681195851;8345.624446899843;10054.597816087347;10101.292909496338;10317.74205644865;10355.637552685695;1732.0646850700607;1781.7683701118901;1781.8752687311894;1800.1539276540136;1804.2061492943062;87641.30141974869;116279;126227;128802.71197288;132672.0099198513;9429.905700942903;11470.59852905161;11921.88078119225;11924.821127683092;12220.022398208122;14724.411023559152;14775;14816.629584260265;14843.332050057774;14877.553673389815;8012.31895288907;8195.836083278302;8648.870266946002;8852.601632926533;8932.151445612657;7382;8834.072422395557;8938.4190027648;8974.326925480615;9025.142611451902;3799.677027452642;3833.5208098987628;4491.550844915548;4661;4731.243001119804;1676.8658507319385;1730.6365663210868;1965.4398496428448;1985.067018501302;1990.6317331293758;903.4308385716956;940.6895724410928;955.8852937647526;1049.506731836036;1096.4517741129434;20142.093605787773;20323;20375.592488150152;20737.170513179302;20778.896105519678;960.6157536985122;966.5988614724811;976.7558110472382;1001.9048190421898;1033.6692258477365;8092.3930705197345;10157.238207134347;10660.840087398696;10859.18556108295;10941.726456838644;597445;602257;602673;606396;615270;97871;108316;114985.85014149752;130237;135795;941.23759754599;956.3783540698463;973.756560859785;978.8580655804868;1005.3364779245662;18184.36354727578;18318.619883391475;18406.631867362845;18464.81535184631;18576;54871.72564137154;55225;55737.72131139319;57045.714771427534;57247.42752572421;78193.60903195447;81480;82569.58715206386;82898;84818.33499157606;7004.789856304319;7382.52013619113;7497.62511874415;7500.474966752493;7536.7362142324755;12151.574694885636;12663.176893501894;12801.231926084465;12982.870171298544;13019.934900325818;11172;11186.552537898719;11315.321080735182;11365.261258018203;11423;5171.534561889448;9164.541772911194;9664.275179361435;10990.615328463466;11090.279131856403;9725.513724313614;10934.781304374028;11120.666380008613;11484.655460336204;11612.767744645229;7368.115826100902;7427.071616047994;7506.061742282215;7537.434692397982;7681.923180768121;9515.904840951502;9865.210783137189;10703.946480267548;10791.460426978776;11551.480183391935 12:10:50 INFO - PROCESS | 1688 | |3;mootools.html;1432.8495507971663;1601.5435600853755;1837.6967800312948;1935.8257756801886;1968.065169044703;8138.633761480733;8639.481631102139;8722.781930451742;9160.496172710507;9195.724128276146;8711.346649001334;8841.204291613769;8926;8933.062028486996;8933.731988040354;2430.1130087518104;2430.5138972205586;2450.656908032877;2450.7059152901675;2458.2748089313604;2418.322869596516;2428.9878550607223;2446.1683027770555;2451.0685939343025;2455.312512496504;2011.567512984708;2053.486628342914;2057.4753437873396;2446.0949448704005;2450.4608986023045;2083.895535366258;2237.977620223793;2301.2175860207526;2304.412374844421;2313.363824948136;2383.964240536376;2401.747816479262;2413.4207790130417;2415.3599296186526;2416.4683769570843;8760.912390876074;8995.280377569845;9018.188363047357;9021.32340074497;9027.954860225656;5363.919541206885;5498.147787093007;5522.30971128609;5524.751386187631;5556.583256255756;3598.946015809765;3624.981875090634;3643.9979005773357;3688.870889518854;3695.8891233263043;1012.185190921308;1057.2916146182076;1057.312746714634;1065.0680654427376;1073.924825262232;12012.279263244232;12163.635090947197;12195;12202.633920982296;12290.754184916252;4667.393238878924;4903.33804936329;5000.4999500050435;5003.5997120230295;5022.2466630005065;10152.543135558917;10225.130863876506;10245.7438564035;10272.383656980604;10294.897051029393;5409.891802164014;5425.403205647375;5432.266644003009;5464.043792336404;5516.972415137979;4485.0805584855025;4744.525547445297;4971.477994810565;5007.349044624176;5010.49895010496;3416.8462419191196;4107.938380924288;4236.279832428495;4249.787510624456;4286.271333873249;1348.6291269900855;1379.9793003104962;1392.7701929181774;1395.7143709834647;1395.783653533704;907.7095329494631;915.2632131134501;917.5779141594808;936.7845395558924;968.4721826604376;5747.5114615257335;5946.07835785454;5986.3714309997695;5987.221661184019;6028.698565071729;445.58337954012455;447.75149791865175;461.8106576303699;474.8195685639504;479.1590758219303;3899.3760998240145;3953.881383558498;4004.039030632627;4009.759414435085;4041.6362527372676;10288.8682244953;10583.206259530565;10699.679009629723;10706.250562460553;10879.945600271947;10494.475276236157;10776.838347424795;10805.189610779224;10820.783584328427;10821.458927053773;8233.711820086388;8380.580970951429;8395.70615028471;8423.11557286476;8462.576871156418;5950.4644581986095;5969.194158788681;5983.012802887475;6188.783392581238;6199.628022318675;7373.5575865448245;10072.546735396778;10343.224258180517;10344.482775861328;10418.843717344398;10247.641332553325;10419.479026048819;10428.322159059637;10430.791384172426;10463.006014428616;6903.6203008835;7075.929240707733;7616.885746713914;7677.61611919413;7806.336461400618;8415.3267738582;8485.278751306209;8512.74461766148;8571.742847714579;8575.656973720981;7525.623718814147;7644.885326719992;7746.30283274508;7770.611469426393;7787.493812902143;6059.848503787441;7457.067866516685;7533.096028476618;7580.62096895142;7638.770836874903;7119.537230080028;7163.31948464895;7209.567425954459;7236.493445458767;7240.891386629311;4790.473047964651;4815.422149342101;4954.950450495449;5007.273945277987;5141.974290128525;4021.9396709049975;4035.41486484464;4050.736702114353;4159.480064991876;4166.1251137261515 12:10:50 INFO - PROCESS | 1688 | |4;prototype.html;313.34979916672904;316.3499009535404;318.49518513156636;320.0270333394622;320.3480916335258;4805.567498925096;4853.223484242518;5128.948565544064;5543.25166102576;5618;4883.218685010399;5041.647084704063;5281.102212623853;5398.406175320712;5438.374586922505;3212.775105742599;3529.9763068710045;3777.5466943966762;3823.012033742466;4210.789460526977;3445.5865296164498;3448.8448019839166;4122.721956193574;4138.7516748995;4156.355764856437;3829.349010668193;3935.9963209381567;4111.149982507868;4134.710570260083;4175.54069052404;3569.036360182736;3959.267535505912;4083.938176074242;4167.291560434718;4203.55862634422;3188.713015828587;3611.1513794258326;3611.765235259726;3613.241219343941;3620.6560376764164;4220.78896055196;5335.946640533583;5336.905934283463;5373.973130134364;5380.4350543192795;4276.679249056333;4454.309582014793;4806.879828004293;4840.6127509799135;4845.830395936126;5336.91994620081;5622.887542249132;5803.781205946756;5835.270591176103;5868.677222752747;3562.3765840977726;3758.1919887224103;4026.979865100656;4048.67610591152;4062.578097665823;5399.623096110506;5961;6117.847053823645;6121.969390153065;6156.630602163885;3997.980010099989;4036.8385264589087;4063.9840039990004;4067.9050289101137;4067.91864162721;3360.5463262459257;3533.505309256706;4117.732347397409;4124.91750164995;4125.195586860534;4379.934300985487;4436.334549817553;4765.999140180601;4785.234362501983;4790.203673622392;4715.669903106749;5129.435762066169;5146.485351464824;5604.075327570987;5618.887622247532;1303.6414985878769;1350.9125154250921;1352.3981828086603;1410.4428750643438;1411.5976946570179;786.9173736757673;800.2357748350312;828.9544075075808;836.3476488338983;894.865770134485;4178.051741104627;4612.463145270088;4700.7671356105575;4800.35195248644;5024.095662780662;5400.919816036809;5437.564994800407;5757.568182386338;5919;6109.694515274218;4861.975690121598;5428.83713488596;5455.1544510600925;5489.286392768914;5502.5597952163735;2852.3011862093504;2897.27568107973;3008.533677280025;3149.5118256670253;3151.3697260547983;5098.643094983316;5611.9337325907945;5948.940510594839;6221.720022598994;6292.2134733158355;5121.797627020343;5998.000999500163;6135.32511423743;6194.907076393858;6294.402031806971;5698.230738850285;5755.70496638253;5767.8558036049435;6346.650934198571;6401.647909364937;4554.407926969473;5652.208690783212;5819.912701309399;6120.602160859708;6137.386261374006;5449.692073902155;5523.950449414599;5948.137520059654;5983.311919129356;5994.28068631767;5493.890122197454;5774.564134340061;5941.940580594139;6176.783812566719;6373.418765400021;3674.8162591870832;3713.9442908356937;3905.628965248297;3972.331620719247;3992.720509564419;5236.895262094813;5336.612480754954;5886.146508756292;5931.894177567075;5995.100734889627;5482.91775623358;5739.311282646109;5822.302837698007;5833.6874203305615;5863.413658634103;4901.754912254444;5113.821016264413;5160.329157209539;5764.971175144097;5773.393793651606;4349.652027837828;5661.46216109469;5736.799212027726;5749.9175585333205;5800;5537.280153580009;5649.4350564944825;5816;5843.2403787507355;5859.765609375748;5111.87220319495;5382.515573598395;5732.598718089694;5773.364929857797;5841.415858414124 12:10:50 INFO - PROCESS | 1688 | |5;yui.html;659.1694464974131;683.695755388852;694.4305669351135;708.950373473857;736.1313649893126;15150.545483635495;15607.141607211599;15691.37234510621;15700.76448853268;16762.329506819744;16286.267117979689;16396.918015409938;16702.916485417554;16724.749128763047;16735.581610459743;928.4568527411473;932.2541966426866;937.409432057806;938;938.6949241496507;733.1275781819618;901.8016036471965;935.822193783179;937.1097457415449;938.2728385501223;947.3179310896178;972.1445128287132;974.098958463422;977.7702239973636;978.4227305889524;972.6109556177515;974.2741657465199;974.6101559376235;974.868392766978;977.5063592885618;719.0257201491955;720.1969803668871;721.2679130682361;721.9205887352387;723.5080145501057;13631.454741810316;14225.648563386461;15389.538313850491;15426.9228653856;15465.690686186213;12362.690932726664;12477.93761031189;12505.3747312634;12540.937295313557;12794.168379055332;9895.505224738807;10269.74325641865;10301.845472317922;10354.637587684394;10581.047705706447;3458.0490365149535;3501.6498350165034;3502.1069627245142;3527.470879368115;3578.499010138583;93828;93923.53038234766;94956.57565136529;96016;96347;9194.391860505788;9329.860052099224;9404.200642945427;9508.572114254875;9846.310758246855;17458.825411745718;18990.810091898904;21839.78160218409;21875;22055.22806701758;6037.792441511715;7166.53417527859;7186.532875363189;7349.154847192534;7350.301721336465;3875.2249550090096;3906.5898080701686;3921;3942.3495123304906;3945.1715139820385;3634.47300141478;3752.0057184846037;3752.380857158593;3753.6997040236715;3761.3793724035777;640.8333833203401;654.4306453385585;659.3571268013649;662.0367365483211;664.4949838123061;465.206822367862;500.7521276967924;508.14631419216073;588.114887094928;604.8336707405499;7771.300582947449;7851.254130857559;8102.906107675389;8276.503409795432;8353.457025293337;505.5147058823497;518.7380372911656;553.2089112568984;570.7688386203595;571.4228629084654;3420.81185534793;3701.851925922987;3869.4776205212497;3958.4656071430563;4034.464372031791;85632.14367856366;86335.56832215798;98479;99627;102675;80083.59958200171;80159.797603036;81457;82143.17856821475;82490.58754706188;65893.34106658968;66348.00477992737;66971.9908402739;67042.99435508471;67172;7682.308592226726;7699.037620297463;7738.458307918391;7821.335186508983;7977.082635496992;44169.33745993749;44350.556494435936;45118.548814512746;45318.320225197305;45685;61947.07079393722;62444.68777656083;62480.68759656173;62648.373516266074;62761;8566.871496927675;10076.848847267443;10317.432541210306;10479.94760026195;10535.525901334306;11072.114230861673;11106.333619982826;11136.888631113585;11268.985791278825;11374.31754094757;10487.685369438928;10557.366558006544;10676.306040107369;10882.510287036945;10938.945305273422;10277.229207809594;10875.51060202277;10905.509252083833;10928.453577320943;11014.724631884266;10373.533191006574;10814;11234.831477528007;11236.94381528087;11333.659990200307;9507.809843803223;9601.951990240004;9639.325247232626;9734.269929755155;9780.951095244478;9421.199198068241;10108.360990043431;10146.644867429604;10160.542775575264;10178.694639160836 12:10:50 INFO - PROCESS | 1688 | __end_tp_report 12:10:50 INFO - PROCESS | 1688 | __start_cc_report 12:10:50 INFO - PROCESS | 1688 | _x_x_mozilla_cycle_collect,417 12:10:50 INFO - PROCESS | 1688 | __end_cc_report 12:10:50 INFO - PROCESS | 1688 | __startTimestamp1463425850060__endTimestamp 12:10:50 INFO - PROCESS | 1688 | 12:10:50 INFO - PROCESS | 1688 | ------- Summary: start ------- 12:10:50 INFO - PROCESS | 1688 | Number of tests: 6 12:10:50 INFO - PROCESS | 1688 | 12:10:50 INFO - PROCESS | 1688 | [#0] dojo.html Cycles:165 Average:5807.26 Median:6108.68 stddev:834.01 (13.7%) stddev-sans-first:805.56 12:10:50 INFO - PROCESS | 1688 | Values: 2935.2 3494.5 3509.2 3516.1 3556.2 5824.3 5934.3 5964.9 5990.8 6068.3 5752.2 5932.5 5936.5 5991.8 6004.1 5223.9 5289.0 5366.2 5373.2 5414.6 241.2 5220.9 5272.2 5322.3 5338.7 5259.3 5263.5 5268.9 5309.5 5346.2 5316.7 5317.3 5322.2 5360.5 5365.7 5169.9 5176.9 5194.9 5288.2 5317.8 5599.9 5766.9 5768.6 5780.7 5826.1 6269.2 6305.2 6331.7 6337.4 6347.0 6198.9 6212.4 6214.3 6275.8 6352.6 6007.4 6033.7 6040.8 6048.7 6080.0 6232.2 6390.8 6453.3 6454.3 6471.1 6230.8 6247.3 6258.2 6267.5 6275.1 6252.6 6352.2 6353.7 6356.4 6367.7 4623.0 4946.8 6288.7 6305.1 6311.4 6208.9 6292.1 6296.9 6313.1 6326.9 3987.6 4996.2 5014.4 5016.6 5033.5 3349.3 4090.8 4412.2 4493.1 4512.3 4959.0 5935.1 6010.1 6037.5 6051.5 6324.9 6352.3 6375.5 6389.7 6410.0 5765.7 6023.9 6026.5 6048.1 6099.9 5487.8 5569.2 5570.2 5572.6 5605.0 6582.1 6614.5 6630.0 6645.2 6645.3 6174.7 6238.2 6291.8 6337.8 6382.6 6595.2 6612.0 6640.2 6640.8 6654.2 6113.4 6255.7 6271.4 6296.2 6311.2 6243.9 6247.3 6276.0 6284.7 6335.3 5999.4 6188.2 6215.9 6233.2 6248.8 6118.6 6152.0 6194.4 6215.7 6226.7 6014.8 6055.9 6146.2 6163.3 6175.0 6197.1 6203.0 6215.9 6217.6 6232.2 5993.8 6079.0 6108.7 6169.1 6169.9 12:10:50 INFO - PROCESS | 1688 | 12:10:50 INFO - PROCESS | 1688 | [#1] ext.html Cycles:180 Average:69095.29 Median:39452.51 stddev:158569.06 (401.9%) stddev-sans-first:158930.29 12:10:50 INFO - PROCESS | 1688 | Values: 517.6 535.1 539.9 565.6 577.7 40172.0 42747.4 42855.8 42931.6 43041.0 43123.1 43498.1 43882.6 43926.8 43932.0 8236.6 9543.2 9736.0 9786.6 9795.4 8307.2 9625.7 9691.0 9721.3 9745.4 9747.3 9769.1 9797.0 9802.9 9804.1 8453.2 9722.9 9764.6 9787.7 9797.9 9464.9 9537.4 9580.5 9597.2 9601.5 34657.3 38785.8 39917.4 40254.0 40261.8 2875.8 3094.1 3150.4 3421.7 3443.8 27622.3 28762.9 29113.9 29516.1 29596.4 2623.2 2689.3 2715.7 2784.5 2785.9 355449.0 358326.0 359381.0 360259.4 361496.0 34735.3 34767.5 35747.5 35767.8 35902.0 37706.8 38047.0 38065.8 38090.0 38181.4 15387.5 15416.1 15615.5 15636.2 15656.8 12657.4 12969.1 12975.2 13075.5 13077.7 8042.6 8053.5 8226.4 8245.7 8379.3 3408.2 3428.7 3432.3 3444.9 3464.1 934.6 954.7 961.7 971.3 1080.7 26351.7 30230.1 30427.4 30546.8 30886.5 1067.2 1088.8 1097.8 1144.7 1212.7 13448.7 14076.7 15088.9 15147.9 15410.1 578593.0 750020.0 752951.0 754751.0 754998.0 51496.0 59195.0 59220.0 60759.7 61273.0 1452.8 1464.3 1468.7 1469.2 1473.7 28688.1 28915.7 29375.3 29470.0 29570.4 53150.0 59239.7 60854.0 60908.1 64165.4 621185.0 626223.0 627839.0 629620.0 630488.0 42429.6 43248.4 43333.3 43511.3 44226.8 47484.3 48122.8 48205.0 48290.5 48618.5 39642.4 39648.8 39767.0 39917.4 40430.6 38980.4 39013.0 39262.6 39679.0 40039.2 32691.5 38107.6 38722.6 38730.3 39220.8 29256.4 30189.8 34490.8 35459.3 35641.8 24145.0 25344.1 25459.1 25747.6 25837.4 12:10:50 INFO - PROCESS | 1688 | 12:10:50 INFO - PROCESS | 1688 | [#2] jquery.html Cycles:180 Average:34720.99 Median:371.15 stddev:100837.62 (27169.0%) stddev-sans-first:101087.40 12:10:50 INFO - PROCESS | 1688 | Values: 312.9 365.7 376.6 387.7 394.2 19605.9 19867.6 20673.3 20931.0 20951.0 20862.9 20868.9 20892.3 20965.0 21275.1 5812.9 5889.1 6073.3 6086.1 6140.5 6004.0 6047.4 6093.1 6111.8 6175.0 5648.6 5871.5 5985.7 6003.2 6062.4 5761.0 5994.4 6028.2 6058.8 6102.1 5886.3 5907.7 5945.6 5950.4 6001.2 13299.5 13355.1 13633.5 13684.7 20217.3 2059.5 2130.9 2175.4 2194.3 2292.3 8345.6 10054.6 10101.3 10317.7 10355.6 1732.1 1781.8 1781.9 1800.2 1804.2 87641.3 116279.0 126227.0 128802.7 132672.0 9429.9 11470.6 11921.9 11924.8 12220.0 14724.4 14775.0 14816.6 14843.3 14877.6 8012.3 8195.8 8648.9 8852.6 8932.2 7382.0 8834.1 8938.4 8974.3 9025.1 3799.7 3833.5 4491.6 4661.0 4731.2 1676.9 1730.6 1965.4 1985.1 1990.6 903.4 940.7 955.9 1049.5 1096.5 20142.1 20323.0 20375.6 20737.2 20778.9 960.6 966.6 976.8 1001.9 1033.7 8092.4 10157.2 10660.8 10859.2 10941.7 597445.0 602257.0 602673.0 606396.0 615270.0 97871.0 108316.0 114985.9 130237.0 135795.0 941.2 956.4 973.8 978.9 1005.3 18184.4 18318.6 18406.6 18464.8 18576.0 54871.7 55225.0 55737.7 57045.7 57247.4 78193.6 81480.0 82569.6 82898.0 84818.3 7004.8 7382.5 7497.6 7500.5 7536.7 12151.6 12663.2 12801.2 12982.9 13019.9 11172.0 11186.6 11315.3 11365.3 11423.0 5171.5 9164.5 9664.3 10990.6 11090.3 9725.5 10934.8 11120.7 11484.7 11612.8 7368.1 7427.1 7506.1 7537.4 7681.9 9515.9 9865.2 10703.9 10791.5 11551.5 12:10:50 INFO - PROCESS | 1688 | 12:10:50 INFO - PROCESS | 1688 | [#3] mootools.html Cycles:180 Average:5769.39 Median:2466.42 stddev:3285.02 (133.2%) stddev-sans-first:3278.07 12:10:50 INFO - PROCESS | 1688 | Values: 1432.8 1601.5 1837.7 1935.8 1968.1 8138.6 8639.5 8722.8 9160.5 9195.7 8711.3 8841.2 8926.0 8933.1 8933.7 2430.1 2430.5 2450.7 2450.7 2458.3 2418.3 2429.0 2446.2 2451.1 2455.3 2011.6 2053.5 2057.5 2446.1 2450.5 2083.9 2238.0 2301.2 2304.4 2313.4 2384.0 2401.7 2413.4 2415.4 2416.5 8760.9 8995.3 9018.2 9021.3 9028.0 5363.9 5498.1 5522.3 5524.8 5556.6 3598.9 3625.0 3644.0 3688.9 3695.9 1012.2 1057.3 1057.3 1065.1 1073.9 12012.3 12163.6 12195.0 12202.6 12290.8 4667.4 4903.3 5000.5 5003.6 5022.2 10152.5 10225.1 10245.7 10272.4 10294.9 5409.9 5425.4 5432.3 5464.0 5517.0 4485.1 4744.5 4971.5 5007.3 5010.5 3416.8 4107.9 4236.3 4249.8 4286.3 1348.6 1380.0 1392.8 1395.7 1395.8 907.7 915.3 917.6 936.8 968.5 5747.5 5946.1 5986.4 5987.2 6028.7 445.6 447.8 461.8 474.8 479.2 3899.4 3953.9 4004.0 4009.8 4041.6 10288.9 10583.2 10699.7 10706.3 10879.9 10494.5 10776.8 10805.2 10820.8 10821.5 8233.7 8380.6 8395.7 8423.1 8462.6 5950.5 5969.2 5983.0 6188.8 6199.6 7373.6 10072.5 10343.2 10344.5 10418.8 10247.6 10419.5 10428.3 10430.8 10463.0 6903.6 7075.9 7616.9 7677.6 7806.3 8415.3 8485.3 8512.7 8571.7 8575.7 7525.6 7644.9 7746.3 7770.6 7787.5 6059.8 7457.1 7533.1 7580.6 7638.8 7119.5 7163.3 7209.6 7236.5 7240.9 4790.5 4815.4 4955.0 5007.3 5142.0 4021.9 4035.4 4050.7 4159.5 4166.1 12:10:50 INFO - PROCESS | 1688 | 12:10:50 INFO - PROCESS | 1688 | [#4] prototype.html Cycles:180 Average:4623.22 Median:5137.96 stddev:1452.57 (28.3%) stddev-sans-first:1420.16 12:10:50 INFO - PROCESS | 1688 | Values: 313.3 316.3 318.5 320.0 320.3 4805.6 4853.2 5128.9 5543.3 5618.0 4883.2 5041.6 5281.1 5398.4 5438.4 3212.8 3530.0 3777.5 3823.0 4210.8 3445.6 3448.8 4122.7 4138.8 4156.4 3829.3 3936.0 4111.1 4134.7 4175.5 3569.0 3959.3 4083.9 4167.3 4203.6 3188.7 3611.2 3611.8 3613.2 3620.7 4220.8 5335.9 5336.9 5374.0 5380.4 4276.7 4454.3 4806.9 4840.6 4845.8 5336.9 5622.9 5803.8 5835.3 5868.7 3562.4 3758.2 4027.0 4048.7 4062.6 5399.6 5961.0 6117.8 6122.0 6156.6 3998.0 4036.8 4064.0 4067.9 4067.9 3360.5 3533.5 4117.7 4124.9 4125.2 4379.9 4436.3 4766.0 4785.2 4790.2 4715.7 5129.4 5146.5 5604.1 5618.9 1303.6 1350.9 1352.4 1410.4 1411.6 786.9 800.2 829.0 836.3 894.9 4178.1 4612.5 4700.8 4800.4 5024.1 5400.9 5437.6 5757.6 5919.0 6109.7 4862.0 5428.8 5455.2 5489.3 5502.6 2852.3 2897.3 3008.5 3149.5 3151.4 5098.6 5611.9 5948.9 6221.7 6292.2 5121.8 5998.0 6135.3 6194.9 6294.4 5698.2 5755.7 5767.9 6346.7 6401.6 4554.4 5652.2 5819.9 6120.6 6137.4 5449.7 5524.0 5948.1 5983.3 5994.3 5493.9 5774.6 5941.9 6176.8 6373.4 3674.8 3713.9 3905.6 3972.3 3992.7 5236.9 5336.6 5886.1 5931.9 5995.1 5482.9 5739.3 5822.3 5833.7 5863.4 4901.8 5113.8 5160.3 5765.0 5773.4 4349.7 5661.5 5736.8 5749.9 5800.0 5537.3 5649.4 5816.0 5843.2 5859.8 5111.9 5382.5 5732.6 5773.4 5841.4 12:10:50 INFO - PROCESS | 1688 | 12:10:50 INFO - PROCESS | 1688 | [#5] yui.html Cycles:180 Average:18413.91 Median:579.77 stddev:26590.06 (4586.3%) stddev-sans-first:26631.23 12:10:50 INFO - PROCESS | 1688 | Values: 659.2 683.7 694.4 709.0 736.1 15150.5 15607.1 15691.4 15700.8 16762.3 16286.3 16396.9 16702.9 16724.7 16735.6 928.5 932.3 937.4 938.0 938.7 733.1 901.8 935.8 937.1 938.3 947.3 972.1 974.1 977.8 978.4 972.6 974.3 974.6 974.9 977.5 719.0 720.2 721.3 721.9 723.5 13631.5 14225.6 15389.5 15426.9 15465.7 12362.7 12477.9 12505.4 12540.9 12794.2 9895.5 10269.7 10301.8 10354.6 10581.0 3458.0 3501.6 3502.1 3527.5 3578.5 93828.0 93923.5 94956.6 96016.0 96347.0 9194.4 9329.9 9404.2 9508.6 9846.3 17458.8 18990.8 21839.8 21875.0 22055.2 6037.8 7166.5 7186.5 7349.2 7350.3 3875.2 3906.6 3921.0 3942.3 3945.2 3634.5 3752.0 3752.4 3753.7 3761.4 640.8 654.4 659.4 662.0 664.5 465.2 500.8 508.1 588.1 604.8 7771.3 7851.3 8102.9 8276.5 8353.5 505.5 518.7 553.2 570.8 571.4 3420.8 3701.9 3869.5 3958.5 4034.5 85632.1 86335.6 98479.0 99627.0 102675.0 80083.6 80159.8 81457.0 82143.2 82490.6 65893.3 66348.0 66972.0 67043.0 67172.0 7682.3 7699.0 7738.5 7821.3 7977.1 44169.3 44350.6 45118.5 45318.3 45685.0 61947.1 62444.7 62480.7 62648.4 62761.0 8566.9 10076.8 10317.4 10479.9 10535.5 11072.1 11106.3 11136.9 11269.0 11374.3 10487.7 10557.4 10676.3 10882.5 10938.9 10277.2 10875.5 10905.5 10928.5 11014.7 10373.5 10814.0 11234.8 11236.9 11333.7 9507.8 9602.0 9639.3 9734.3 9781.0 9421.2 10108.4 10146.6 10160.5 10178.7 12:10:50 INFO - PROCESS | 1688 | -------- Summary: end -------- 12:10:50 INFO - PROCESS | 1688 | 12:10:50 INFO - TEST-INFO | 1688: exit 0 12:10:50 INFO - TEST-OK | dromaeo_css | took 1112352ms 12:10:50 INFO - TEST-START | kraken 12:10:50 INFO - operating with platform_type : mac_ 12:10:50 INFO - Initialising browser for kraken test... 12:10:50 INFO - TEST-INFO | started process 1811 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/tmpFn_Utc/profile http://localhost:49285/getInfo.html) 12:10:53 INFO - PROCESS | 1811 | __metrics Screen width/height:1600/1200 12:10:53 INFO - PROCESS | 1811 | colorDepth:24 12:10:53 INFO - PROCESS | 1811 | Browser inner width/height: 1024/689 12:10:53 INFO - PROCESS | 1811 | __metrics 12:10:53 ERROR - PROCESS | 1811 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2946: TypeError: this.tabs is undefined 12:10:54 INFO - TEST-INFO | 1811: exit 0 12:10:54 INFO - Browser initialized. 12:10:54 INFO - Running cycle 1/1 for kraken test... 12:10:54 INFO - TEST-INFO | started process 1815 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/tmpFn_Utc/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:11:06 INFO - PROCESS | 1815 | RSS: Main: 249884672 12:11:06 INFO - PROCESS | 1815 | 12:11:09 INFO - PROCESS | 1815 | Cycle 1(1): loaded http://localhost:49285/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49285/tests/kraken/driver.html?testName=audio-beat-detection) 12:11:10 INFO - PROCESS | 1815 | RSS: Main: 261906432 12:11:10 INFO - PROCESS | 1815 | 12:11:12 INFO - PROCESS | 1815 | Cycle 1(1): loaded http://localhost:49285/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49285/tests/kraken/driver.html?testName=audio-dft) 12:11:13 INFO - PROCESS | 1815 | RSS: Main: 266563584 12:11:13 INFO - PROCESS | 1815 | 12:11:17 INFO - PROCESS | 1815 | Cycle 1(1): loaded http://localhost:49285/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49285/tests/kraken/driver.html?testName=audio-fft) 12:11:17 INFO - PROCESS | 1815 | RSS: Main: 266899456 12:11:17 INFO - PROCESS | 1815 | 12:11:19 INFO - PROCESS | 1815 | Cycle 1(1): loaded http://localhost:49285/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49285/tests/kraken/driver.html?testName=audio-oscillator) 12:11:20 INFO - PROCESS | 1815 | RSS: Main: 268042240 12:11:20 INFO - PROCESS | 1815 | 12:11:22 INFO - PROCESS | 1815 | Cycle 1(1): loaded http://localhost:49285/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49285/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:11:23 INFO - PROCESS | 1815 | RSS: Main: 268443648 12:11:23 INFO - PROCESS | 1815 | 12:11:26 INFO - PROCESS | 1815 | Cycle 1(1): loaded http://localhost:49285/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49285/tests/kraken/driver.html?testName=imaging-darkroom) 12:11:26 INFO - PROCESS | 1815 | RSS: Main: 268414976 12:11:26 INFO - PROCESS | 1815 | 12:11:29 INFO - PROCESS | 1815 | Cycle 1(1): loaded http://localhost:49285/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49285/tests/kraken/driver.html?testName=imaging-desaturate) 12:11:30 INFO - PROCESS | 1815 | RSS: Main: 268832768 12:11:30 INFO - PROCESS | 1815 | 12:11:33 INFO - PROCESS | 1815 | Cycle 1(1): loaded http://localhost:49285/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49285/tests/kraken/driver.html?testName=json-parse-financial) 12:11:34 INFO - PROCESS | 1815 | RSS: Main: 268828672 12:11:34 INFO - PROCESS | 1815 | 12:11:36 INFO - PROCESS | 1815 | Cycle 1(1): loaded http://localhost:49285/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49285/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:11:36 INFO - PROCESS | 1815 | RSS: Main: 268828672 12:11:36 INFO - PROCESS | 1815 | 12:11:38 INFO - PROCESS | 1815 | Cycle 1(1): loaded http://localhost:49285/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49285/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:11:39 INFO - PROCESS | 1815 | RSS: Main: 268480512 12:11:39 INFO - PROCESS | 1815 | 12:11:41 INFO - PROCESS | 1815 | Cycle 1(1): loaded http://localhost:49285/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49285/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:11:42 INFO - PROCESS | 1815 | RSS: Main: 268648448 12:11:42 INFO - PROCESS | 1815 | 12:11:45 INFO - PROCESS | 1815 | Cycle 1(1): loaded http://localhost:49285/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49285/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:11:45 INFO - PROCESS | 1815 | RSS: Main: 268738560 12:11:45 INFO - PROCESS | 1815 | 12:11:48 INFO - PROCESS | 1815 | Cycle 1(1): loaded http://localhost:49285/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49285/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:11:49 INFO - PROCESS | 1815 | RSS: Main: 268673024 12:11:49 INFO - PROCESS | 1815 | 12:11:51 INFO - PROCESS | 1815 | Cycle 1(1): loaded http://localhost:49285/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49285/tests/kraken/driver.html?testName=ai-astar) 12:11:51 INFO - PROCESS | 1815 | RSS: Main: 270598144 12:11:51 INFO - PROCESS | 1815 | 12:11:51 INFO - PROCESS | 1815 | __start_tp_report 12:11:51 INFO - PROCESS | 1815 | _x_x_mozilla_page_load 12:11:51 INFO - PROCESS | 1815 | _x_x_mozilla_page_load_details 12:11:51 INFO - PROCESS | 1815 | |i|pagename|runs| 12:11:51 INFO - PROCESS | 1815 | |0;ai-astar;111;115;105;119;126;115;106;116;140;171 12:11:51 INFO - PROCESS | 1815 | |1;audio-beat-detection;168;151;174;192;126;159;142;122;169;126 12:11:51 INFO - PROCESS | 1815 | |2;audio-dft;193;251;248;269;194;214;229;198;193;196 12:11:51 INFO - PROCESS | 1815 | |3;audio-fft;70;80;76;173;56;57;58;65;133;57 12:11:51 INFO - PROCESS | 1815 | |4;audio-oscillator;79;84;146;78;83;101;113;84;114;156 12:11:51 INFO - PROCESS | 1815 | |5;imaging-gaussian-blur;91;88;92;90;89;131;94;88;91;78 12:11:51 INFO - PROCESS | 1815 | |6;imaging-darkroom;95;131;98;155;113;152;96;97;98;97 12:11:51 INFO - PROCESS | 1815 | |7;imaging-desaturate;90;119;110;91;91;110;122;91;90;92 12:11:51 INFO - PROCESS | 1815 | |8;json-parse-financial;58;59;59;59;60;59;58;117;61;59 12:11:51 INFO - PROCESS | 1815 | |9;json-stringify-tinderbox;64;64;67;80;76;70;66;65;59;74 12:11:51 INFO - PROCESS | 1815 | |10;stanford-crypto-aes;86;85;86;86;90;87;84;87;88;91 12:11:51 INFO - PROCESS | 1815 | |11;stanford-crypto-ccm;135;144;134;151;171;154;146;137;212;153 12:11:51 INFO - PROCESS | 1815 | |12;stanford-crypto-pbkdf2;164;166;165;164;163;162;166;164;162;161 12:11:51 INFO - PROCESS | 1815 | |13;stanford-crypto-sha256-iterative;68;75;84;84;58;73;87;86;86;81 12:11:51 INFO - PROCESS | 1815 | __end_tp_report 12:11:51 INFO - PROCESS | 1815 | __start_cc_report 12:11:51 INFO - PROCESS | 1815 | _x_x_mozilla_cycle_collect,1073 12:11:51 INFO - PROCESS | 1815 | __end_cc_report 12:11:51 INFO - PROCESS | 1815 | __startTimestamp1463425911299__endTimestamp 12:11:51 INFO - PROCESS | 1815 | 12:11:51 INFO - PROCESS | 1815 | ------- Summary: start ------- 12:11:51 INFO - PROCESS | 1815 | Number of tests: 14 12:11:51 INFO - PROCESS | 1815 | 12:11:51 INFO - PROCESS | 1815 | [#0] ai-astar Cycles:10 Average:122.40 Median:117.50 stddev:19.86 (16.9%) stddev-sans-first:20.63 12:11:51 INFO - PROCESS | 1815 | Values: 111.0 115.0 105.0 119.0 126.0 115.0 106.0 116.0 140.0 171.0 12:11:51 INFO - PROCESS | 1815 | 12:11:51 INFO - PROCESS | 1815 | [#1] audio-beat-detection Cycles:10 Average:152.90 Median:163.50 stddev:23.62 (14.4%) stddev-sans-first:24.42 12:11:51 INFO - PROCESS | 1815 | Values: 168.0 151.0 174.0 192.0 126.0 159.0 142.0 122.0 169.0 126.0 12:11:51 INFO - PROCESS | 1815 | 12:11:51 INFO - PROCESS | 1815 | [#2] audio-dft Cycles:10 Average:218.50 Median:221.50 stddev:28.74 (13.0%) stddev-sans-first:28.97 12:11:51 INFO - PROCESS | 1815 | Values: 193.0 251.0 248.0 269.0 194.0 214.0 229.0 198.0 193.0 196.0 12:11:51 INFO - PROCESS | 1815 | 12:11:51 INFO - PROCESS | 1815 | [#3] audio-fft Cycles:10 Average:82.50 Median:61.50 stddev:39.24 (63.8%) stddev-sans-first:41.35 12:11:51 INFO - PROCESS | 1815 | Values: 70.0 80.0 76.0 173.0 56.0 57.0 58.0 65.0 133.0 57.0 12:11:51 INFO - PROCESS | 1815 | 12:11:51 INFO - PROCESS | 1815 | [#4] audio-oscillator Cycles:10 Average:103.80 Median:78.50 stddev:28.28 (36.0%) stddev-sans-first:28.54 12:11:51 INFO - PROCESS | 1815 | Values: 79.0 84.0 146.0 78.0 83.0 101.0 113.0 84.0 114.0 156.0 12:11:51 INFO - PROCESS | 1815 | 12:11:51 INFO - PROCESS | 1815 | [#5] imaging-gaussian-blur Cycles:10 Average:93.20 Median:90.50 stddev:13.96 (15.4%) stddev-sans-first:14.78 12:11:51 INFO - PROCESS | 1815 | Values: 91.0 88.0 92.0 90.0 89.0 131.0 94.0 88.0 91.0 78.0 12:11:51 INFO - PROCESS | 1815 | 12:11:51 INFO - PROCESS | 1815 | [#6] imaging-darkroom Cycles:10 Average:113.20 Median:96.50 stddev:24.00 (24.9%) stddev-sans-first:24.53 12:11:51 INFO - PROCESS | 1815 | Values: 95.0 131.0 98.0 155.0 113.0 152.0 96.0 97.0 98.0 97.0 12:11:51 INFO - PROCESS | 1815 | 12:11:51 INFO - PROCESS | 1815 | [#7] imaging-desaturate Cycles:10 Average:100.60 Median:90.50 stddev:13.12 (14.5%) stddev-sans-first:13.34 12:11:51 INFO - PROCESS | 1815 | Values: 90.0 119.0 110.0 91.0 91.0 110.0 122.0 91.0 90.0 92.0 12:11:51 INFO - PROCESS | 1815 | 12:11:51 INFO - PROCESS | 1815 | [#8] json-parse-financial Cycles:10 Average:64.90 Median:59.00 stddev:18.33 (31.1%) stddev-sans-first:19.27 12:11:51 INFO - PROCESS | 1815 | Values: 58.0 59.0 59.0 59.0 60.0 59.0 58.0 117.0 61.0 59.0 12:11:51 INFO - PROCESS | 1815 | 12:11:51 INFO - PROCESS | 1815 | [#9] json-stringify-tinderbox Cycles:10 Average:68.50 Median:68.50 stddev:6.43 (9.4%) stddev-sans-first:6.61 12:11:51 INFO - PROCESS | 1815 | Values: 64.0 64.0 67.0 80.0 76.0 70.0 66.0 65.0 59.0 74.0 12:11:51 INFO - PROCESS | 1815 | 12:11:51 INFO - PROCESS | 1815 | [#10] stanford-crypto-aes Cycles:10 Average:87.00 Median:87.00 stddev:2.16 (2.5%) stddev-sans-first:2.26 12:11:51 INFO - PROCESS | 1815 | Values: 86.0 85.0 86.0 86.0 90.0 87.0 84.0 87.0 88.0 91.0 12:11:51 INFO - PROCESS | 1815 | 12:11:51 INFO - PROCESS | 1815 | [#11] stanford-crypto-ccm Cycles:10 Average:153.70 Median:152.00 stddev:23.28 (15.3%) stddev-sans-first:23.68 12:11:51 INFO - PROCESS | 1815 | Values: 135.0 144.0 134.0 151.0 171.0 154.0 146.0 137.0 212.0 153.0 12:11:51 INFO - PROCESS | 1815 | 12:11:51 INFO - PROCESS | 1815 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:163.70 Median:164.00 stddev:1.70 (1.0%) stddev-sans-first:1.80 12:11:51 INFO - PROCESS | 1815 | Values: 164.0 166.0 165.0 164.0 163.0 162.0 166.0 164.0 162.0 161.0 12:11:51 INFO - PROCESS | 1815 | 12:11:51 INFO - PROCESS | 1815 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:78.20 Median:84.00 stddev:9.57 (11.4%) stddev-sans-first:9.41 12:11:51 INFO - PROCESS | 1815 | Values: 68.0 75.0 84.0 84.0 58.0 73.0 87.0 86.0 86.0 81.0 12:11:51 INFO - PROCESS | 1815 | -------- Summary: end -------- 12:11:51 INFO - PROCESS | 1815 | 12:11:52 INFO - TEST-INFO | 1815: exit 0 12:11:52 INFO - TEST-OK | kraken | took 61504ms 12:11:52 INFO - SUITE-END | took 1173s 12:11:52 INFO - Completed test suite (00:19:34) 12:11:52 INFO - javascript benchmark 12:11:52 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7123.425137622303, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2935.2221661259755, 3494.545709057822, 3509.2104276537784, 3516.0858176874012, 3556.2176321209326, 5824.271966004249, 5934.347221805603, 5964.910526342108, 5990.790322338719, 6068.302145253286, 5752.194692743009, 5932.495737862287, 5936.465718085371, 5991.760329586822, 6004.099385092239, 5223.895522089565, 5289.047971365153, 5366.221897824813, 5373.167159090328, 5414.593905457087, 241.15455214939706, 5220.869478263055, 5272.209168624718, 5322.308099947001, 5338.652987555796, 5259.2899958505495, 5263.526282634562, 5268.947310526884, 5309.548688361455, 5346.1713434417925, 5316.707581083039, 5317.2821669074565, 5322.175062865262, 5360.544353729938, 5365.731713414352, 5169.870753231162, 5176.948230517722, 5194.896102077975, 5288.206768984644, 5317.760700768475, 5599.944000559983, 5766.855828604318, 5768.6250393724695, 5780.682062486561, 5826.067829147316, 6269.185005949243, 6305.211848518935, 6331.651759153245, 6337.397947195009, 6347.0, 6198.876022479571, 6212.409821066992, 6214.25428948529, 6275.811725648238, 6352.618842869442, 6007.369226231226, 6033.691269809627, 6040.848978775522, 6048.727807248684, 6080.0, 6232.158658581124, 6390.84022899422, 6453.290138084807, 6454.2577603575255, 6471.0940468334475, 6230.844228894223, 6247.344028876993, 6258.249010118815, 6267.467265282411, 6275.121482992385, 6252.5935814171935, 6352.237731472253, 6353.714082866282, 6356.364363563606, 6367.745290188341, 4622.9768851156205, 4946.826861059845, 6288.717007734663, 6305.117283580303, 6311.431971122621, 6208.937910620926, 6292.119103325538, 6296.905546416808, 6313.05304204373, 6326.905096423558, 3987.5613682494904, 4996.150654388763, 5014.373203349582, 5016.648834581544, 5033.471485494044, 3349.3468773588916, 4090.775007374623, 4412.183746006999, 4493.123840851068, 4512.34570987205, 4958.9504104959215, 5935.109733540004, 6010.128531363015, 6037.45662890342, 6051.485623721945, 6324.936750632435, 6352.269489008823, 6375.521835862329, 6389.712462939179, 6410.038494225903, 5765.654060756368, 6023.909641355383, 6026.487748541423, 6048.092786082035, 6099.9085013724825, 5487.807926722546, 5569.19246709233, 5570.2480165177185, 5572.609917305831, 5605.0, 6582.144321238304, 6614.470842332602, 6629.966850165718, 6645.169353830771, 6645.3022432643875, 6174.66039367839, 6238.189035425366, 6291.842703932255, 6337.841553961188, 6382.585131966407, 6595.175603049619, 6612.0, 6640.203175618763, 6640.800775976729, 6654.168228971379, 6113.415495409368, 6255.687215639109, 6271.404216599416, 6296.244450665949, 6311.211098612674, 6243.875122497434, 6247.281562620356, 6275.96862015687, 6284.685765711788, 6335.303116657072, 5999.400059993965, 6188.195534580475, 6215.875682486416, 6233.2208473940755, 6248.781292654735, 6118.649636126507, 6152.0156774915795, 6194.442500175006, 6215.720292586754, 6226.688665566613, 6014.789482368271, 6055.909161362495, 6146.170267013896, 6163.291221509584, 6175.011998080286, 6197.070439434121, 6202.968985155046, 6215.906761398673, 6217.564770466205, 6232.189815323979, 5993.760249589967, 6078.969605151946, 6108.675989702823, 6169.105479705508, 6169.938300616936], "value": 5752.981602688118, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [517.5523172455826, 535.1197280473621, 539.8947205294965, 565.6492974355897, 577.7371296060293, 40172.0, 42747.35878961814, 42855.78572107139, 42931.57068429315, 43041.0, 43123.13753724931, 43498.130037399314, 43882.56117438825, 43926.78036609812, 43932.0, 8236.588170591476, 9543.236541076714, 9735.951320243388, 9786.608535658565, 9795.363301385387, 8307.210814972568, 9625.663101791439, 9691.0, 9721.270904682176, 9745.415275083518, 9747.268954828416, 9769.120779129877, 9797.02029797018, 9802.852957205647, 9804.117629413351, 8453.196946290092, 9722.854157187649, 9764.60941562333, 9787.706368808947, 9797.922228554853, 9464.905350946472, 9537.380070295409, 9580.473073980927, 9597.23222142227, 9601.47191904445, 34657.30685386303, 38785.806070969746, 39917.40123898144, 40254.0, 40261.798691006356, 2875.7699384049433, 3094.149108995022, 3150.3699260147832, 3421.7433692473164, 3443.8450269737923, 27622.309442264104, 28762.856185718938, 29113.892626446734, 29516.11451656432, 29596.408071838658, 2623.2130360891656, 2689.341111427713, 2715.728427157288, 2784.5266304728043, 2785.902493412741, 355449.0, 358326.0, 359381.0, 360259.3974060252, 361496.0, 34735.30529389398, 34767.4784878227, 35747.4637880432, 35767.821160894026, 35902.0, 37706.8114659425, 38047.0, 38065.809670951465, 38090.0, 38181.42727859085, 15387.461438849587, 15416.075035497906, 15615.453459129103, 15636.2181890905, 15656.765148522782, 12657.367131643381, 12969.092163548461, 12975.221486710827, 13075.542356017493, 13077.738445231042, 8042.597870106471, 8053.476524025919, 8226.383021273308, 8245.670173193004, 8379.329653627696, 3408.1820363112674, 3428.708559772397, 3432.3135372925017, 3444.8794292200155, 3464.0993341731332, 934.5747684803398, 954.6754103604808, 961.7451375385389, 971.3249291742171, 1080.6649938519083, 26351.73648263531, 30230.09309720712, 30427.391452170832, 30546.847265763972, 30886.536701949488, 1067.2315932528722, 1088.78768640116, 1097.8188598881095, 1144.6566030190909, 1212.7271363943041, 13448.663783405493, 14076.718465630835, 15088.924555377373, 15147.924260378848, 15410.075395476308, 578593.0, 750020.0, 752951.0, 754751.0, 754998.0, 51496.0, 59195.0, 59220.0, 60759.6962015196, 61273.0, 1452.7602945514084, 1464.3264098514803, 1468.6915747693104, 1469.1846025455761, 1473.6684246044554, 28688.13935581936, 28915.7108428913, 29375.26561835886, 29470.0, 29570.408591828473, 53150.0, 59239.70380148244, 60854.0, 60908.08637870347, 64165.39586510375, 621185.0, 626223.0, 627839.0, 629620.0, 630488.0, 42429.57570424256, 43248.351274730274, 43333.3499997494, 43511.34732979071, 44226.778866105466, 47484.28773568468, 48122.759386202844, 48205.0, 48290.51709483001, 48618.5138148614, 39642.405363920145, 39648.80175599104, 39767.0, 39917.401238980856, 40430.59569404386, 38980.415293771184, 39013.0, 39262.60737392589, 39679.00802479961, 40039.19921601493, 32691.509627356085, 38107.618923810405, 38722.61277387303, 38730.284693979665, 39220.80389598034, 29256.390898500787, 30189.792408303423, 34490.82754586211, 35459.29081418409, 35641.82179089088, 24145.034198631856, 25344.11295604645, 25459.10893118732, 25747.613785792855, 25837.354066148495], "value": 18774.32124803928, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [312.8736548425668, 365.7145134850999, 376.58387481832574, 387.7363392892833, 394.15847166299943, 19605.901970490144, 19867.60264794705, 20673.276435324766, 20931.0, 20950.952452377358, 20862.895685521587, 20868.895655521737, 20892.268770593033, 20964.951752412395, 21275.14899404022, 5812.883742325151, 5889.116632505115, 6073.331933487313, 6086.087086936951, 6140.508759299268, 6004.0, 6047.3650266722025, 6093.146959425684, 6111.816645500642, 6174.969125154368, 5648.632838865481, 5871.500922421578, 5985.670788106652, 6003.1895694081395, 6062.393760623946, 5760.9711951440395, 5994.370591087938, 6028.1861948636815, 6058.757649694007, 6102.084687296897, 5886.293644762613, 5907.734151963129, 5945.554083443759, 5950.434708702666, 6001.1898393717165, 13299.468021279137, 13355.065145439823, 13633.454661813515, 13684.726305473934, 20217.281531069875, 2059.4542446251753, 2130.8508404411696, 2175.380016695234, 2194.3307291276155, 2292.346681195851, 8345.624446899843, 10054.597816087347, 10101.292909496338, 10317.74205644865, 10355.637552685695, 1732.0646850700607, 1781.7683701118901, 1781.8752687311894, 1800.1539276540136, 1804.2061492943062, 87641.30141974869, 116279.0, 126227.0, 128802.71197288, 132672.0099198513, 9429.905700942903, 11470.59852905161, 11921.88078119225, 11924.821127683092, 12220.022398208122, 14724.411023559152, 14775.0, 14816.629584260265, 14843.332050057774, 14877.553673389815, 8012.31895288907, 8195.836083278302, 8648.870266946002, 8852.601632926533, 8932.151445612657, 7382.0, 8834.072422395557, 8938.4190027648, 8974.326925480615, 9025.142611451902, 3799.677027452642, 3833.5208098987628, 4491.550844915548, 4661.0, 4731.243001119804, 1676.8658507319385, 1730.6365663210868, 1965.4398496428448, 1985.067018501302, 1990.6317331293758, 903.4308385716956, 940.6895724410928, 955.8852937647526, 1049.506731836036, 1096.4517741129434, 20142.093605787773, 20323.0, 20375.592488150152, 20737.170513179302, 20778.896105519678, 960.6157536985122, 966.5988614724811, 976.7558110472382, 1001.9048190421898, 1033.6692258477365, 8092.3930705197345, 10157.238207134347, 10660.840087398696, 10859.18556108295, 10941.726456838644, 597445.0, 602257.0, 602673.0, 606396.0, 615270.0, 97871.0, 108316.0, 114985.85014149752, 130237.0, 135795.0, 941.23759754599, 956.3783540698463, 973.756560859785, 978.8580655804868, 1005.3364779245662, 18184.36354727578, 18318.619883391475, 18406.631867362845, 18464.81535184631, 18576.0, 54871.72564137154, 55225.0, 55737.72131139319, 57045.714771427534, 57247.42752572421, 78193.60903195447, 81480.0, 82569.58715206386, 82898.0, 84818.33499157606, 7004.789856304319, 7382.52013619113, 7497.62511874415, 7500.474966752493, 7536.7362142324755, 12151.574694885636, 12663.176893501894, 12801.231926084465, 12982.870171298544, 13019.934900325818, 11172.0, 11186.552537898719, 11315.321080735182, 11365.261258018203, 11423.0, 5171.534561889448, 9164.541772911194, 9664.275179361435, 10990.615328463466, 11090.279131856403, 9725.513724313614, 10934.781304374028, 11120.666380008613, 11484.655460336204, 11612.767744645229, 7368.115826100902, 7427.071616047994, 7506.061742282215, 7537.434692397982, 7681.923180768121, 9515.904840951502, 9865.210783137189, 10703.946480267548, 10791.460426978776, 11551.480183391935], "value": 9325.289898699097, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1432.8495507971663, 1601.5435600853755, 1837.6967800312948, 1935.8257756801886, 1968.065169044703, 8138.633761480733, 8639.481631102139, 8722.781930451742, 9160.496172710507, 9195.724128276146, 8711.346649001334, 8841.204291613769, 8926.0, 8933.062028486996, 8933.731988040354, 2430.1130087518104, 2430.5138972205586, 2450.656908032877, 2450.7059152901675, 2458.2748089313604, 2418.322869596516, 2428.9878550607223, 2446.1683027770555, 2451.0685939343025, 2455.312512496504, 2011.567512984708, 2053.486628342914, 2057.4753437873396, 2446.0949448704005, 2450.4608986023045, 2083.895535366258, 2237.977620223793, 2301.2175860207526, 2304.412374844421, 2313.363824948136, 2383.964240536376, 2401.747816479262, 2413.4207790130417, 2415.3599296186526, 2416.4683769570843, 8760.912390876074, 8995.280377569845, 9018.188363047357, 9021.32340074497, 9027.954860225656, 5363.919541206885, 5498.147787093007, 5522.30971128609, 5524.751386187631, 5556.583256255756, 3598.946015809765, 3624.981875090634, 3643.9979005773357, 3688.870889518854, 3695.8891233263043, 1012.185190921308, 1057.2916146182076, 1057.312746714634, 1065.0680654427376, 1073.924825262232, 12012.279263244232, 12163.635090947197, 12195.0, 12202.633920982296, 12290.754184916252, 4667.393238878924, 4903.33804936329, 5000.4999500050435, 5003.5997120230295, 5022.2466630005065, 10152.543135558917, 10225.130863876506, 10245.7438564035, 10272.383656980604, 10294.897051029393, 5409.891802164014, 5425.403205647375, 5432.266644003009, 5464.043792336404, 5516.972415137979, 4485.0805584855025, 4744.525547445297, 4971.477994810565, 5007.349044624176, 5010.49895010496, 3416.8462419191196, 4107.938380924288, 4236.279832428495, 4249.787510624456, 4286.271333873249, 1348.6291269900855, 1379.9793003104962, 1392.7701929181774, 1395.7143709834647, 1395.783653533704, 907.7095329494631, 915.2632131134501, 917.5779141594808, 936.7845395558924, 968.4721826604376, 5747.5114615257335, 5946.07835785454, 5986.3714309997695, 5987.221661184019, 6028.698565071729, 445.58337954012455, 447.75149791865175, 461.8106576303699, 474.8195685639504, 479.1590758219303, 3899.3760998240145, 3953.881383558498, 4004.039030632627, 4009.759414435085, 4041.6362527372676, 10288.8682244953, 10583.206259530565, 10699.679009629723, 10706.250562460553, 10879.945600271947, 10494.475276236157, 10776.838347424795, 10805.189610779224, 10820.783584328427, 10821.458927053773, 8233.711820086388, 8380.580970951429, 8395.70615028471, 8423.11557286476, 8462.576871156418, 5950.4644581986095, 5969.194158788681, 5983.012802887475, 6188.783392581238, 6199.628022318675, 7373.5575865448245, 10072.546735396778, 10343.224258180517, 10344.482775861328, 10418.843717344398, 10247.641332553325, 10419.479026048819, 10428.322159059637, 10430.791384172426, 10463.006014428616, 6903.6203008835, 7075.929240707733, 7616.885746713914, 7677.61611919413, 7806.336461400618, 8415.3267738582, 8485.278751306209, 8512.74461766148, 8571.742847714579, 8575.656973720981, 7525.623718814147, 7644.885326719992, 7746.30283274508, 7770.611469426393, 7787.493812902143, 6059.848503787441, 7457.067866516685, 7533.096028476618, 7580.62096895142, 7638.770836874903, 7119.537230080028, 7163.31948464895, 7209.567425954459, 7236.493445458767, 7240.891386629311, 4790.473047964651, 4815.422149342101, 4954.950450495449, 5007.273945277987, 5141.974290128525, 4021.9396709049975, 4035.41486484464, 4050.736702114353, 4159.480064991876, 4166.1251137261515], "value": 4555.489343501852, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [313.34979916672904, 316.3499009535404, 318.49518513156636, 320.0270333394622, 320.3480916335258, 4805.567498925096, 4853.223484242518, 5128.948565544064, 5543.25166102576, 5618.0, 4883.218685010399, 5041.647084704063, 5281.102212623853, 5398.406175320712, 5438.374586922505, 3212.775105742599, 3529.9763068710045, 3777.5466943966762, 3823.012033742466, 4210.789460526977, 3445.5865296164498, 3448.8448019839166, 4122.721956193574, 4138.7516748995, 4156.355764856437, 3829.349010668193, 3935.9963209381567, 4111.149982507868, 4134.710570260083, 4175.54069052404, 3569.036360182736, 3959.267535505912, 4083.938176074242, 4167.291560434718, 4203.55862634422, 3188.713015828587, 3611.1513794258326, 3611.765235259726, 3613.241219343941, 3620.6560376764164, 4220.78896055196, 5335.946640533583, 5336.905934283463, 5373.973130134364, 5380.4350543192795, 4276.679249056333, 4454.309582014793, 4806.879828004293, 4840.6127509799135, 4845.830395936126, 5336.91994620081, 5622.887542249132, 5803.781205946756, 5835.270591176103, 5868.677222752747, 3562.3765840977726, 3758.1919887224103, 4026.979865100656, 4048.67610591152, 4062.578097665823, 5399.623096110506, 5961.0, 6117.847053823645, 6121.969390153065, 6156.630602163885, 3997.980010099989, 4036.8385264589087, 4063.9840039990004, 4067.9050289101137, 4067.91864162721, 3360.5463262459257, 3533.505309256706, 4117.732347397409, 4124.91750164995, 4125.195586860534, 4379.934300985487, 4436.334549817553, 4765.999140180601, 4785.234362501983, 4790.203673622392, 4715.669903106749, 5129.435762066169, 5146.485351464824, 5604.075327570987, 5618.887622247532, 1303.6414985878769, 1350.9125154250921, 1352.3981828086603, 1410.4428750643438, 1411.5976946570179, 786.9173736757673, 800.2357748350312, 828.9544075075808, 836.3476488338983, 894.865770134485, 4178.051741104627, 4612.463145270088, 4700.7671356105575, 4800.35195248644, 5024.095662780662, 5400.919816036809, 5437.564994800407, 5757.568182386338, 5919.0, 6109.694515274218, 4861.975690121598, 5428.83713488596, 5455.1544510600925, 5489.286392768914, 5502.5597952163735, 2852.3011862093504, 2897.27568107973, 3008.533677280025, 3149.5118256670253, 3151.3697260547983, 5098.643094983316, 5611.9337325907945, 5948.940510594839, 6221.720022598994, 6292.2134733158355, 5121.797627020343, 5998.000999500163, 6135.32511423743, 6194.907076393858, 6294.402031806971, 5698.230738850285, 5755.70496638253, 5767.8558036049435, 6346.650934198571, 6401.647909364937, 4554.407926969473, 5652.208690783212, 5819.912701309399, 6120.602160859708, 6137.386261374006, 5449.692073902155, 5523.950449414599, 5948.137520059654, 5983.311919129356, 5994.28068631767, 5493.890122197454, 5774.564134340061, 5941.940580594139, 6176.783812566719, 6373.418765400021, 3674.8162591870832, 3713.9442908356937, 3905.628965248297, 3972.331620719247, 3992.720509564419, 5236.895262094813, 5336.612480754954, 5886.146508756292, 5931.894177567075, 5995.100734889627, 5482.91775623358, 5739.311282646109, 5822.302837698007, 5833.6874203305615, 5863.413658634103, 4901.754912254444, 5113.821016264413, 5160.329157209539, 5764.971175144097, 5773.393793651606, 4349.652027837828, 5661.46216109469, 5736.799212027726, 5749.9175585333205, 5800.0, 5537.280153580009, 5649.4350564944825, 5816.0, 5843.2403787507355, 5859.765609375748, 5111.87220319495, 5382.515573598395, 5732.598718089694, 5773.364929857797, 5841.415858414124], "value": 4159.759595754598, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [659.1694464974131, 683.695755388852, 694.4305669351135, 708.950373473857, 736.1313649893126, 15150.545483635495, 15607.141607211599, 15691.37234510621, 15700.76448853268, 16762.329506819744, 16286.267117979689, 16396.918015409938, 16702.916485417554, 16724.749128763047, 16735.581610459743, 928.4568527411473, 932.2541966426866, 937.409432057806, 938.0, 938.6949241496507, 733.1275781819618, 901.8016036471965, 935.822193783179, 937.1097457415449, 938.2728385501223, 947.3179310896178, 972.1445128287132, 974.098958463422, 977.7702239973636, 978.4227305889524, 972.6109556177515, 974.2741657465199, 974.6101559376235, 974.868392766978, 977.5063592885618, 719.0257201491955, 720.1969803668871, 721.2679130682361, 721.9205887352387, 723.5080145501057, 13631.454741810316, 14225.648563386461, 15389.538313850491, 15426.9228653856, 15465.690686186213, 12362.690932726664, 12477.93761031189, 12505.3747312634, 12540.937295313557, 12794.168379055332, 9895.505224738807, 10269.74325641865, 10301.845472317922, 10354.637587684394, 10581.047705706447, 3458.0490365149535, 3501.6498350165034, 3502.1069627245142, 3527.470879368115, 3578.499010138583, 93828.0, 93923.53038234766, 94956.57565136529, 96016.0, 96347.0, 9194.391860505788, 9329.860052099224, 9404.200642945427, 9508.572114254875, 9846.310758246855, 17458.825411745718, 18990.810091898904, 21839.78160218409, 21875.0, 22055.22806701758, 6037.792441511715, 7166.53417527859, 7186.532875363189, 7349.154847192534, 7350.301721336465, 3875.2249550090096, 3906.5898080701686, 3921.0, 3942.3495123304906, 3945.1715139820385, 3634.47300141478, 3752.0057184846037, 3752.380857158593, 3753.6997040236715, 3761.3793724035777, 640.8333833203401, 654.4306453385585, 659.3571268013649, 662.0367365483211, 664.4949838123061, 465.206822367862, 500.7521276967924, 508.14631419216073, 588.114887094928, 604.8336707405499, 7771.300582947449, 7851.254130857559, 8102.906107675389, 8276.503409795432, 8353.457025293337, 505.5147058823497, 518.7380372911656, 553.2089112568984, 570.7688386203595, 571.4228629084654, 3420.81185534793, 3701.851925922987, 3869.4776205212497, 3958.4656071430563, 4034.464372031791, 85632.14367856366, 86335.56832215798, 98479.0, 99627.0, 102675.0, 80083.59958200171, 80159.797603036, 81457.0, 82143.17856821475, 82490.58754706188, 65893.34106658968, 66348.00477992737, 66971.9908402739, 67042.99435508471, 67172.0, 7682.308592226726, 7699.037620297463, 7738.458307918391, 7821.335186508983, 7977.082635496992, 44169.33745993749, 44350.556494435936, 45118.548814512746, 45318.320225197305, 45685.0, 61947.07079393722, 62444.68777656083, 62480.68759656173, 62648.373516266074, 62761.0, 8566.871496927675, 10076.848847267443, 10317.432541210306, 10479.94760026195, 10535.525901334306, 11072.114230861673, 11106.333619982826, 11136.888631113585, 11268.985791278825, 11374.31754094757, 10487.685369438928, 10557.366558006544, 10676.306040107369, 10882.510287036945, 10938.945305273422, 10277.229207809594, 10875.51060202277, 10905.509252083833, 10928.453577320943, 11014.724631884266, 10373.533191006574, 10814.0, 11234.831477528007, 11236.94381528087, 11333.659990200307, 9507.809843803223, 9601.951990240004, 9639.325247232626, 9734.269929755155, 9780.951095244478, 9421.199198068241, 10108.360990043431, 10146.644867429604, 10160.542775575264, 10178.694639160836], "value": 6844.910626580879, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1603.1000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 115.0, 105.0, 119.0, 126.0, 115.0, 106.0, 116.0, 140.0, 171.0], "value": 122.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 151.0, 174.0, 192.0, 126.0, 159.0, 142.0, 122.0, 169.0, 126.0], "value": 152.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [193.0, 251.0, 248.0, 269.0, 194.0, 214.0, 229.0, 198.0, 193.0, 196.0], "value": 218.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 80.0, 76.0, 173.0, 56.0, 57.0, 58.0, 65.0, 133.0, 57.0], "value": 82.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 84.0, 146.0, 78.0, 83.0, 101.0, 113.0, 84.0, 114.0, 156.0], "value": 103.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 88.0, 92.0, 90.0, 89.0, 131.0, 94.0, 88.0, 91.0, 78.0], "value": 93.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 131.0, 98.0, 155.0, 113.0, 152.0, 96.0, 97.0, 98.0, 97.0], "value": 113.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 119.0, 110.0, 91.0, 91.0, 110.0, 122.0, 91.0, 90.0, 92.0], "value": 100.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 59.0, 59.0, 59.0, 60.0, 59.0, 58.0, 117.0, 61.0, 59.0], "value": 64.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 67.0, 80.0, 76.0, 70.0, 66.0, 65.0, 59.0, 74.0], "value": 68.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 86.0, 86.0, 90.0, 87.0, 84.0, 87.0, 88.0, 91.0], "value": 87.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 144.0, 134.0, 151.0, 171.0, 154.0, 146.0, 137.0, 212.0, 153.0], "value": 153.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 166.0, 165.0, 164.0, 163.0, 162.0, 166.0, 164.0, 162.0, 161.0], "value": 163.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 75.0, 84.0, 84.0, 58.0, 73.0, 87.0, 86.0, 86.0, 81.0], "value": 78.2, "unit": "score"}]}]} 12:11:52 INFO - Return code: 0 12:11:52 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 12:11:52 ERROR - # TBPL SUCCESS # 12:11:52 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 12:11:52 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 12:11:52 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 12:11:52 INFO - 2016-05-16 12:11:52.578 screenresolution[1825:10662] starting screenresolution argv=screenresolution get 12:11:52 INFO - 2016-05-16 12:11:52.581 screenresolution[1825:10662] Display 0: 1600x1200x32@60 12:11:52 INFO - 2016-05-16 12:11:52.587 screenresolution[1826:10665] starting screenresolution argv=screenresolution list 12:11:52 INFO - Available Modes on Display 0 12:11:52 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 12:11:52 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 12:11:52 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 12:11:52 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 12:11:52 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 12:11:52 INFO - Intel Iris: 12:11:52 INFO - Chipset Model: Intel Iris 12:11:52 INFO - Type: GPU 12:11:52 INFO - Bus: Built-In 12:11:52 INFO - VRAM (Dynamic, Max): 1536 MB 12:11:52 INFO - Vendor: Intel (0x8086) 12:11:52 INFO - Device ID: 0x0a2e 12:11:52 INFO - Revision ID: 0x0009 12:11:52 INFO - Displays: 12:11:52 INFO - Display: 12:11:52 INFO - Resolution: 1600 x 1200 @ 60 Hz 12:11:52 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 12:11:52 INFO - Display Serial Number: 1600x1200 60 12:11:52 INFO - Main Display: Yes 12:11:52 INFO - Mirror: Off 12:11:52 INFO - Online: Yes 12:11:52 INFO - Rotation: Supported 12:11:52 INFO - Return code: 0 12:11:52 INFO - Running post-action listener: _resource_record_post_action 12:11:52 INFO - ##### 12:11:52 INFO - ##### Finished run-tests step (success) 12:11:52 INFO - ##### 12:11:52 INFO - Running post-run listener: _resource_record_post_run 12:11:52 INFO - Total resource usage - Wall time: 1210s; CPU: 55.0%; Read bytes: 36668928; Write bytes: 698243584; Read time: 237; Write time: 1941 12:11:52 INFO - TinderboxPrint: CPU usage
54.5% 12:11:52 INFO - TinderboxPrint: I/O read bytes / time
36,668,928 / 237 12:11:52 INFO - TinderboxPrint: I/O write bytes / time
698,243,584 / 1,941 12:11:52 INFO - TinderboxPrint: CPU idle
2,200.5 (45.5%) 12:11:52 INFO - TinderboxPrint: CPU system
979.0 (20.2%) 12:11:52 INFO - TinderboxPrint: CPU user
1,662.1 (34.3%) 12:11:52 INFO - TinderboxPrint: Swap in / out
431,665,152 / 0 12:11:52 INFO - install - Wall time: 34s; CPU: 55.0%; Read bytes: 395840000; Write bytes: 397309952; Read time: 29777; Write time: 788 12:11:52 INFO - run-tests - Wall time: 1176s; CPU: 55.0%; Read bytes: 34854400; Write bytes: 300085760; Read time: 221; Write time: 1151 12:11:53 INFO - Running post-run listener: _upload_blobber_files 12:11:53 INFO - Blob upload gear active. 12:11:53 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:11:53 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 12:11:53 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', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 12:11:53 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 Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 12:11:53 INFO - (blobuploader) - INFO - Open directory for files ... 12:11:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 12:11:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:11:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:11:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 12:11:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:11:54 INFO - (blobuploader) - INFO - Done attempting. 12:11:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 12:11:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:11:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:11:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 12:11:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:11:55 INFO - (blobuploader) - INFO - Done attempting. 12:11:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 12:11:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:11:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:11:58 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 12:11:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:11:58 INFO - (blobuploader) - INFO - Done attempting. 12:11:58 INFO - (blobuploader) - INFO - Iteration through files over. 12:11:58 INFO - Return code: 0 12:11:58 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:11:58 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:11:58 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9f476602116778cbbafbf385e920dc9c34eabc898db8b951d635a3515302bda12a15c607c171f121b2852c3e456f1a17fdb6df570dfde68292d690c00e556ec2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4caec210f13bd1d9573f69e16e326d0dbe2208e5c6d022e219aff86a15599661d7aa0216028c3547d9e97d660247c8d9d39dc94b9bb46d772ff6cb2c26f564f2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e9f3aeecce5ccb78e19da7b9292757a38e2f3bc02a331e29ddc3afc88d932f21aeffb545e3ffe89128990b3f044a72a12adf7685fba85ea4aa3d4ab10342fc62"} 12:11:58 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:11:58 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:11:58 INFO - Contents: 12:11:58 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9f476602116778cbbafbf385e920dc9c34eabc898db8b951d635a3515302bda12a15c607c171f121b2852c3e456f1a17fdb6df570dfde68292d690c00e556ec2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4caec210f13bd1d9573f69e16e326d0dbe2208e5c6d022e219aff86a15599661d7aa0216028c3547d9e97d660247c8d9d39dc94b9bb46d772ff6cb2c26f564f2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e9f3aeecce5ccb78e19da7b9292757a38e2f3bc02a331e29ddc3afc88d932f21aeffb545e3ffe89128990b3f044a72a12adf7685fba85ea4aa3d4ab10342fc62"} 12:11:58 INFO - Running post-run listener: copy_logs_to_upload_dir 12:11:58 INFO - Copying logs to upload dir... 12:11:58 INFO - mkdir: /builds/slave/test/build/upload/logs 12:11:58 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1269.741648 ========= master_lag: 1.19 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2016-05-16 12:11:59.745715) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-16 12:11:59.751619) ========= 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.yQGdPv9ht4/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.ZTaiaekecT/Listeners TMPDIR=/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/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-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9f476602116778cbbafbf385e920dc9c34eabc898db8b951d635a3515302bda12a15c607c171f121b2852c3e456f1a17fdb6df570dfde68292d690c00e556ec2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4caec210f13bd1d9573f69e16e326d0dbe2208e5c6d022e219aff86a15599661d7aa0216028c3547d9e97d660247c8d9d39dc94b9bb46d772ff6cb2c26f564f2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e9f3aeecce5ccb78e19da7b9292757a38e2f3bc02a331e29ddc3afc88d932f21aeffb545e3ffe89128990b3f044a72a12adf7685fba85ea4aa3d4ab10342fc62"} build_url:https://queue.taskcluster.net/v1/task/I8C8TsMyTcyE0Dh8RKS1Cg/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011122 build_url: 'https://queue.taskcluster.net/v1/task/I8C8TsMyTcyE0Dh8RKS1Cg/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9f476602116778cbbafbf385e920dc9c34eabc898db8b951d635a3515302bda12a15c607c171f121b2852c3e456f1a17fdb6df570dfde68292d690c00e556ec2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4caec210f13bd1d9573f69e16e326d0dbe2208e5c6d022e219aff86a15599661d7aa0216028c3547d9e97d660247c8d9d39dc94b9bb46d772ff6cb2c26f564f2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e9f3aeecce5ccb78e19da7b9292757a38e2f3bc02a331e29ddc3afc88d932f21aeffb545e3ffe89128990b3f044a72a12adf7685fba85ea4aa3d4ab10342fc62"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-16 12:11:59.793033) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-16 12:11:59.796419) ========= 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.yQGdPv9ht4/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.ZTaiaekecT/Listeners TMPDIR=/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/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.004502 ========= master_lag: 0.68 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-16 12:12:00.477722) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-16 12:12:00.478146) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-16 12:12:00.478991) ========= ========= Total master_lag: 1.96 =========