builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0209 starttime: 1464442357.94 results: success (0) buildid: 20160528033932 builduid: a578fa7b871d4f22a35bf020ea4372fe revision: 199230f44725b8e4919a5014b9649a9951383355 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-28 06:32:37.936901) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-28 06:32:37.937761) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-28 06:32:37.938211) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-28 06:32:38.046470) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-28 06:32:38.046717) ========= 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.PYp9ygSX1b/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.HpJi1QcLvv/Listeners TMPDIR=/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/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-28 06:32:38-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 19.2M=0.001s 2016-05-28 06:32:38 (19.2 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.166613 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-28 06:32:38.233870) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-28 06:32:38.234147) ========= 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.PYp9ygSX1b/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.HpJi1QcLvv/Listeners TMPDIR=/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/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.025328 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-28 06:32:38.284091) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-28 06:32:38.284435) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 199230f44725b8e4919a5014b9649a9951383355 --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 199230f44725b8e4919a5014b9649a9951383355 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.PYp9ygSX1b/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.HpJi1QcLvv/Listeners TMPDIR=/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/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-28 06:32:38,358 truncating revision to first 12 chars 2016-05-28 06:32:38,358 Setting DEBUG logging. 2016-05-28 06:32:38,358 attempt 1/10 2016-05-28 06:32:38,358 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/199230f44725?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-28 06:32:39,217 unpacking tar archive at: fx-team-199230f44725/testing/mozharness/ program finished with exit code 0 elapsedTime=1.124778 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-28 06:32:39.429167) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-28 06:32:39.429460) ========= script_repo_revision: 199230f44725b8e4919a5014b9649a9951383355 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-28 06:32:39.429817) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-28 06:32:39.430079) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-28 06:32:39.445848) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 41 secs) (at 2016-05-28 06:32:39.446110) ========= /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.PYp9ygSX1b/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.HpJi1QcLvv/Listeners TMPDIR=/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 06:32:39 INFO - MultiFileLogger online at 20160528 06:32:39 in /builds/slave/test 06:32:39 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 06:32:39 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:32:39 INFO - {'append_to_log': False, 06:32:39 INFO - 'base_work_dir': '/builds/slave/test', 06:32:39 INFO - 'blob_upload_branch': 'Fx-Team', 06:32:39 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:32:39 INFO - 'branch': 'Fx-Team', 06:32:39 INFO - 'buildbot_json_path': 'buildprops.json', 06:32:39 INFO - 'config_files': ('talos/mac_config.py',), 06:32:39 INFO - 'default_actions': ('clobber', 06:32:39 INFO - 'read-buildbot-config', 06:32:39 INFO - 'download-and-extract', 06:32:39 INFO - 'populate-webroot', 06:32:39 INFO - 'create-virtualenv', 06:32:39 INFO - 'install', 06:32:39 INFO - 'run-tests'), 06:32:39 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:32:39 INFO - 'download_minidump_stackwalk': True, 06:32:39 INFO - 'download_symbols': 'ondemand', 06:32:39 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:32:39 INFO - 'tooltool.py': '/tools/tooltool.py', 06:32:39 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:32:39 INFO - '/tools/misc-python/virtualenv.py')}, 06:32:39 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:32:39 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:32:39 INFO - 'installer_path': 'installer.exe', 06:32:39 INFO - 'log_level': 'info', 06:32:39 INFO - 'log_name': 'talos', 06:32:39 INFO - 'log_to_console': True, 06:32:39 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 06:32:39 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 06:32:39 INFO - 'opt_config_files': (), 06:32:39 INFO - 'pip_index': False, 06:32:39 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 06:32:39 INFO - 'cmd': ('bash', 06:32:39 INFO - '-c', 06:32:39 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 06:32:39 INFO - 'enabled': True, 06:32:39 INFO - 'halt_on_failure': False, 06:32:39 INFO - 'name': 'check_screen_resolution'},), 06:32:39 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 06:32:39 INFO - 'cmd': ('bash', 06:32:39 INFO - '-c', 06:32:39 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 06:32:39 INFO - 'enabled': True, 06:32:39 INFO - 'halt_on_failure': False, 06:32:39 INFO - 'name': 'check_screen_resolution'},), 06:32:39 INFO - 'run_cmd_checks_enabled': True, 06:32:39 INFO - 'sps_profile': False, 06:32:39 INFO - 'sps_profile_interval': 0, 06:32:39 INFO - 'suite': 'dromaeojs-e10s', 06:32:39 INFO - 'system_bits': '32', 06:32:39 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:32:39 INFO - 'title': 't-yosemite-r7-0209', 06:32:39 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:32:39 INFO - 'use_talos_json': True, 06:32:39 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:32:39 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:32:39 INFO - 'work_dir': 'build'} 06:32:39 INFO - ##### 06:32:39 INFO - ##### Running clobber step. 06:32:39 INFO - ##### 06:32:39 INFO - Running pre-action listener: _resource_record_pre_action 06:32:39 INFO - Running main action method: clobber 06:32:39 INFO - rmtree: /builds/slave/test/build 06:32:39 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:32:41 INFO - Running post-action listener: _resource_record_post_action 06:32:41 INFO - ##### 06:32:41 INFO - ##### Finished clobber step (success) 06:32:41 INFO - ##### 06:32:41 INFO - ##### 06:32:41 INFO - ##### Running read-buildbot-config step. 06:32:41 INFO - ##### 06:32:41 INFO - Running pre-action listener: _resource_record_pre_action 06:32:41 INFO - Running main action method: read_buildbot_config 06:32:41 INFO - Using buildbot properties: 06:32:41 INFO - { 06:32:41 INFO - "project": "", 06:32:41 INFO - "product": "firefox", 06:32:41 INFO - "script_repo_revision": "production", 06:32:41 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 06:32:41 INFO - "repository": "", 06:32:41 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 06:32:41 INFO - "buildid": "20160528033932", 06:32:41 INFO - "pgo_build": "False", 06:32:41 INFO - "basedir": "/builds/slave/test", 06:32:41 INFO - "buildnumber": 8, 06:32:41 INFO - "slavename": "t-yosemite-r7-0209", 06:32:41 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 06:32:41 INFO - "platform": "yosemite_r7", 06:32:41 INFO - "scheduler": "tests-fx-team-macosx64-talos-7-3600", 06:32:41 INFO - "branch": "fx-team", 06:32:41 INFO - "repo_path": "integration/fx-team", 06:32:41 INFO - "revision": "199230f44725b8e4919a5014b9649a9951383355", 06:32:41 INFO - "stage_platform": "macosx64", 06:32:41 INFO - "builduid": "a578fa7b871d4f22a35bf020ea4372fe", 06:32:41 INFO - "slavebuilddir": "test" 06:32:41 INFO - } 06:32:41 INFO - Found installer url https://queue.taskcluster.net/v1/task/eYj2REvAQQeyS2Ff3U0M8A/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg. 06:32:41 INFO - Running post-action listener: _resource_record_post_action 06:32:41 INFO - ##### 06:32:41 INFO - ##### Finished read-buildbot-config step (success) 06:32:41 INFO - ##### 06:32:41 INFO - ##### 06:32:41 INFO - ##### Running download-and-extract step. 06:32:41 INFO - ##### 06:32:41 INFO - Running pre-action listener: _resource_record_pre_action 06:32:41 INFO - Running main action method: download_and_extract 06:32:41 INFO - mkdir: /builds/slave/test/build/tests 06:32:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:32:41 INFO - https://queue.taskcluster.net/v1/task/eYj2REvAQQeyS2Ff3U0M8A/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 06:32:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eYj2REvAQQeyS2Ff3U0M8A/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json 06:32:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eYj2REvAQQeyS2Ff3U0M8A/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json 06:32:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eYj2REvAQQeyS2Ff3U0M8A/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 06:32:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eYj2REvAQQeyS2Ff3U0M8A/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 06:33:08 INFO - Downloaded 1199 bytes. 06:33:08 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.mac.test_packages.json 06:33:08 INFO - Using the following test package requirements: 06:33:08 INFO - {u'common': [u'firefox-49.0a1.en-US.mac.common.tests.zip'], 06:33:08 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 06:33:08 INFO - u'firefox-49.0a1.en-US.mac.cppunittest.tests.zip'], 06:33:08 INFO - u'gtest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 06:33:08 INFO - u'firefox-49.0a1.en-US.mac.gtest.tests.zip'], 06:33:08 INFO - u'jittest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 06:33:08 INFO - u'jsshell-mac.zip'], 06:33:08 INFO - u'mochitest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 06:33:08 INFO - u'firefox-49.0a1.en-US.mac.mochitest.tests.zip'], 06:33:08 INFO - u'mozbase': [u'firefox-49.0a1.en-US.mac.common.tests.zip'], 06:33:08 INFO - u'reftest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 06:33:08 INFO - u'firefox-49.0a1.en-US.mac.reftest.tests.zip'], 06:33:08 INFO - u'talos': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 06:33:08 INFO - u'firefox-49.0a1.en-US.mac.talos.tests.zip'], 06:33:08 INFO - u'web-platform': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 06:33:08 INFO - u'firefox-49.0a1.en-US.mac.web-platform.tests.zip'], 06:33:08 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 06:33:08 INFO - u'firefox-49.0a1.en-US.mac.xpcshell.tests.zip']} 06:33:08 INFO - Downloading packages: [u'firefox-49.0a1.en-US.mac.common.tests.zip'] for test suite category: common 06:33:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:33:08 INFO - https://queue.taskcluster.net/v1/task/eYj2REvAQQeyS2Ff3U0M8A/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 06:33:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eYj2REvAQQeyS2Ff3U0M8A/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 06:33:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eYj2REvAQQeyS2Ff3U0M8A/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 06:33:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eYj2REvAQQeyS2Ff3U0M8A/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 06:33:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eYj2REvAQQeyS2Ff3U0M8A/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 06:33:18 INFO - Downloaded 18684798 bytes. 06:33:18 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'] 06:33:18 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 06:33:21 INFO - Return code: 0 06:33:21 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 06:33:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:33:21 INFO - https://queue.taskcluster.net/v1/task/eYj2REvAQQeyS2Ff3U0M8A/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 06:33:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eYj2REvAQQeyS2Ff3U0M8A/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 06:33:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eYj2REvAQQeyS2Ff3U0M8A/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 06:33:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eYj2REvAQQeyS2Ff3U0M8A/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 06:33:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eYj2REvAQQeyS2Ff3U0M8A/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 06:33:23 INFO - Downloaded 18684798 bytes. 06:33:23 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'] 06:33:23 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 06:33:27 INFO - Return code: 0 06:33: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')]} 06:33:27 INFO - https://queue.taskcluster.net/v1/task/eYj2REvAQQeyS2Ff3U0M8A/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 06:33:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eYj2REvAQQeyS2Ff3U0M8A/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip 06:33:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eYj2REvAQQeyS2Ff3U0M8A/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip 06:33:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eYj2REvAQQeyS2Ff3U0M8A/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 06:33:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eYj2REvAQQeyS2Ff3U0M8A/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 06:33:28 INFO - Downloaded 10834034 bytes. 06:33:28 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'] 06:33:28 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 06:33:28 INFO - Return code: 0 06:33:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:33:28 INFO - https://queue.taskcluster.net/v1/task/eYj2REvAQQeyS2Ff3U0M8A/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 06:33:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eYj2REvAQQeyS2Ff3U0M8A/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 06:33:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eYj2REvAQQeyS2Ff3U0M8A/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 06:33:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eYj2REvAQQeyS2Ff3U0M8A/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-49.0a1.en-US.mac.dmg 06:33:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eYj2REvAQQeyS2Ff3U0M8A/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 06:33:32 INFO - Downloaded 110488054 bytes. 06:33:32 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/eYj2REvAQQeyS2Ff3U0M8A/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 06:33:32 INFO - mkdir: /builds/slave/test/properties 06:33:32 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:33:32 INFO - Writing to file /builds/slave/test/properties/build_url 06:33:32 INFO - Contents: 06:33:32 INFO - build_url:https://queue.taskcluster.net/v1/task/eYj2REvAQQeyS2Ff3U0M8A/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 06:33:33 INFO - Running post-action listener: _resource_record_post_action 06:33:33 INFO - Running post-action listener: set_extra_try_arguments 06:33:33 INFO - ##### 06:33:33 INFO - ##### Finished download-and-extract step (success) 06:33:33 INFO - ##### 06:33:33 INFO - ##### 06:33:33 INFO - ##### Running populate-webroot step. 06:33:33 INFO - ##### 06:33:33 INFO - Running pre-action listener: _resource_record_pre_action 06:33:33 INFO - Running main action method: populate_webroot 06:33:33 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:33:33 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:33:33 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:33:33 INFO - '--tppagecycles', 06:33:33 INFO - '7'], 06:33:33 INFO - 'tests': ['tsvgm']}}, 06:33:33 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:33:33 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:33:33 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:33:33 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:33:33 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:33:33 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:33:33 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:33:33 INFO - 'talos_options': ['--disable-e10s'], 06:33:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:33:33 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:33:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:33:33 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:33:33 INFO - 'talos_options': ['--disable-e10s'], 06:33:33 INFO - 'tests': ['damp', 'tps']}, 06:33:33 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:33:33 INFO - 'tests': ['damp', 'tps']}, 06:33:33 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:33:33 INFO - 'tests': ['dromaeo_dom']}, 06:33:33 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:33:33 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:33:33 INFO - 'tests': ['a11yr', 06:33:33 INFO - 'ts_paint', 06:33:33 INFO - 'tpaint', 06:33:33 INFO - 'sessionrestore', 06:33:33 INFO - 'sessionrestore_no_auto_restore', 06:33:33 INFO - 'tabpaint']}, 06:33:33 INFO - 'other-e10s': {'tests': ['a11yr', 06:33:33 INFO - 'ts_paint', 06:33:33 INFO - 'tpaint', 06:33:33 INFO - 'sessionrestore', 06:33:33 INFO - 'sessionrestore_no_auto_restore', 06:33:33 INFO - 'tabpaint']}, 06:33:33 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:33:33 INFO - 'ts_paint', 06:33:33 INFO - 'tpaint', 06:33:33 INFO - 'sessionrestore', 06:33:33 INFO - 'sessionrestore_no_auto_restore', 06:33:33 INFO - 'tabpaint']}, 06:33:33 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:33:33 INFO - 'ts_paint', 06:33:33 INFO - 'tpaint', 06:33:33 INFO - 'sessionrestore', 06:33:33 INFO - 'sessionrestore_no_auto_restore', 06:33:33 INFO - 'tabpaint']}, 06:33:33 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:33:33 INFO - 'tests': ['a11yr', 06:33:33 INFO - 'ts_paint', 06:33:33 INFO - 'tpaint', 06:33:33 INFO - 'sessionrestore', 06:33:33 INFO - 'sessionrestore_no_auto_restore', 06:33:33 INFO - 'tabpaint']}, 06:33:33 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:33:33 INFO - 'tests': ['a11yr', 06:33:33 INFO - 'ts_paint', 06:33:33 INFO - 'tpaint', 06:33:33 INFO - 'sessionrestore', 06:33:33 INFO - 'sessionrestore_no_auto_restore', 06:33:33 INFO - 'tabpaint']}, 06:33:33 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:33:33 INFO - 'tests': ['tsvgx', 06:33:33 INFO - 'tsvgr_opacity', 06:33:33 INFO - 'tart', 06:33:33 INFO - 'tscrollx', 06:33:33 INFO - 'cart']}, 06:33:33 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:33:33 INFO - 'tsvgr_opacity', 06:33:33 INFO - 'tart', 06:33:33 INFO - 'tscrollx', 06:33:33 INFO - 'cart']}, 06:33:33 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:33:33 INFO - 'talos_options': ['--disable-e10s'], 06:33:33 INFO - 'tests': ['tp5o']}, 06:33:33 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:33:33 INFO - 'tests': ['tp5o']}, 06:33:33 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:33:33 INFO - 'talos_options': ['--disable-e10s', 06:33:33 INFO - '--xperf_path', 06:33:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:33:33 INFO - 'tests': ['tp5n']}, 06:33:33 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:33:33 INFO - 'talos_options': ['--xperf_path', 06:33:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:33:33 INFO - 'tests': ['tp5n']}}, 06:33:33 INFO - 'talos.zip': {'path': '', 06:33:33 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:33:33 INFO - Running post-action listener: _resource_record_post_action 06:33:33 INFO - ##### 06:33:33 INFO - ##### Finished populate-webroot step (success) 06:33:33 INFO - ##### 06:33:33 INFO - ##### 06:33:33 INFO - ##### Running create-virtualenv step. 06:33:33 INFO - ##### 06:33:33 INFO - Running pre-action listener: _resource_record_pre_action 06:33:33 INFO - Running main action method: create_virtualenv 06:33:33 INFO - Creating virtualenv /builds/slave/test/build/venv 06:33:33 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 06:33:33 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:33:33 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:33:33 INFO - Using real prefix '/tools/python27' 06:33:33 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:33:34 INFO - Installing distribute.............................................................................................................................................................................................done. 06:33:37 INFO - Installing pip.................done. 06:33:37 INFO - Return code: 0 06:33:37 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:33:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:33:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:33:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:33:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:33:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:33:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:33:37 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 0x107187a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10718d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd6a9c8c870>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10702bd30>, '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 0x106e4fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107022b20>, '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.PYp9ygSX1b/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.HpJi1QcLvv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 06:33:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 06:33:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 06:33:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PYp9ygSX1b/Render', 06:33:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:33:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:33:37 INFO - 'HOME': '/Users/cltbld', 06:33:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:33:37 INFO - 'LOGNAME': 'cltbld', 06:33:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:33:37 INFO - 'MOZ_NO_REMOTE': '1', 06:33:37 INFO - 'NO_EM_RESTART': '1', 06:33:37 INFO - 'PAGER': '/bin/cat', 06:33:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:33:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:33:37 INFO - 'PWD': '/builds/slave/test', 06:33:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:33:37 INFO - 'SHELL': '/bin/bash', 06:33:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HpJi1QcLvv/Listeners', 06:33:37 INFO - 'TMPDIR': '/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/', 06:33:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:33:37 INFO - 'USER': 'cltbld', 06:33:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:33:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:33:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:33:37 INFO - 'XPC_FLAGS': '0x0', 06:33:37 INFO - 'XPC_SERVICE_NAME': '0', 06:33:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:33:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:33:37 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 06:33:37 INFO - Cleaning up... 06:33:37 INFO - Return code: 0 06:33:37 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 06:33:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:33:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:33:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:33:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:33:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:33:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:33:37 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 0x107187a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10718d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd6a9c8c870>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10702bd30>, '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 0x106e4fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107022b20>, '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.PYp9ygSX1b/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.HpJi1QcLvv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 06:33:37 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 06:33:37 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 06:33:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PYp9ygSX1b/Render', 06:33:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:33:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:33:37 INFO - 'HOME': '/Users/cltbld', 06:33:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:33:37 INFO - 'LOGNAME': 'cltbld', 06:33:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:33:37 INFO - 'MOZ_NO_REMOTE': '1', 06:33:37 INFO - 'NO_EM_RESTART': '1', 06:33:37 INFO - 'PAGER': '/bin/cat', 06:33:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:33:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:33:37 INFO - 'PWD': '/builds/slave/test', 06:33:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:33:37 INFO - 'SHELL': '/bin/bash', 06:33:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HpJi1QcLvv/Listeners', 06:33:37 INFO - 'TMPDIR': '/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/', 06:33:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:33:37 INFO - 'USER': 'cltbld', 06:33:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:33:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:33:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:33:37 INFO - 'XPC_FLAGS': '0x0', 06:33:37 INFO - 'XPC_SERVICE_NAME': '0', 06:33:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:33:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:33:37 INFO - Downloading/unpacking psutil>=3.1.1 06:33:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:33:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:33:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:33:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:33:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:33:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:33:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:33:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:33:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:33:40 INFO - Installing collected packages: psutil 06:33:40 INFO - Running setup.py install for psutil 06:33:40 INFO - building 'psutil._psutil_osx' extension 06:33:40 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 06:33:41 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 06:33:41 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 06:33:41 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 06:33:41 INFO - building 'psutil._psutil_posix' extension 06:33:41 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 06:33:41 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 06:33:41 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 06:33:41 INFO - ^ 06:33:41 INFO - 1 warning generated. 06:33:41 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 06:33:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:33:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:33:41 INFO - Successfully installed psutil 06:33:41 INFO - Cleaning up... 06:33:41 INFO - Return code: 0 06:33:41 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 06:33:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:33:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:33:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:33:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:33:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:33:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:33:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107187a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10718d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd6a9c8c870>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10702bd30>, '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 0x106e4fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107022b20>, '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.PYp9ygSX1b/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.HpJi1QcLvv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 06:33:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 06:33:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 06:33:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PYp9ygSX1b/Render', 06:33:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:33:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:33:41 INFO - 'HOME': '/Users/cltbld', 06:33:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:33:41 INFO - 'LOGNAME': 'cltbld', 06:33:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:33:41 INFO - 'MOZ_NO_REMOTE': '1', 06:33:41 INFO - 'NO_EM_RESTART': '1', 06:33:41 INFO - 'PAGER': '/bin/cat', 06:33:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:33:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:33:41 INFO - 'PWD': '/builds/slave/test', 06:33:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:33:41 INFO - 'SHELL': '/bin/bash', 06:33:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HpJi1QcLvv/Listeners', 06:33:41 INFO - 'TMPDIR': '/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/', 06:33:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:33:41 INFO - 'USER': 'cltbld', 06:33:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:33:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:33:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:33:41 INFO - 'XPC_FLAGS': '0x0', 06:33:41 INFO - 'XPC_SERVICE_NAME': '0', 06:33:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:33:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:33:41 INFO - Downloading/unpacking mozsystemmonitor==0.3 06:33: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 06:33: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 06:33: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 06:33: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 06:33: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 06:33: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 06:33:44 INFO - Downloading mozsystemmonitor-0.3.tar.gz 06:33:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:33:44 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 06:33:44 INFO - Installing collected packages: mozsystemmonitor 06:33:44 INFO - Running setup.py install for mozsystemmonitor 06:33:44 INFO - Successfully installed mozsystemmonitor 06:33:44 INFO - Cleaning up... 06:33:44 INFO - Return code: 0 06:33:44 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:33:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:33:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:33:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:33:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:33:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:33:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:33:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x107187a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10718d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd6a9c8c870>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10702bd30>, '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 0x106e4fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107022b20>, '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.PYp9ygSX1b/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.HpJi1QcLvv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 06:33:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 06:33:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 06:33:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PYp9ygSX1b/Render', 06:33:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:33:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:33:44 INFO - 'HOME': '/Users/cltbld', 06:33:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:33:44 INFO - 'LOGNAME': 'cltbld', 06:33:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:33:44 INFO - 'MOZ_NO_REMOTE': '1', 06:33:44 INFO - 'NO_EM_RESTART': '1', 06:33:44 INFO - 'PAGER': '/bin/cat', 06:33:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:33:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:33:44 INFO - 'PWD': '/builds/slave/test', 06:33:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:33:44 INFO - 'SHELL': '/bin/bash', 06:33:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HpJi1QcLvv/Listeners', 06:33:44 INFO - 'TMPDIR': '/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/', 06:33:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:33:44 INFO - 'USER': 'cltbld', 06:33:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:33:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:33:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:33:44 INFO - 'XPC_FLAGS': '0x0', 06:33:44 INFO - 'XPC_SERVICE_NAME': '0', 06:33:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:33:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:33:44 INFO - Downloading/unpacking blobuploader==1.2.4 06:33:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:33:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:33:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:33:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:33:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:33:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:33:47 INFO - Downloading blobuploader-1.2.4.tar.gz 06:33:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:33:47 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:33:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:33:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:33:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:33:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:33:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:33:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:33:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:33:48 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:33:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:33:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:33:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:33:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:33:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:33:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:33:48 INFO - Downloading docopt-0.6.1.tar.gz 06:33:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:33:48 INFO - Installing collected packages: blobuploader, requests, docopt 06:33:48 INFO - Running setup.py install for blobuploader 06:33:48 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:33:48 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:33:48 INFO - Running setup.py install for requests 06:33:49 INFO - Running setup.py install for docopt 06:33:49 INFO - Successfully installed blobuploader requests docopt 06:33:49 INFO - Cleaning up... 06:33:49 INFO - Return code: 0 06:33:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:33:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:33:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:33:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:33:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:33:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:33:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:33:49 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 0x107187a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10718d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd6a9c8c870>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10702bd30>, '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 0x106e4fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107022b20>, '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.PYp9ygSX1b/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.HpJi1QcLvv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 06:33:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 06:33:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 06:33:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PYp9ygSX1b/Render', 06:33:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:33:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:33:49 INFO - 'HOME': '/Users/cltbld', 06:33:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:33:49 INFO - 'LOGNAME': 'cltbld', 06:33:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:33:49 INFO - 'MOZ_NO_REMOTE': '1', 06:33:49 INFO - 'NO_EM_RESTART': '1', 06:33:49 INFO - 'PAGER': '/bin/cat', 06:33:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:33:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:33:49 INFO - 'PWD': '/builds/slave/test', 06:33:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:33:49 INFO - 'SHELL': '/bin/bash', 06:33:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HpJi1QcLvv/Listeners', 06:33:49 INFO - 'TMPDIR': '/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/', 06:33:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:33:49 INFO - 'USER': 'cltbld', 06:33:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:33:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:33:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:33:49 INFO - 'XPC_FLAGS': '0x0', 06:33:49 INFO - 'XPC_SERVICE_NAME': '0', 06:33:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:33:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:33:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:33:49 INFO - Running setup.py (path:/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/pip-WRYeS7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:33:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:33:49 INFO - Running setup.py (path:/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/pip-C833M_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:33:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:33:49 INFO - Running setup.py (path:/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/pip-PX9bW0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:33:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:33:50 INFO - Running setup.py (path:/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/pip-Fj5YBa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:33:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:33:50 INFO - Running setup.py (path:/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/pip-5SaCwo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:33:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:33:50 INFO - Running setup.py (path:/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/pip-NDJc3Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:33:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:33:50 INFO - Running setup.py (path:/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/pip-G0IGfR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:33:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:33:50 INFO - Running setup.py (path:/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/pip-GKw9VC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:33:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:33:50 INFO - Running setup.py (path:/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/pip-ll66p1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:33:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:33:50 INFO - Running setup.py (path:/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/pip-ncpvlp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:33:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:33:50 INFO - Running setup.py (path:/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/pip-c_Ekmi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:33:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:33:50 INFO - Running setup.py (path:/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/pip-APz7Lt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:33:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:33:50 INFO - Running setup.py (path:/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/pip-AvnBRa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:33:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:33:51 INFO - Running setup.py (path:/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/pip-3FnAfq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:33:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:33:51 INFO - Running setup.py (path:/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/pip-MKvyB7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:33:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:33:51 INFO - Running setup.py (path:/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/pip-wglxbF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:33:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:33:51 INFO - Running setup.py (path:/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/pip-o3dlAS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:33:51 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:33:51 INFO - Running setup.py install for manifestparser 06:33:51 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:33:51 INFO - Running setup.py install for mozcrash 06:33:51 INFO - Running setup.py install for mozdebug 06:33:51 INFO - Running setup.py install for mozdevice 06:33:52 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:33:52 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:33:52 INFO - Running setup.py install for mozfile 06:33:52 INFO - Running setup.py install for mozhttpd 06:33:52 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:33:52 INFO - Running setup.py install for mozinfo 06:33:52 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:33:52 INFO - Running setup.py install for mozInstall 06:33:52 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:33:52 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:33:52 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:33:52 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:33:52 INFO - Running setup.py install for mozleak 06:33:52 INFO - Running setup.py install for mozlog 06:33:52 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:33:52 INFO - Running setup.py install for moznetwork 06:33:53 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:33:53 INFO - Running setup.py install for mozprocess 06:33:53 INFO - Running setup.py install for mozprofile 06:33:53 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:33:53 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:33:53 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:33:53 INFO - Running setup.py install for mozrunner 06:33:53 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:33:53 INFO - Running setup.py install for mozscreenshot 06:33:53 INFO - Running setup.py install for moztest 06:33:53 INFO - Running setup.py install for mozversion 06:33:54 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:33:54 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:33:54 INFO - Cleaning up... 06:33:54 INFO - Return code: 0 06:33:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:33:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:33:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:33:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:33:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:33:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:33:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:33:54 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 0x107187a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10718d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd6a9c8c870>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10702bd30>, '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 0x106e4fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107022b20>, '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.PYp9ygSX1b/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.HpJi1QcLvv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 06:33:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 06:33:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 06:33:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PYp9ygSX1b/Render', 06:33:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:33:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:33:54 INFO - 'HOME': '/Users/cltbld', 06:33:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:33:54 INFO - 'LOGNAME': 'cltbld', 06:33:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:33:54 INFO - 'MOZ_NO_REMOTE': '1', 06:33:54 INFO - 'NO_EM_RESTART': '1', 06:33:54 INFO - 'PAGER': '/bin/cat', 06:33:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:33:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:33:54 INFO - 'PWD': '/builds/slave/test', 06:33:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:33:54 INFO - 'SHELL': '/bin/bash', 06:33:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HpJi1QcLvv/Listeners', 06:33:54 INFO - 'TMPDIR': '/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/', 06:33:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:33:54 INFO - 'USER': 'cltbld', 06:33:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:33:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:33:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:33:54 INFO - 'XPC_FLAGS': '0x0', 06:33:54 INFO - 'XPC_SERVICE_NAME': '0', 06:33:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:33:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:33:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:33:54 INFO - Running setup.py (path:/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/pip-8QfeGy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:33:54 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 06:33:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:33:54 INFO - Running setup.py (path:/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/pip-2Innl_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:33:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:33:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:33:54 INFO - Running setup.py (path:/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/pip-7NwCws-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:33:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 06:33:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:33:54 INFO - Running setup.py (path:/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/pip-D3DUrT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:33:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:33:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:33:54 INFO - Running setup.py (path:/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/pip-aQ5jwe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:33:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 06:33:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:33:54 INFO - Running setup.py (path:/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/pip-lfQLHQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:33:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 06:33:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:33:54 INFO - Running setup.py (path:/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/pip-WwQAaA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:33:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 06:33:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:33:55 INFO - Running setup.py (path:/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/pip-KIDtiL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:33:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 06:33:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:33:55 INFO - Running setup.py (path:/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/pip-VDcBcx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:33:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 06:33:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:33:55 INFO - Running setup.py (path:/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/pip-dWRsyA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:33:55 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)) 06:33:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:33:55 INFO - Running setup.py (path:/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/pip-twQtx5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:33:55 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 06:33:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:33:55 INFO - Running setup.py (path:/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/pip-qGdX1D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:33:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 06:33:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:33:55 INFO - Running setup.py (path:/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/pip-aUquKM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:33:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 06:33:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:33:55 INFO - Running setup.py (path:/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/pip-dDJ2Xk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:33:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 06:33:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:33:55 INFO - Running setup.py (path:/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/pip-m_6Dd9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:33:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 06:33:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:33:55 INFO - Running setup.py (path:/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/pip-bzQ9tv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:33:56 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 06:33:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:33:56 INFO - Running setup.py (path:/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/pip-I97Zql-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:33:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 06:33:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:33:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:33:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 06:33:56 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:33:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:33:56 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:33:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:33:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:33:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:33:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:33:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:33:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:33:58 INFO - Downloading blessings-1.6.tar.gz 06:33:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:33:58 INFO - Installing collected packages: blessings 06:33:58 INFO - Running setup.py install for blessings 06:33:58 INFO - Successfully installed blessings 06:33:58 INFO - Cleaning up... 06:33:58 INFO - Return code: 0 06:33:58 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:33:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:33:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:33:59 INFO - Reading from file tmpfile_stdout 06:33:59 INFO - Current package versions: 06:33:59 INFO - blessings == 1.6 06:33:59 INFO - blobuploader == 1.2.4 06:33:59 INFO - docopt == 0.6.1 06:33:59 INFO - manifestparser == 1.1 06:33:59 INFO - mozInstall == 1.12 06:33:59 INFO - mozcrash == 0.17 06:33:59 INFO - mozdebug == 0.1 06:33:59 INFO - mozdevice == 0.48 06:33:59 INFO - mozfile == 1.2 06:33:59 INFO - mozhttpd == 0.7 06:33:59 INFO - mozinfo == 0.9 06:33:59 INFO - mozleak == 0.1 06:33:59 INFO - mozlog == 3.2 06:33:59 INFO - moznetwork == 0.27 06:33:59 INFO - mozprocess == 0.22 06:33:59 INFO - mozprofile == 0.28 06:33:59 INFO - mozrunner == 6.11 06:33:59 INFO - mozscreenshot == 0.1 06:33:59 INFO - mozsystemmonitor == 0.3 06:33:59 INFO - moztest == 0.7 06:33:59 INFO - mozversion == 1.4 06:33:59 INFO - psutil == 3.1.1 06:33:59 INFO - requests == 1.2.3 06:33:59 INFO - wsgiref == 0.1.2 06:33:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:33:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:33:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:33:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:33:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:33:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:33:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:33:59 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 0x107187a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10718d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd6a9c8c870>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10702bd30>, '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 0x106e4fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107022b20>, '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.PYp9ygSX1b/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.HpJi1QcLvv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 06:33:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 06:33:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 06:33:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PYp9ygSX1b/Render', 06:33:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:33:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:33:59 INFO - 'HOME': '/Users/cltbld', 06:33:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:33:59 INFO - 'LOGNAME': 'cltbld', 06:33:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:33:59 INFO - 'MOZ_NO_REMOTE': '1', 06:33:59 INFO - 'NO_EM_RESTART': '1', 06:33:59 INFO - 'PAGER': '/bin/cat', 06:33:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:33:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:33:59 INFO - 'PWD': '/builds/slave/test', 06:33:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:33:59 INFO - 'SHELL': '/bin/bash', 06:33:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HpJi1QcLvv/Listeners', 06:33:59 INFO - 'TMPDIR': '/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/', 06:33:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:33:59 INFO - 'USER': 'cltbld', 06:33:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:33:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:33:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:33:59 INFO - 'XPC_FLAGS': '0x0', 06:33:59 INFO - 'XPC_SERVICE_NAME': '0', 06:33:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:33:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:33:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 06:33:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 06:33:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 06:33:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 06:33:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 06:33:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 06:33:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 06:33:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 06:33:59 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 06:33:59 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 06:33:59 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 06:33:59 INFO - Cleaning up... 06:33:59 INFO - Return code: 0 06:33:59 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:33:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:33:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:33:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:33:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:33:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:33:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:33:59 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 0x107187a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10718d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd6a9c8c870>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10702bd30>, '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 0x106e4fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107022b20>, '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.PYp9ygSX1b/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.HpJi1QcLvv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 06:33:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 06:33:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 06:33:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PYp9ygSX1b/Render', 06:33:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:33:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:33:59 INFO - 'HOME': '/Users/cltbld', 06:33:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:33:59 INFO - 'LOGNAME': 'cltbld', 06:33:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:33:59 INFO - 'MOZ_NO_REMOTE': '1', 06:33:59 INFO - 'NO_EM_RESTART': '1', 06:33:59 INFO - 'PAGER': '/bin/cat', 06:33:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:33:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:33:59 INFO - 'PWD': '/builds/slave/test', 06:33:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:33:59 INFO - 'SHELL': '/bin/bash', 06:33:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HpJi1QcLvv/Listeners', 06:33:59 INFO - 'TMPDIR': '/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/', 06:33:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:33:59 INFO - 'USER': 'cltbld', 06:33:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:33:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:33:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:33:59 INFO - 'XPC_FLAGS': '0x0', 06:33:59 INFO - 'XPC_SERVICE_NAME': '0', 06:33:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:33:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:33:59 INFO - Downloading/unpacking jsonschema 06:33:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:33:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:33:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:33:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:33:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:33:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:34:01 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:34:02 INFO - Downloading/unpacking functools32 (from jsonschema) 06:34:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:34:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:34:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:34:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:34:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:34:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:34:02 INFO - Downloading functools32-3.2.3-2.tar.gz 06:34:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:34:02 INFO - warning: no files found matching '*.txt' 06:34:02 INFO - no previously-included directories found matching 'build' 06:34:02 INFO - no previously-included directories found matching 'dist' 06:34:02 INFO - no previously-included directories found matching '.git*' 06:34:02 INFO - Installing collected packages: jsonschema, functools32 06:34:02 INFO - Running setup.py install for functools32 06:34:02 INFO - warning: no files found matching '*.txt' 06:34:02 INFO - no previously-included directories found matching 'build' 06:34:02 INFO - no previously-included directories found matching 'dist' 06:34:02 INFO - no previously-included directories found matching '.git*' 06:34:02 INFO - Successfully installed jsonschema functools32 06:34:02 INFO - Cleaning up... 06:34:02 INFO - Return code: 0 06:34:02 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 06:34: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')]} 06:34:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:34:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:34: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')]} 06:34:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:34:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:34:02 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 0x107187a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10718d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd6a9c8c870>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10702bd30>, '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 0x106e4fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107022b20>, '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.PYp9ygSX1b/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.HpJi1QcLvv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 06:34:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 06:34:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 06:34:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PYp9ygSX1b/Render', 06:34:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:34:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:34:02 INFO - 'HOME': '/Users/cltbld', 06:34:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:34:02 INFO - 'LOGNAME': 'cltbld', 06:34:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:34:02 INFO - 'MOZ_NO_REMOTE': '1', 06:34:02 INFO - 'NO_EM_RESTART': '1', 06:34:02 INFO - 'PAGER': '/bin/cat', 06:34:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:34:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:34:02 INFO - 'PWD': '/builds/slave/test', 06:34:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:34:02 INFO - 'SHELL': '/bin/bash', 06:34:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HpJi1QcLvv/Listeners', 06:34:02 INFO - 'TMPDIR': '/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/', 06:34:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:34:02 INFO - 'USER': 'cltbld', 06:34:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:34:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:34:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:34:02 INFO - 'XPC_FLAGS': '0x0', 06:34:02 INFO - 'XPC_SERVICE_NAME': '0', 06:34:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:34:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:34:03 INFO - Downloading/unpacking flake8 06:34:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:34:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:34:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:34:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:34:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:34:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:34:05 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 06:34:05 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 06:34:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:34:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:34:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:34:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:34:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:34:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:34:05 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 06:34:05 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 06:34:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:34:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:34:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:34:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:34:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:34:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:34:06 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 06:34:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:34:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:34:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:34:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:34:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:34:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:34:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 06:34:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:34:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:34:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:34:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:34:06 INFO - no previously-included directories found matching 'docs/_build' 06:34:06 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 06:34:06 INFO - Running setup.py install for pep8 06:34:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:34:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:34:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:34:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:34:06 INFO - no previously-included directories found matching 'docs/_build' 06:34:06 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 06:34:06 INFO - Successfully installed flake8 mccabe pyflakes pep8 06:34:06 INFO - Cleaning up... 06:34:07 INFO - Return code: 0 06:34:07 INFO - Running post-action listener: _resource_record_post_action 06:34:07 INFO - Running post-action listener: _start_resource_monitoring 06:34:07 INFO - Starting resource monitoring. 06:34:07 INFO - ##### 06:34:07 INFO - ##### Finished create-virtualenv step (success) 06:34:07 INFO - ##### 06:34:07 INFO - ##### 06:34:07 INFO - ##### Running install step. 06:34:07 INFO - ##### 06:34:07 INFO - Running pre-action listener: _resource_record_pre_action 06:34:07 INFO - Running main action method: install 06:34:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:34:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:34:07 INFO - Reading from file tmpfile_stdout 06:34:07 INFO - Detecting whether we're running mozinstall >=1.0... 06:34:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:34:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:34:07 INFO - Reading from file tmpfile_stdout 06:34:07 INFO - Output received: 06:34:07 INFO - Usage: mozinstall [options] installer 06:34:07 INFO - Options: 06:34:07 INFO - -h, --help show this help message and exit 06:34:07 INFO - -d DEST, --destination=DEST 06:34:07 INFO - Directory to install application into. [default: 06:34:07 INFO - "/builds/slave/test"] 06:34:07 INFO - --app=APP Application being installed. [default: firefox] 06:34:07 INFO - mkdir: /builds/slave/test/build/application 06:34:07 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'] 06:34:07 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 06:34:41 INFO - Reading from file tmpfile_stdout 06:34:41 INFO - Output received: 06:34:41 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 06:34:41 INFO - Running post-action listener: _resource_record_post_action 06:34:41 INFO - ##### 06:34:41 INFO - ##### Finished install step (success) 06:34:41 INFO - ##### 06:34:41 INFO - ##### 06:34:41 INFO - ##### Running run-tests step. 06:34:41 INFO - ##### 06:34:41 INFO - Running pre-action listener: _resource_record_pre_action 06:34:41 INFO - Running main action method: run_tests 06:34:41 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 06:34:41 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 06:34:41 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 06:34:41 INFO - 2016-05-28 06:34:41.216 screenresolution[1644:8280] starting screenresolution argv=screenresolution get 06:34:41 INFO - 2016-05-28 06:34:41.219 screenresolution[1644:8280] Display 0: 1600x1200x32@60 06:34:41 INFO - 2016-05-28 06:34:41.224 screenresolution[1645:8282] starting screenresolution argv=screenresolution list 06:34:41 INFO - Available Modes on Display 0 06:34:41 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 06:34:41 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 06:34:41 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 06:34:41 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 06:34:41 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 06:34:41 INFO - Intel Iris: 06:34:41 INFO - Chipset Model: Intel Iris 06:34:41 INFO - Type: GPU 06:34:41 INFO - Bus: Built-In 06:34:41 INFO - VRAM (Dynamic, Max): 1536 MB 06:34:41 INFO - Vendor: Intel (0x8086) 06:34:41 INFO - Device ID: 0x0a2e 06:34:41 INFO - Revision ID: 0x0009 06:34:41 INFO - Displays: 06:34:41 INFO - Display: 06:34:41 INFO - Resolution: 1600 x 1200 @ 60 Hz 06:34:41 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 06:34:41 INFO - Display Serial Number: 1600x1200 60 06:34:41 INFO - Main Display: Yes 06:34:41 INFO - Mirror: Off 06:34:41 INFO - Online: Yes 06:34:41 INFO - Rotation: Supported 06:34:41 INFO - Return code: 0 06:34:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:34:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:34:41 INFO - Python 2.7.3 06:34:41 INFO - Return code: 0 06:34:41 INFO - grabbing minidump binary from tooltool 06:34:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:34:41 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 0x10702bd30>, '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 0x106e4fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107022b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:34:41 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 06:34:41 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 06:34:41 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 06:34:41 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:34:41 INFO - Return code: 0 06:34:41 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 06:34:41 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:34:41 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:34:41 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 06:34:41 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:34:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 06:34:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 06:34:42 INFO - Return code: 0 06:34:42 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/eYj2REvAQQeyS2Ff3U0M8A/artifacts/public/build/firefox-49.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0209', '--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 06:34:42 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/eYj2REvAQQeyS2Ff3U0M8A/artifacts/public/build/firefox-49.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0209 --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 06:34:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PYp9ygSX1b/Render', 06:34:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:34:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:34:42 INFO - 'HOME': '/Users/cltbld', 06:34:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:34:42 INFO - 'LOGNAME': 'cltbld', 06:34:42 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:34:42 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 06:34:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:34:42 INFO - 'MOZ_NO_REMOTE': '1', 06:34:42 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:34:42 INFO - 'NO_EM_RESTART': '1', 06:34:42 INFO - 'PAGER': '/bin/cat', 06:34:42 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:34:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:34:42 INFO - 'PWD': '/builds/slave/test', 06:34:42 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:34:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:34:42 INFO - 'SHELL': '/bin/bash', 06:34:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HpJi1QcLvv/Listeners', 06:34:42 INFO - 'TMPDIR': '/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/', 06:34:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:34:42 INFO - 'USER': 'cltbld', 06:34:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:34:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:34:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:34:42 INFO - 'XPC_FLAGS': '0x0', 06:34:42 INFO - 'XPC_SERVICE_NAME': '0', 06:34:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:34:42 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/eYj2REvAQQeyS2Ff3U0M8A/artifacts/public/build/firefox-49.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0209', '--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 06:34:42 INFO - mozversion application_buildid: 20160528033932 06:34:42 INFO - mozversion application_changeset: 199230f44725b8e4919a5014b9649a9951383355 06:34:42 INFO - mozversion application_display_name: Nightly 06:34:42 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:34:42 INFO - mozversion application_name: Firefox 06:34:42 INFO - mozversion application_remotingname: firefox 06:34:42 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 06:34:42 INFO - mozversion application_vendor: Mozilla 06:34:42 INFO - mozversion application_version: 49.0a1 06:34:42 INFO - mozversion platform_buildid: 20160528033932 06:34:42 INFO - mozversion platform_changeset: 199230f44725b8e4919a5014b9649a9951383355 06:34:42 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 06:34:42 INFO - mozversion platform_version: 49.0a1 06:34:42 INFO - using testdate: 1464442482 06:34:42 INFO - actual date: 1464442482 06:34:42 INFO - starting webserver on 'localhost:49278' 06:34:42 INFO - SUITE-START | Running 2 tests 06:34:42 INFO - TEST-START | dromaeo_css 06:34:42 INFO - operating with platform_type : mac_ 06:34:42 INFO - Initialising browser for dromaeo_css test... 06:34:42 INFO - TEST-INFO | started process 1663 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/tmpOoutQI/profile http://localhost:49278/getInfo.html) 06:34:45 INFO - PROCESS | 1663 | __metrics Screen width/height:1600/1200 06:34:45 INFO - PROCESS | 1663 | colorDepth:24 06:34:45 INFO - PROCESS | 1663 | Browser inner width/height: 1024/689 06:34:45 INFO - PROCESS | 1663 | __metrics 06:34:45 ERROR - PROCESS | 1663 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 06:34:46 INFO - TEST-INFO | 1663: exit 0 06:34:46 INFO - Browser initialized. 06:34:46 INFO - Running cycle 1/1 for dromaeo_css test... 06:34:46 INFO - TEST-INFO | started process 1667 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/tmpOoutQI/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:34:58 INFO - PROCESS | 1667 | RSS: Main: 252145664 06:34:58 INFO - PROCESS | 1667 | 06:35:48 INFO - PROCESS | 1667 | 1464442548166 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 06:37:59 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49278/tests/dromaeo/cssquery-ext.html) 06:38:00 INFO - PROCESS | 1667 | RSS: Main: 264335360 06:38:00 INFO - PROCESS | 1667 | 06:41:02 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-ext.html (next: http://localhost:49278/tests/dromaeo/cssquery-jquery.html) 06:41:03 INFO - PROCESS | 1667 | RSS: Main: 276054016 06:41:03 INFO - PROCESS | 1667 | 06:44:05 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49278/tests/dromaeo/cssquery-mootools.html) 06:44:05 INFO - PROCESS | 1667 | RSS: Main: 278249472 06:44:05 INFO - PROCESS | 1667 | 06:47:07 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49278/tests/dromaeo/cssquery-prototype.html) 06:47:08 INFO - PROCESS | 1667 | RSS: Main: 279654400 06:47:08 INFO - PROCESS | 1667 | 06:50:10 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49278/tests/dromaeo/cssquery-yui.html) 06:50:11 INFO - PROCESS | 1667 | RSS: Main: 283115520 06:50:11 INFO - PROCESS | 1667 | 06:53:14 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-yui.html (next: http://localhost:49278/tests/dromaeo/cssquery-dojo.html) 06:53:14 INFO - PROCESS | 1667 | RSS: Main: 283422720 06:53:14 INFO - PROCESS | 1667 | 06:53:14 INFO - PROCESS | 1667 | __start_tp_report 06:53:14 INFO - PROCESS | 1667 | _x_x_mozilla_page_load 06:53:14 INFO - PROCESS | 1667 | _x_x_mozilla_page_load_details 06:53:14 INFO - PROCESS | 1667 | |i|pagename|runs| 06:53:14 INFO - PROCESS | 1667 | |0;dojo.html;3455.913602159946;3473.808940508274;3485.8779942702004;3526.8589256429727;3528.435450327948;5682.318121825377;5704.828855134342;5721.306419681849;5790.82627521174;5821.417858214177;5641.12562552804;5712.628679135863;5731.111677689964;5738.3974682658345;5793.13103034545;5074.8731281718065;5178.378594568657;5291.153415453509;5291.841244762663;5372.597055220874;1018.2384767230488;4840.626904136406;5175.146100893348;5237.528622423981;5254.973725131369;5194.324737784102;5232.189010703328;5272.472752724735;5279.973600131974;5297.814576489843;5269.973650131725;5309.134423613866;5320.547753440962;5329.760160792774;5340.62615616907;5024.422191447994;5113.718745469035;5125.154349532323;5148.536631703128;5218.739063046833;5465.9726701366235;5591.860203494904;5627.662340259557;5647.519960803336;5660.688662123582;5548.167774833807;5927.585069045169;6104.550104788481;6249.750009999594;6256.15541901842;6159.3224745277985;6210.254769427653;6228.096925945758;6234.625922444668;6279.529035322324;4490.101979604092;4846.442659094249;5825.0679891217205;5855.443732845373;5908.970455147697;6175.2589689237575;6238.719257633417;6263.467605253513;6267.310595834455;6272.372762723782;6137.5302083125;6224.097505861625;6230.7819226326865;6234.189555357774;6236.6258024518675;4714.38712967312;5145.45972672864;6257.812265632038;6267.0286105653695;6314.652694101868;5917.733701983421;6121.178620693132;6123.540734444845;6151.538634602333;6275.152854364694;6192.628442293477;6244.438000579969;6270.561060725706;6292.276388215322;6297.4017468340435;4995.175795993693;5028.823991160292;5034.84895453137;5038.5969122470115;5039.319691841628;4382.627476664456;4426.247537918562;4432.689711720149;4460.1525710114975;4507.414036175342;5766.682832444256;5889.116632505158;5891.086881533369;5903.675297858659;5912.260967379078;6199.504039676815;6235.781747638811;6240.812775616739;6278.843028924313;6287.685615719196;5769.278840144982;5881.3530511643685;5907.556933230025;5934.6142500737315;6008.849778755566;5446.700431476228;5474.753636086306;5487.2317875497465;5487.286652735119;5510.6969116698165;6442.291347951628;6469.708863101172;6474.255460621995;6478.222613286436;6500.057491663777;6174.506039516918;6194.349593292639;6222.533310001859;6229.719662615103;6259.624422534663;5370.275012873212;6469.902951455638;6470.967645161744;6477.708503117466;6496.123023391781;6281.371862813865;6287.46556542699;6293.118963345044;6298.779542715983;6310.842228944313;6142.897836592492;6170.228721409824;6187.783427580013;6235.844103897439;6295;4757.215059515142;6080.665563394055;6108;6162.044883043135;6163.537734669828;6021.42796434338;6142.815715528542;6205.937940620536;6210.472109870711;6218.9378106218355;5073.720945348041;5781.017227071324;5945.791897283574;6063.575549711654;6071.483923866344;6175;6177.567570270217;6214.285357183981;6214.844628884133;6220.875582488416;5918.082697181943;6038.245219347582;6113.816585502442;6125.601835880653;6135.14108024868 06:53:14 INFO - PROCESS | 1667 | |1;ext.html;504.8964962182753;519.6777997641462;539.3123767196824;540.2085944091905;575.706389741232;35082.82458587707;39463.40804887929;39541.209175816504;39556.604433955654;39635.80182099089;39526.01184970377;39955.800220998855;40499.39250911239;40566.79716601413;40613.796931015306;9437.858432123507;9654.082862128087;9674.080962308604;9687.32188746788;9709.223262139012;8425.747227583182;9297.070292970717;9576.47329396883;9607.318719224142;9613.711588652352;8599.22606965373;9148.81065461489;9592.184664303542;9597.47213903235;9684.951575242114;9524.285678574135;9587.472689002103;9620.615175392975;9641.035896410373;9654.75863103421;8117;9423.010583888661;9517.428954262767;9534.332596718232;9556.331056826026;37537.43693844594;38027.23945521074;38060.80969595134;38265.234695306215;38330.616693832984;3044.725974662291;3139.4505961456653;3367.6632336766374;3467.9133021674406;3471.3577988072034;25194.11820586289;30424.54363184554;30770.38459230825;31294;31520.054398368087;3271.918202044968;3290.226796702797;3325.6840600142946;3325.817080060596;3432;448411;477098;506186;508869.4556527231;510590;57411.425885741446;58534.829303414546;58581.41418585845;58598;58785.41214587799;31295;34937.65062349344;35289;35759.64240357615;59456;16237.918810405872;16310.673786524203;16704;16888.91555542239;16936.407225747287;12916.354182291036;12994.870051299366;13002;13007.219566826021;13071.934640326737;17685.837235919473;18367;19079.141438635295;19521.53588480841;19535.316263930978;8297.128801475757;8390.279992601623;8392.412531122885;8412.747617571482;8444;962.6438217859437;1080.9513571889283;1098.1599076706325;1120.5965852293168;1123.6235362209034;29737.85131074374;30323.696763032527;30468.84765576158;30996.69003309938;31925.20186995344;1004.0762498501397;1013.6046941692746;1072.3726619927274;1129.593346395297;1150.263831148066;15583.532494025198;15780.763288550681;15807.446739364066;15886.364545418284;15969.281382337822;645407;659163;659626;660404;661129;56081.43918560844;57354.426455735746;58029.83940321254;58138.8372232553;58335.416645833;1413.9889978665303;1425.6222101143205;1454.0845604562994;1454.5854431486975;1458.5988853065492;30188;31382.84308578534;31698;32526;32600;56809.14786278292;56968;57389.713051434475;57393;57479.85040299254;601957;609390;611915;612140;615201;43583;43815.34276985784;44255;44484.33273500836;44684;48004.5199548;48422.75788621034;48561.757191213816;49433.01133977372;49642.751786240835;35061.24693765352;38944.41583376195;39812.80093599513;40287;40580.79709601433;33943.83028084844;33966;39598.2080358397;39730;40108.799456003704;32805.5554166809;37901.43147852839;38125.2374952505;38764.806175970065;38963;31581.210469738442;32629.673703263612;34222.31555368929;35027.47458788069;35168.47247291344;20008;20475.59048819045;23190.884045579664;26074;26465.33836654099 06:53:14 INFO - PROCESS | 1667 | |2;jquery.html;333.2501870790721;381.1899713109642;386.25645632158097;387.95732469428367;396.7678907838914;19357.516062098453;19934.903580303097;21018.474538136554;21019.57960840786;21106.683399749018;20393.286234981777;20842.68735968962;21023.369298921058;21215.893920530416;21545.46136346588;5413.810516631918;5643.661380317194;5975.9701201494145;5989.460948514633;6016.639001659914;5831.708414579275;5919.526437884959;5935.49548288396;5953.910691339634;5956.047032474805;5557.638753481011;5861.0915308127305;5884.323302820188;5959.910601340984;6047.606905551125;5847.239858818348;5950.7917222896995;6009.1587177795145;6117.204763380777;6127.816165515042;5813.505852002585;5832.270966129234;5848.7075646217945;5870.677112758796;5896.086106653475;12328.260304381765;13198.076134670577;13212.669683257995;13212.801807972888;13227.669308267274;2155.234891613486;2156.762756096828;2163.0482587661536;2246.9101235950543;2247.392576129796;9265.16613504781;9936.304458687895;9951.502424878727;10221.846672299922;10437.530311136017;1829.0854572713642;1843.7787465504225;1857.9721304180448;1868.0099547239984;1896.506908203877;130867;131118.3444082783;131163;131490;132573.6742632571;11500.597479088192;11684.941575292069;11721.824172637418;11813.881861181279;11900.821487677691;14417.42330306776;14437.711245775236;14469.782953255499;14488.058276212012;14498.420063197565;8631.913680863237;8710.692292781805;8713.91286087131;8804.427712198814;8919.394508988444;7162.785116446515;8836.513991730388;8842.823143537093;8874.112588741074;8974.28205743539;3807.904802379963;3897.4543563901075;3984.943989842694;4554.931676024862;4608.746518941491;1964.646363654556;1972.5660354721938;1974.6840505519049;2013.7180794688754;2021.6563184258712;917.8347897378402;959.7792507723262;987.5457289646699;1019.0268293779422;1025.415513157493;20882.164713411596;20955.58088838215;21059.894700526398;21355.25256616011;21414.25050123238;861.543382007537;939.272064150289;994.796066806303;1011.8026984738052;1048.9527971241312;10228.488575571191;11244.325340479598;11251.94374028141;11271.830922536168;11345.546178152947;512999;604019;606839;607236;615560;128795.35602322116;131132;132777;137671;141672.26543643067;993.7714325704984;1014.1379827146866;1042.2391654092555;1044.1072882685346;1044.1803184500131;17178;18310.908445457688;18679.813201867808;19058.80941190626;19380.806191938464;50602.49397505978;51559.226611600105;55665.443345566026;56315;57288;80696.59651701704;80845.19154808612;81420;82455;82829.95945344472;6782.457403407814;7766.961165194138;7842.177061107263;8343.624536895975;8354.955630546181;9665;13136;13255.66860828487;13494.52769153075;13597.932010339884;11369.431528423711;11453.083753299883;11604.535818567163;11737.765244695229;11766.117541184274;11365.147613928822;11410.714732131763;11506.482208300815;11540.538378464767;11575.363355015555;11670.88329116732;11775.116866234895;11857.644270671894;11889.881101189223;11982;8260.005254834687;8293.83412331762;8334.49993000422;8353.289970352587;8432.241098301183;8221.958890205511;9184.173424391836;10274.537645805807;11635.88364116348;11792.70518237051 06:53:14 INFO - PROCESS | 1667 | |3;mootools.html;1524.9020705092337;1559.446396529232;1599.5761123302323;1873.36305656077;1901.1444849817585;8069.03171619405;8600.35497337699;8640.35197360198;9154.725358239248;9200.585973631187;8706.25996790272;8817.603207855645;8951.194392504673;8968.282537397008;8978.685745998891;2006.3780228129326;2358.6226203807396;2397.700287464067;2405.4707964247837;2410.421498840283;2343.7773411525964;2346.765323467657;2407.6990376202975;2421.69728783902;2435.7198922124007;2409.783119519243;2414.8188885833547;2415.3237093613816;2426.793722533587;2426.817988650849;2384.1655420602824;2397.580423425902;2412.4089598048413;2414.1791790791217;2418.814780757425;2269.6028195065965;2377.583922813518;2382.309130352196;2401.5317013182434;2414.9879250603635;8891.466512009236;8972.416792908505;8978.910210897873;8996.235319997808;9203.079692030811;5269.104252277122;5418.2685337479725;5433.347998240237;5439.347278326587;5455.536279416255;3539.2744487380023;3590.8204589770407;3657.3965295726175;3659.2315613721153;3690.0774806298427;1079.438691880218;1091.165258577189;1103.3545375955075;1104.1608377632976;1111.1000089927104;11478.483468243949;11592.999999999916;11615.825762613567;11625.186236963416;11626.76746465066;4757.310190022427;4772.673408121349;4876.975615121902;4893.828715994923;4903.8966232598095;9935;9978.151857092229;9987.750306242402;9994.850077248848;10019.849702254473;5334.5732341412595;5390.568754499631;5439.401665816757;5451.809186678447;5521.309836270466;4339.869803905888;4667.953320466752;4801.591864691471;4804.95195048045;4991.850244492671;4074.490688663917;4099.692523060723;4114.115465175002;4118.248903958595;4124.876253712393;1323.7484877873173;1334.50623269389;1337.9264140472367;1343.8387393512842;1350.6150747037243;902.1880307722971;922.7923717163585;929.2658799548416;945.9952700236593;985.2609347526155;5915.822525324247;5938.198343223696;5979.5814292999075;6014.578979471395;6112.908306375408;364.3750967091451;439.0385056725824;439.5538528393683;449.2946074662748;453.26570955052364;3090.3201295714907;3964.5440774310746;3971.7418367806;4027.2348253832265;4052.5542190359038;10403.84394234087;10830.94584527088;10903.672889813319;10948.233623646427;10972.396518191417;10551.208659350426;10830.67507974762;10908.290961087503;10917.39954302521;10926.617568385069;6981.197162326296;8368.707095251637;8426.915730842613;8450.028246751579;8463.873041904377;5885.676287804212;5911.142884281841;5930.11048342752;5956.344802071682;6023.939760602338;9747.561359738687;9891.060349266809;10194.745131371776;10217.795644086927;10217.897821021992;10243;10305.896941030494;10316.226283028953;10326.01902819231;10365.274430789772;7033.648317584202;7426;7604.353629941517;7683.34691551202;7748.65131069092;8499;8505.489670619783;8543.61553730096;8585.399022068645;8599.96800383958;7522.322990930843;7676.6161691916295;7681.7695469136015;7703.499272547267;7791.92208077912;7052.294770523112;7229.313215244543;7454.217307182885;7549.698012079455;7629.427792915664;6980.406665433495;7034.050403195503;7038.788836334918;7091.43268538526;7140.6072666003865;4923.704577725348;5031.899362012666;5103.311053007945;5106.872328191825;5116.104681680766;4986.875328116681;5052.494750524918;5094.159463688598;5153.175491921274;5242.082635538842 06:53:14 INFO - PROCESS | 1667 | |4;prototype.html;311.9922001949951;313.96389415217243;315.9320746039602;318.70678975342685;321.13294105914036;5009.423916249637;5032.031101650025;5300.6289559730785;5781.537477001841;5797.217375654285;4502.716725733167;4708.599769019637;4901.877453063676;5357.919631205526;5668.943310566893;3490.354284457377;4146.523149837762;4274.187904298174;4280.850170244042;4298.914021719564;3728.459373390857;4210.957890421102;4213.588447869952;4268.359746038088;4288.914221715564;3683.576388715292;4149.493677842219;4243.469566304212;4260.914781704364;4291.485021797389;3661.212839239576;4123.721646289645;4251.319788833787;4254.978725106354;4294.1105913398005;3087.8539415106284;3643.526341575605;3651.881908493068;3656.232191239843;3693.113652723354;5172.922406163911;5408.513233808937;5414.3232095988005;5475.247920665389;5532.889342213133;4366.519682834885;4688.179568575486;4908.337374454474;4921.581665558432;4973.5772459341;5072.467390923974;5304.419516826127;5965.150803251006;5983.282006159246;6050.183225264577;4089.161721847014;4118.12625255508;4121.711480196387;4138.813753381105;4149.460570125864;5858.2677165354335;6011.549133814981;6058.545609079337;6267.490205484943;6337.524685648595;3439.9312013759586;4120.464339635888;4160.812763425653;4168.895777605584;4191;3549.4853246279145;3743.288775132716;3752.418375151856;3977.76133431995;4235.43756027605;4399.912001759947;4407.933880991788;4495.279956046138;4962.245953495844;4995.550400463976;4985.977874535712;5504.091824848935;5568.053430916754;5581.609287349846;6093.634381937098;1240.7034648792035;1248.5193200617646;1450.58658282389;1454.941802327916;1455.5997100797365;749.5540153608595;833.4332653795356;881.8456770065213;892.6652505310509;910.4446287764591;4857.247126695368;5374.059539580558;5406.54044406222;5438.91841622376;5488.643238189505;4967.2549117631925;5215.035218484592;5570.693611851387;6082.300535438481;6095.847603809941;4856.514348565115;5296.496832800878;5357.19642053695;5511.724413779295;5551.611387202857;2910.661095895912;3233.3694929488993;3270.31323422084;3276.2144631176066;3277.5903012123485;6054.606450580786;6091.604045737013;6342.207224096988;6416.903746443807;6423.839404014843;5443.755031023614;5920.171176035358;6331.810045698544;6371.904421433589;6385.329540398284;5363.570914326844;5587.972060139673;6359.682015899279;6369.840753981188;6409.967950160312;5435.586747445614;5519.448055194448;6132.6627035513475;6185.103160041679;6233.96883015582;5594.916076258941;5637.57718171147;5647.774089036392;5648.802291919763;6123.84690382744;5591.161325800999;6075.939240607538;6351.93648063532;6385.297617262005;6413.454856337077;3381.5265862779725;3395.8641654334538;3532.869481765913;3849.230153969161;4162.7502349859105;5486.835394938158;6067.696615169312;6107.786227482017;6218.393331867596;6245.781397651061;5044.621653376085;5640.364294354756;5744;5966.166071116359;5995.8008398319635;4686.437627484587;5965.313988891333;5984.431479009487;5989.3711160329285;6005.579609427298;5160.509751573594;5376.704281264411;5767.307923049261;5792.652440853562;5838.766449342149;5509.972450137884;5518.365387980433;5673.723412232214;5682.516986056232;5793.246877905845;5011.9498805012945;5040.546350828443;5867.354590994902;5907.409259074058;5935.40645935403 06:53:14 INFO - PROCESS | 1667 | |5;yui.html;725.8330583965684;735.2794261623609;750.5346685055263;776.2780614028958;854.4019186569403;14612.561623151296;14837.25813709313;15046.774298385533;15216.315265813037;15273.465428709997;13075.28085955272;14073.859261407382;14147.717045659107;14152;14179.645508862284;863.5897948474487;868.340061553221;881.7795551112222;882.496976723268;882.8631562107884;879.2702057292464;889.9332550058739;892.2861710631502;892.7678803511069;893.1648908270755;932.0539652252969;936.2697096264924;938.1509733691021;939.0984654731466;941.7080704981478;928.2202949522366;929.6420877961966;932.8460803967337;935.2891802230286;936.1434287626813;673.6429692263108;677.6069879469895;679.6669631880393;693.8820400531922;698.3400686351349;13049.282289474075;13049.478020879153;14287.428502859873;14741.926290368587;14774.556763297118;13182.934085329513;13185.274809885452;13205.301166574058;13294.601161965156;13537.984651151104;11557.88442115585;11664.475098620582;11726.648200553997;12135.393230338535;12312.507499700001;3751.4747935289083;3801.543814742221;3869.4267515923457;3877.0888841122314;3944.211157768429;78645.60677196634;80825.59587202086;81127;81424;81605.77591336134;10468.47657617116;10621.787564248672;10649;10748.623798167184;10809.67570972872;20869.791302086785;20870.58258834815;20887.373378798355;20911.268105616535;20924.58150836975;7706.229377062249;7774.611269436506;7853.293203611588;7873.724419645285;7989.241022102891;4400.405945197357;4455.086707225011;4513.50351461339;4542.68201225911;4624.884377890579;3429.53701250328;3493.283876805249;3521.506989021539;3534.1341371363665;3538.115471132217;660.7687309441657;663.4360793325635;677.2448719677524;691;691.239636399956;540.3138014721281;618.5206464989669;676.2865177238061;681.4854784637666;706.2690115730195;8567.614457349435;8718.956405217934;9187.035361287102;9197.494137822485;9260.814783704289;590.6456126324257;616.9413905678954;631.0912286307703;657.9768460044677;704.432931490145;3467.7052450541482;4331.97834010828;4402.273624851863;4416.403785488982;4491.214037543482;86696.56651716701;91098.54450727836;91637.92503652787;92149;94127;56603.71698141565;57612.135817962764;61588;80969.59515202386;81492.59253703694;54681.45318546764;71480;71587.92618110732;72078.63960680059;73378;6705.295943926013;7459.515131516434;8756.343274254328;8758.167974042455;8886;41015;45215.54784452245;45685.85785355393;45778.084438311715;45967.08065838731;59224;62077.37922620716;62132.37867621266;62399;62693.68653156705;10907.563697452013;11705;11816.40917954116;11845.170838041255;11976.76046479083;12687.936560317139;12715.427805748579;12755.744885102431;12769.297688627215;13201.867981320449;11942.104342174198;11970.820437693268;12077.39613019363;12269.141160118706;12330.568430104904;11694.649160525198;11949.342786146497;12092.911637952626;12227.69430764238;12407.751844963232;9509.286803489627;11822.377151458748;12002.519899204284;12090.758184836079;12135.211211271238;9837.360571562825;9910.950445247727;10195.439250841275;10201.234907381828;10224.926382730004;8430.241278284984;9590.616375345187;10107.7473063174;10251.333663311862;10274.897251027394 06:53:14 INFO - PROCESS | 1667 | __end_tp_report 06:53:14 INFO - PROCESS | 1667 | __start_cc_report 06:53:14 INFO - PROCESS | 1667 | _x_x_mozilla_cycle_collect,411 06:53:14 INFO - PROCESS | 1667 | __end_cc_report 06:53:14 INFO - PROCESS | 1667 | __startTimestamp1464443594418__endTimestamp 06:53:14 INFO - PROCESS | 1667 | 06:53:14 INFO - PROCESS | 1667 | ------- Summary: start ------- 06:53:14 INFO - PROCESS | 1667 | Number of tests: 6 06:53:14 INFO - PROCESS | 1667 | 06:53:14 INFO - PROCESS | 1667 | [#0] dojo.html Cycles:165 Average:5711.75 Median:5927.59 stddev:749.15 (12.6%) stddev-sans-first:730.25 06:53:14 INFO - PROCESS | 1667 | Values: 3455.9 3473.8 3485.9 3526.9 3528.4 5682.3 5704.8 5721.3 5790.8 5821.4 5641.1 5712.6 5731.1 5738.4 5793.1 5074.9 5178.4 5291.2 5291.8 5372.6 1018.2 4840.6 5175.1 5237.5 5255.0 5194.3 5232.2 5272.5 5280.0 5297.8 5270.0 5309.1 5320.5 5329.8 5340.6 5024.4 5113.7 5125.2 5148.5 5218.7 5466.0 5591.9 5627.7 5647.5 5660.7 5548.2 5927.6 6104.6 6249.8 6256.2 6159.3 6210.3 6228.1 6234.6 6279.5 4490.1 4846.4 5825.1 5855.4 5909.0 6175.3 6238.7 6263.5 6267.3 6272.4 6137.5 6224.1 6230.8 6234.2 6236.6 4714.4 5145.5 6257.8 6267.0 6314.7 5917.7 6121.2 6123.5 6151.5 6275.2 6192.6 6244.4 6270.6 6292.3 6297.4 4995.2 5028.8 5034.8 5038.6 5039.3 4382.6 4426.2 4432.7 4460.2 4507.4 5766.7 5889.1 5891.1 5903.7 5912.3 6199.5 6235.8 6240.8 6278.8 6287.7 5769.3 5881.4 5907.6 5934.6 6008.8 5446.7 5474.8 5487.2 5487.3 5510.7 6442.3 6469.7 6474.3 6478.2 6500.1 6174.5 6194.3 6222.5 6229.7 6259.6 5370.3 6469.9 6471.0 6477.7 6496.1 6281.4 6287.5 6293.1 6298.8 6310.8 6142.9 6170.2 6187.8 6235.8 6295.0 4757.2 6080.7 6108.0 6162.0 6163.5 6021.4 6142.8 6205.9 6210.5 6218.9 5073.7 5781.0 5945.8 6063.6 6071.5 6175.0 6177.6 6214.3 6214.8 6220.9 5918.1 6038.2 6113.8 6125.6 6135.1 06:53:14 INFO - PROCESS | 1667 | 06:53:14 INFO - PROCESS | 1667 | [#1] ext.html Cycles:180 Average:71481.30 Median:39548.91 stddev:157858.49 (399.1%) stddev-sans-first:158211.38 06:53:14 INFO - PROCESS | 1667 | Values: 504.9 519.7 539.3 540.2 575.7 35082.8 39463.4 39541.2 39556.6 39635.8 39526.0 39955.8 40499.4 40566.8 40613.8 9437.9 9654.1 9674.1 9687.3 9709.2 8425.7 9297.1 9576.5 9607.3 9613.7 8599.2 9148.8 9592.2 9597.5 9685.0 9524.3 9587.5 9620.6 9641.0 9654.8 8117.0 9423.0 9517.4 9534.3 9556.3 37537.4 38027.2 38060.8 38265.2 38330.6 3044.7 3139.5 3367.7 3467.9 3471.4 25194.1 30424.5 30770.4 31294.0 31520.1 3271.9 3290.2 3325.7 3325.8 3432.0 448411.0 477098.0 506186.0 508869.5 510590.0 57411.4 58534.8 58581.4 58598.0 58785.4 31295.0 34937.7 35289.0 35759.6 59456.0 16237.9 16310.7 16704.0 16888.9 16936.4 12916.4 12994.9 13002.0 13007.2 13071.9 17685.8 18367.0 19079.1 19521.5 19535.3 8297.1 8390.3 8392.4 8412.7 8444.0 962.6 1081.0 1098.2 1120.6 1123.6 29737.9 30323.7 30468.8 30996.7 31925.2 1004.1 1013.6 1072.4 1129.6 1150.3 15583.5 15780.8 15807.4 15886.4 15969.3 645407.0 659163.0 659626.0 660404.0 661129.0 56081.4 57354.4 58029.8 58138.8 58335.4 1414.0 1425.6 1454.1 1454.6 1458.6 30188.0 31382.8 31698.0 32526.0 32600.0 56809.1 56968.0 57389.7 57393.0 57479.9 601957.0 609390.0 611915.0 612140.0 615201.0 43583.0 43815.3 44255.0 44484.3 44684.0 48004.5 48422.8 48561.8 49433.0 49642.8 35061.2 38944.4 39812.8 40287.0 40580.8 33943.8 33966.0 39598.2 39730.0 40108.8 32805.6 37901.4 38125.2 38764.8 38963.0 31581.2 32629.7 34222.3 35027.5 35168.5 20008.0 20475.6 23190.9 26074.0 26465.3 06:53:14 INFO - PROCESS | 1667 | 06:53:14 INFO - PROCESS | 1667 | [#2] jquery.html Cycles:180 Average:35187.25 Median:21479.86 stddev:99263.75 (462.1%) stddev-sans-first:99507.71 06:53:14 INFO - PROCESS | 1667 | Values: 333.3 381.2 386.3 388.0 396.8 19357.5 19934.9 21018.5 21019.6 21106.7 20393.3 20842.7 21023.4 21215.9 21545.5 5413.8 5643.7 5976.0 5989.5 6016.6 5831.7 5919.5 5935.5 5953.9 5956.0 5557.6 5861.1 5884.3 5959.9 6047.6 5847.2 5950.8 6009.2 6117.2 6127.8 5813.5 5832.3 5848.7 5870.7 5896.1 12328.3 13198.1 13212.7 13212.8 13227.7 2155.2 2156.8 2163.0 2246.9 2247.4 9265.2 9936.3 9951.5 10221.8 10437.5 1829.1 1843.8 1858.0 1868.0 1896.5 130867.0 131118.3 131163.0 131490.0 132573.7 11500.6 11684.9 11721.8 11813.9 11900.8 14417.4 14437.7 14469.8 14488.1 14498.4 8631.9 8710.7 8713.9 8804.4 8919.4 7162.8 8836.5 8842.8 8874.1 8974.3 3807.9 3897.5 3984.9 4554.9 4608.7 1964.6 1972.6 1974.7 2013.7 2021.7 917.8 959.8 987.5 1019.0 1025.4 20882.2 20955.6 21059.9 21355.3 21414.3 861.5 939.3 994.8 1011.8 1049.0 10228.5 11244.3 11251.9 11271.8 11345.5 512999.0 604019.0 606839.0 607236.0 615560.0 128795.4 131132.0 132777.0 137671.0 141672.3 993.8 1014.1 1042.2 1044.1 1044.2 17178.0 18310.9 18679.8 19058.8 19380.8 50602.5 51559.2 55665.4 56315.0 57288.0 80696.6 80845.2 81420.0 82455.0 82830.0 6782.5 7767.0 7842.2 8343.6 8355.0 9665.0 13136.0 13255.7 13494.5 13597.9 11369.4 11453.1 11604.5 11737.8 11766.1 11365.1 11410.7 11506.5 11540.5 11575.4 11670.9 11775.1 11857.6 11889.9 11982.0 8260.0 8293.8 8334.5 8353.3 8432.2 8222.0 9184.2 10274.5 11635.9 11792.7 06:53:14 INFO - PROCESS | 1667 | 06:53:14 INFO - PROCESS | 1667 | [#3] mootools.html Cycles:180 Average:5776.04 Median:4885.40 stddev:3247.75 (66.5%) stddev-sans-first:3241.14 06:53:14 INFO - PROCESS | 1667 | Values: 1524.9 1559.4 1599.6 1873.4 1901.1 8069.0 8600.4 8640.4 9154.7 9200.6 8706.3 8817.6 8951.2 8968.3 8978.7 2006.4 2358.6 2397.7 2405.5 2410.4 2343.8 2346.8 2407.7 2421.7 2435.7 2409.8 2414.8 2415.3 2426.8 2426.8 2384.2 2397.6 2412.4 2414.2 2418.8 2269.6 2377.6 2382.3 2401.5 2415.0 8891.5 8972.4 8978.9 8996.2 9203.1 5269.1 5418.3 5433.3 5439.3 5455.5 3539.3 3590.8 3657.4 3659.2 3690.1 1079.4 1091.2 1103.4 1104.2 1111.1 11478.5 11593.0 11615.8 11625.2 11626.8 4757.3 4772.7 4877.0 4893.8 4903.9 9935.0 9978.2 9987.8 9994.9 10019.8 5334.6 5390.6 5439.4 5451.8 5521.3 4339.9 4668.0 4801.6 4805.0 4991.9 4074.5 4099.7 4114.1 4118.2 4124.9 1323.7 1334.5 1337.9 1343.8 1350.6 902.2 922.8 929.3 946.0 985.3 5915.8 5938.2 5979.6 6014.6 6112.9 364.4 439.0 439.6 449.3 453.3 3090.3 3964.5 3971.7 4027.2 4052.6 10403.8 10830.9 10903.7 10948.2 10972.4 10551.2 10830.7 10908.3 10917.4 10926.6 6981.2 8368.7 8426.9 8450.0 8463.9 5885.7 5911.1 5930.1 5956.3 6023.9 9747.6 9891.1 10194.7 10217.8 10217.9 10243.0 10305.9 10316.2 10326.0 10365.3 7033.6 7426.0 7604.4 7683.3 7748.7 8499.0 8505.5 8543.6 8585.4 8600.0 7522.3 7676.6 7681.8 7703.5 7791.9 7052.3 7229.3 7454.2 7549.7 7629.4 6980.4 7034.1 7038.8 7091.4 7140.6 4923.7 5031.9 5103.3 5106.9 5116.1 4986.9 5052.5 5094.2 5153.2 5242.1 06:53:14 INFO - PROCESS | 1667 | 06:53:14 INFO - PROCESS | 1667 | [#4] prototype.html Cycles:180 Average:4738.15 Median:5357.56 stddev:1483.26 (27.7%) stddev-sans-first:1449.74 06:53:14 INFO - PROCESS | 1667 | Values: 312.0 314.0 315.9 318.7 321.1 5009.4 5032.0 5300.6 5781.5 5797.2 4502.7 4708.6 4901.9 5357.9 5668.9 3490.4 4146.5 4274.2 4280.9 4298.9 3728.5 4211.0 4213.6 4268.4 4288.9 3683.6 4149.5 4243.5 4260.9 4291.5 3661.2 4123.7 4251.3 4255.0 4294.1 3087.9 3643.5 3651.9 3656.2 3693.1 5172.9 5408.5 5414.3 5475.2 5532.9 4366.5 4688.2 4908.3 4921.6 4973.6 5072.5 5304.4 5965.2 5983.3 6050.2 4089.2 4118.1 4121.7 4138.8 4149.5 5858.3 6011.5 6058.5 6267.5 6337.5 3439.9 4120.5 4160.8 4168.9 4191.0 3549.5 3743.3 3752.4 3977.8 4235.4 4399.9 4407.9 4495.3 4962.2 4995.6 4986.0 5504.1 5568.1 5581.6 6093.6 1240.7 1248.5 1450.6 1454.9 1455.6 749.6 833.4 881.8 892.7 910.4 4857.2 5374.1 5406.5 5438.9 5488.6 4967.3 5215.0 5570.7 6082.3 6095.8 4856.5 5296.5 5357.2 5511.7 5551.6 2910.7 3233.4 3270.3 3276.2 3277.6 6054.6 6091.6 6342.2 6416.9 6423.8 5443.8 5920.2 6331.8 6371.9 6385.3 5363.6 5588.0 6359.7 6369.8 6410.0 5435.6 5519.4 6132.7 6185.1 6234.0 5594.9 5637.6 5647.8 5648.8 6123.8 5591.2 6075.9 6351.9 6385.3 6413.5 3381.5 3395.9 3532.9 3849.2 4162.8 5486.8 6067.7 6107.8 6218.4 6245.8 5044.6 5640.4 5744.0 5966.2 5995.8 4686.4 5965.3 5984.4 5989.4 6005.6 5160.5 5376.7 5767.3 5792.7 5838.8 5510.0 5518.4 5673.7 5682.5 5793.2 5011.9 5040.5 5867.4 5907.4 5935.4 06:53:14 INFO - PROCESS | 1667 | 06:53:14 INFO - PROCESS | 1667 | [#5] yui.html Cycles:180 Average:17840.87 Median:27610.88 stddev:24412.19 (88.4%) stddev-sans-first:24446.85 06:53:14 INFO - PROCESS | 1667 | Values: 725.8 735.3 750.5 776.3 854.4 14612.6 14837.3 15046.8 15216.3 15273.5 13075.3 14073.9 14147.7 14152.0 14179.6 863.6 868.3 881.8 882.5 882.9 879.3 889.9 892.3 892.8 893.2 932.1 936.3 938.2 939.1 941.7 928.2 929.6 932.8 935.3 936.1 673.6 677.6 679.7 693.9 698.3 13049.3 13049.5 14287.4 14741.9 14774.6 13182.9 13185.3 13205.3 13294.6 13538.0 11557.9 11664.5 11726.6 12135.4 12312.5 3751.5 3801.5 3869.4 3877.1 3944.2 78645.6 80825.6 81127.0 81424.0 81605.8 10468.5 10621.8 10649.0 10748.6 10809.7 20869.8 20870.6 20887.4 20911.3 20924.6 7706.2 7774.6 7853.3 7873.7 7989.2 4400.4 4455.1 4513.5 4542.7 4624.9 3429.5 3493.3 3521.5 3534.1 3538.1 660.8 663.4 677.2 691.0 691.2 540.3 618.5 676.3 681.5 706.3 8567.6 8719.0 9187.0 9197.5 9260.8 590.6 616.9 631.1 658.0 704.4 3467.7 4332.0 4402.3 4416.4 4491.2 86696.6 91098.5 91637.9 92149.0 94127.0 56603.7 57612.1 61588.0 80969.6 81492.6 54681.5 71480.0 71587.9 72078.6 73378.0 6705.3 7459.5 8756.3 8758.2 8886.0 41015.0 45215.5 45685.9 45778.1 45967.1 59224.0 62077.4 62132.4 62399.0 62693.7 10907.6 11705.0 11816.4 11845.2 11976.8 12687.9 12715.4 12755.7 12769.3 13201.9 11942.1 11970.8 12077.4 12269.1 12330.6 11694.6 11949.3 12092.9 12227.7 12407.8 9509.3 11822.4 12002.5 12090.8 12135.2 9837.4 9911.0 10195.4 10201.2 10224.9 8430.2 9590.6 10107.7 10251.3 10274.9 06:53:14 INFO - PROCESS | 1667 | -------- Summary: end -------- 06:53:14 INFO - PROCESS | 1667 | 06:53:14 INFO - TEST-INFO | 1667: exit 0 06:53:14 INFO - TEST-OK | dromaeo_css | took 1112061ms 06:53:14 INFO - TEST-START | kraken 06:53:14 INFO - operating with platform_type : mac_ 06:53:14 INFO - Initialising browser for kraken test... 06:53:14 INFO - TEST-INFO | started process 1674 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/tmpm2vQ1f/profile http://localhost:49278/getInfo.html) 06:53:17 INFO - PROCESS | 1674 | __metrics Screen width/height:1600/1200 06:53:17 INFO - PROCESS | 1674 | colorDepth:24 06:53:17 INFO - PROCESS | 1674 | Browser inner width/height: 1024/689 06:53:17 INFO - PROCESS | 1674 | __metrics 06:53:17 ERROR - PROCESS | 1674 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 06:53:18 INFO - TEST-INFO | 1674: exit 0 06:53:18 INFO - Browser initialized. 06:53:18 INFO - Running cycle 1/1 for kraken test... 06:53:18 INFO - TEST-INFO | started process 1676 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/tmpm2vQ1f/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:53:30 INFO - PROCESS | 1676 | RSS: Main: 252682240 06:53:30 INFO - PROCESS | 1676 | 06:53:33 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49278/tests/kraken/driver.html?testName=audio-beat-detection) 06:53:34 INFO - PROCESS | 1676 | RSS: Main: 265633792 06:53:34 INFO - PROCESS | 1676 | 06:53:37 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49278/tests/kraken/driver.html?testName=audio-dft) 06:53:37 INFO - PROCESS | 1676 | RSS: Main: 270364672 06:53:37 INFO - PROCESS | 1676 | 06:53:41 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49278/tests/kraken/driver.html?testName=audio-fft) 06:53:41 INFO - PROCESS | 1676 | RSS: Main: 270532608 06:53:41 INFO - PROCESS | 1676 | 06:53:43 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49278/tests/kraken/driver.html?testName=audio-oscillator) 06:53:44 INFO - PROCESS | 1676 | RSS: Main: 271343616 06:53:44 INFO - PROCESS | 1676 | 06:53:46 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49278/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:53:47 INFO - PROCESS | 1676 | RSS: Main: 271794176 06:53:47 INFO - PROCESS | 1676 | 06:53:49 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49278/tests/kraken/driver.html?testName=imaging-darkroom) 06:53:50 INFO - PROCESS | 1676 | RSS: Main: 271790080 06:53:50 INFO - PROCESS | 1676 | 06:53:53 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49278/tests/kraken/driver.html?testName=imaging-desaturate) 06:53:54 INFO - PROCESS | 1676 | RSS: Main: 272035840 06:53:54 INFO - PROCESS | 1676 | 06:53:57 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49278/tests/kraken/driver.html?testName=json-parse-financial) 06:53:57 INFO - PROCESS | 1676 | RSS: Main: 272326656 06:53:57 INFO - PROCESS | 1676 | 06:53:59 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49278/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:53:59 INFO - PROCESS | 1676 | RSS: Main: 271749120 06:53:59 INFO - PROCESS | 1676 | 06:54:01 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:54:02 INFO - PROCESS | 1676 | RSS: Main: 271732736 06:54:02 INFO - PROCESS | 1676 | 06:54:04 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:54:05 INFO - PROCESS | 1676 | RSS: Main: 272158720 06:54:05 INFO - PROCESS | 1676 | 06:54:08 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:54:08 INFO - PROCESS | 1676 | RSS: Main: 272035840 06:54:08 INFO - PROCESS | 1676 | 06:54:11 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:54:12 INFO - PROCESS | 1676 | RSS: Main: 272363520 06:54:12 INFO - PROCESS | 1676 | 06:54:14 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49278/tests/kraken/driver.html?testName=ai-astar) 06:54:14 INFO - PROCESS | 1676 | RSS: Main: 272846848 06:54:14 INFO - PROCESS | 1676 | 06:54:14 INFO - PROCESS | 1676 | __start_tp_report 06:54:14 INFO - PROCESS | 1676 | _x_x_mozilla_page_load 06:54:14 INFO - PROCESS | 1676 | _x_x_mozilla_page_load_details 06:54:14 INFO - PROCESS | 1676 | |i|pagename|runs| 06:54:14 INFO - PROCESS | 1676 | |0;ai-astar;141;158;98;162;156;166;170;160;113;124 06:54:14 INFO - PROCESS | 1676 | |1;audio-beat-detection;154;120;141;181;113;160;164;145;183;123 06:54:14 INFO - PROCESS | 1676 | |2;audio-dft;200;207;229;200;198;198;233;280;194;190 06:54:14 INFO - PROCESS | 1676 | |3;audio-fft;64;81;74;141;65;81;50;67;160;82 06:54:14 INFO - PROCESS | 1676 | |4;audio-oscillator;69;72;115;83;98;92;115;69;72;117 06:54:14 INFO - PROCESS | 1676 | |5;imaging-gaussian-blur;88;86;88;88;91;85;88;86;89;85 06:54:14 INFO - PROCESS | 1676 | |6;imaging-darkroom;123;113;151;151;118;95;94;94;94;95 06:54:14 INFO - PROCESS | 1676 | |7;imaging-desaturate;88;100;90;128;147;102;92;90;91;90 06:54:14 INFO - PROCESS | 1676 | |8;json-parse-financial;58;56;58;57;58;55;57;57;58;57 06:54:14 INFO - PROCESS | 1676 | |9;json-stringify-tinderbox;65;70;72;74;72;82;76;70;70;69 06:54:14 INFO - PROCESS | 1676 | |10;stanford-crypto-aes;86;87;85;88;89;86;86;90;122;93 06:54:14 INFO - PROCESS | 1676 | |11;stanford-crypto-ccm;142;158;151;154;174;155;147;140;140;136 06:54:14 INFO - PROCESS | 1676 | |12;stanford-crypto-pbkdf2;165;167;184;202;152;192;226;178;168;168 06:54:14 INFO - PROCESS | 1676 | |13;stanford-crypto-sha256-iterative;67;68;66;66;64;63;66;66;66;62 06:54:14 INFO - PROCESS | 1676 | __end_tp_report 06:54:14 INFO - PROCESS | 1676 | __start_cc_report 06:54:14 INFO - PROCESS | 1676 | _x_x_mozilla_cycle_collect,1086 06:54:14 INFO - PROCESS | 1676 | __end_cc_report 06:54:14 INFO - PROCESS | 1676 | __startTimestamp1464443654402__endTimestamp 06:54:14 INFO - PROCESS | 1676 | 06:54:14 INFO - PROCESS | 1676 | ------- Summary: start ------- 06:54:14 INFO - PROCESS | 1676 | Number of tests: 14 06:54:14 INFO - PROCESS | 1676 | 06:54:14 INFO - PROCESS | 1676 | [#0] ai-astar Cycles:10 Average:144.80 Median:161.00 stddev:24.85 (15.4%) stddev-sans-first:26.32 06:54:14 INFO - PROCESS | 1676 | Values: 141.0 158.0 98.0 162.0 156.0 166.0 170.0 160.0 113.0 124.0 06:54:14 INFO - PROCESS | 1676 | 06:54:14 INFO - PROCESS | 1676 | [#1] audio-beat-detection Cycles:10 Average:148.40 Median:157.00 stddev:24.59 (15.7%) stddev-sans-first:25.99 06:54:14 INFO - PROCESS | 1676 | Values: 154.0 120.0 141.0 181.0 113.0 160.0 164.0 145.0 183.0 123.0 06:54:14 INFO - PROCESS | 1676 | 06:54:14 INFO - PROCESS | 1676 | [#2] audio-dft Cycles:10 Average:212.90 Median:203.50 stddev:27.61 (13.6%) stddev-sans-first:28.88 06:54:14 INFO - PROCESS | 1676 | Values: 200.0 207.0 229.0 200.0 198.0 198.0 233.0 280.0 194.0 190.0 06:54:14 INFO - PROCESS | 1676 | 06:54:14 INFO - PROCESS | 1676 | [#3] audio-fft Cycles:10 Average:86.50 Median:70.50 stddev:35.42 (50.2%) stddev-sans-first:36.62 06:54:14 INFO - PROCESS | 1676 | Values: 64.0 81.0 74.0 141.0 65.0 81.0 50.0 67.0 160.0 82.0 06:54:14 INFO - PROCESS | 1676 | 06:54:14 INFO - PROCESS | 1676 | [#4] audio-oscillator Cycles:10 Average:90.20 Median:72.00 stddev:20.07 (27.9%) stddev-sans-first:19.77 06:54:14 INFO - PROCESS | 1676 | Values: 69.0 72.0 115.0 83.0 98.0 92.0 115.0 69.0 72.0 117.0 06:54:14 INFO - PROCESS | 1676 | 06:54:14 INFO - PROCESS | 1676 | [#5] imaging-gaussian-blur Cycles:10 Average:87.40 Median:88.00 stddev:1.90 (2.2%) stddev-sans-first:2.00 06:54:14 INFO - PROCESS | 1676 | Values: 88.0 86.0 88.0 88.0 91.0 85.0 88.0 86.0 89.0 85.0 06:54:14 INFO - PROCESS | 1676 | 06:54:14 INFO - PROCESS | 1676 | [#6] imaging-darkroom Cycles:10 Average:112.80 Median:94.00 stddev:22.96 (24.4%) stddev-sans-first:24.05 06:54:14 INFO - PROCESS | 1676 | Values: 123.0 113.0 151.0 151.0 118.0 95.0 94.0 94.0 94.0 95.0 06:54:14 INFO - PROCESS | 1676 | 06:54:14 INFO - PROCESS | 1676 | [#7] imaging-desaturate Cycles:10 Average:101.80 Median:90.00 stddev:19.87 (22.1%) stddev-sans-first:20.44 06:54:14 INFO - PROCESS | 1676 | Values: 88.0 100.0 90.0 128.0 147.0 102.0 92.0 90.0 91.0 90.0 06:54:14 INFO - PROCESS | 1676 | 06:54:14 INFO - PROCESS | 1676 | [#8] json-parse-financial Cycles:10 Average:57.10 Median:57.50 stddev:0.99 (1.7%) stddev-sans-first:1.00 06:54:14 INFO - PROCESS | 1676 | Values: 58.0 56.0 58.0 57.0 58.0 55.0 57.0 57.0 58.0 57.0 06:54:14 INFO - PROCESS | 1676 | 06:54:14 INFO - PROCESS | 1676 | [#9] json-stringify-tinderbox Cycles:10 Average:72.00 Median:72.00 stddev:4.59 (6.4%) stddev-sans-first:4.12 06:54:14 INFO - PROCESS | 1676 | Values: 65.0 70.0 72.0 74.0 72.0 82.0 76.0 70.0 70.0 69.0 06:54:14 INFO - PROCESS | 1676 | 06:54:14 INFO - PROCESS | 1676 | [#10] stanford-crypto-aes Cycles:10 Average:91.20 Median:87.50 stddev:11.08 (12.7%) stddev-sans-first:11.60 06:54:14 INFO - PROCESS | 1676 | Values: 86.0 87.0 85.0 88.0 89.0 86.0 86.0 90.0 122.0 93.0 06:54:14 INFO - PROCESS | 1676 | 06:54:14 INFO - PROCESS | 1676 | [#11] stanford-crypto-ccm Cycles:10 Average:149.70 Median:152.50 stddev:11.30 (7.4%) stddev-sans-first:11.64 06:54:14 INFO - PROCESS | 1676 | Values: 142.0 158.0 151.0 154.0 174.0 155.0 147.0 140.0 140.0 136.0 06:54:14 INFO - PROCESS | 1676 | 06:54:14 INFO - PROCESS | 1676 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:180.20 Median:181.00 stddev:21.68 (12.0%) stddev-sans-first:22.28 06:54:14 INFO - PROCESS | 1676 | Values: 165.0 167.0 184.0 202.0 152.0 192.0 226.0 178.0 168.0 168.0 06:54:14 INFO - PROCESS | 1676 | 06:54:14 INFO - PROCESS | 1676 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.40 Median:66.00 stddev:1.84 (2.8%) stddev-sans-first:1.86 06:54:14 INFO - PROCESS | 1676 | Values: 67.0 68.0 66.0 66.0 64.0 63.0 66.0 66.0 66.0 62.0 06:54:14 INFO - PROCESS | 1676 | -------- Summary: end -------- 06:54:14 INFO - PROCESS | 1676 | 06:54:15 INFO - TEST-INFO | 1676: exit 0 06:54:15 INFO - TEST-OK | kraken | took 60211ms 06:54:15 INFO - SUITE-END | took 1172s 06:54:15 INFO - Completed test suite (00:19:32) 06:54:15 INFO - javascript benchmark 06:54:15 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7283.392718145924, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3455.913602159946, 3473.808940508274, 3485.8779942702004, 3526.8589256429727, 3528.435450327948, 5682.318121825377, 5704.828855134342, 5721.306419681849, 5790.82627521174, 5821.417858214177, 5641.12562552804, 5712.628679135863, 5731.111677689964, 5738.3974682658345, 5793.13103034545, 5074.8731281718065, 5178.378594568657, 5291.153415453509, 5291.841244762663, 5372.597055220874, 1018.2384767230488, 4840.626904136406, 5175.146100893348, 5237.528622423981, 5254.973725131369, 5194.324737784102, 5232.189010703328, 5272.472752724735, 5279.973600131974, 5297.814576489843, 5269.973650131725, 5309.134423613866, 5320.547753440962, 5329.760160792774, 5340.62615616907, 5024.422191447994, 5113.718745469035, 5125.154349532323, 5148.536631703128, 5218.739063046833, 5465.9726701366235, 5591.860203494904, 5627.662340259557, 5647.519960803336, 5660.688662123582, 5548.167774833807, 5927.585069045169, 6104.550104788481, 6249.750009999594, 6256.15541901842, 6159.3224745277985, 6210.254769427653, 6228.096925945758, 6234.625922444668, 6279.529035322324, 4490.101979604092, 4846.442659094249, 5825.0679891217205, 5855.443732845373, 5908.970455147697, 6175.2589689237575, 6238.719257633417, 6263.467605253513, 6267.310595834455, 6272.372762723782, 6137.5302083125, 6224.097505861625, 6230.7819226326865, 6234.189555357774, 6236.6258024518675, 4714.38712967312, 5145.45972672864, 6257.812265632038, 6267.0286105653695, 6314.652694101868, 5917.733701983421, 6121.178620693132, 6123.540734444845, 6151.538634602333, 6275.152854364694, 6192.628442293477, 6244.438000579969, 6270.561060725706, 6292.276388215322, 6297.4017468340435, 4995.175795993693, 5028.823991160292, 5034.84895453137, 5038.5969122470115, 5039.319691841628, 4382.627476664456, 4426.247537918562, 4432.689711720149, 4460.1525710114975, 4507.414036175342, 5766.682832444256, 5889.116632505158, 5891.086881533369, 5903.675297858659, 5912.260967379078, 6199.504039676815, 6235.781747638811, 6240.812775616739, 6278.843028924313, 6287.685615719196, 5769.278840144982, 5881.3530511643685, 5907.556933230025, 5934.6142500737315, 6008.849778755566, 5446.700431476228, 5474.753636086306, 5487.2317875497465, 5487.286652735119, 5510.6969116698165, 6442.291347951628, 6469.708863101172, 6474.255460621995, 6478.222613286436, 6500.057491663777, 6174.506039516918, 6194.349593292639, 6222.533310001859, 6229.719662615103, 6259.624422534663, 5370.275012873212, 6469.902951455638, 6470.967645161744, 6477.708503117466, 6496.123023391781, 6281.371862813865, 6287.46556542699, 6293.118963345044, 6298.779542715983, 6310.842228944313, 6142.897836592492, 6170.228721409824, 6187.783427580013, 6235.844103897439, 6295.0, 4757.215059515142, 6080.665563394055, 6108.0, 6162.044883043135, 6163.537734669828, 6021.42796434338, 6142.815715528542, 6205.937940620536, 6210.472109870711, 6218.9378106218355, 5073.720945348041, 5781.017227071324, 5945.791897283574, 6063.575549711654, 6071.483923866344, 6175.0, 6177.567570270217, 6214.285357183981, 6214.844628884133, 6220.875582488416, 5918.082697181943, 6038.245219347582, 6113.816585502442, 6125.601835880653, 6135.14108024868], "value": 5668.246573889763, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [504.8964962182753, 519.6777997641462, 539.3123767196824, 540.2085944091905, 575.706389741232, 35082.82458587707, 39463.40804887929, 39541.209175816504, 39556.604433955654, 39635.80182099089, 39526.01184970377, 39955.800220998855, 40499.39250911239, 40566.79716601413, 40613.796931015306, 9437.858432123507, 9654.082862128087, 9674.080962308604, 9687.32188746788, 9709.223262139012, 8425.747227583182, 9297.070292970717, 9576.47329396883, 9607.318719224142, 9613.711588652352, 8599.22606965373, 9148.81065461489, 9592.184664303542, 9597.47213903235, 9684.951575242114, 9524.285678574135, 9587.472689002103, 9620.615175392975, 9641.035896410373, 9654.75863103421, 8117.0, 9423.010583888661, 9517.428954262767, 9534.332596718232, 9556.331056826026, 37537.43693844594, 38027.23945521074, 38060.80969595134, 38265.234695306215, 38330.616693832984, 3044.725974662291, 3139.4505961456653, 3367.6632336766374, 3467.9133021674406, 3471.3577988072034, 25194.11820586289, 30424.54363184554, 30770.38459230825, 31294.0, 31520.054398368087, 3271.918202044968, 3290.226796702797, 3325.6840600142946, 3325.817080060596, 3432.0, 448411.0, 477098.0, 506186.0, 508869.4556527231, 510590.0, 57411.425885741446, 58534.829303414546, 58581.41418585845, 58598.0, 58785.41214587799, 31295.0, 34937.65062349344, 35289.0, 35759.64240357615, 59456.0, 16237.918810405872, 16310.673786524203, 16704.0, 16888.91555542239, 16936.407225747287, 12916.354182291036, 12994.870051299366, 13002.0, 13007.219566826021, 13071.934640326737, 17685.837235919473, 18367.0, 19079.141438635295, 19521.53588480841, 19535.316263930978, 8297.128801475757, 8390.279992601623, 8392.412531122885, 8412.747617571482, 8444.0, 962.6438217859437, 1080.9513571889283, 1098.1599076706325, 1120.5965852293168, 1123.6235362209034, 29737.85131074374, 30323.696763032527, 30468.84765576158, 30996.69003309938, 31925.20186995344, 1004.0762498501397, 1013.6046941692746, 1072.3726619927274, 1129.593346395297, 1150.263831148066, 15583.532494025198, 15780.763288550681, 15807.446739364066, 15886.364545418284, 15969.281382337822, 645407.0, 659163.0, 659626.0, 660404.0, 661129.0, 56081.43918560844, 57354.426455735746, 58029.83940321254, 58138.8372232553, 58335.416645833, 1413.9889978665303, 1425.6222101143205, 1454.0845604562994, 1454.5854431486975, 1458.5988853065492, 30188.0, 31382.84308578534, 31698.0, 32526.0, 32600.0, 56809.14786278292, 56968.0, 57389.713051434475, 57393.0, 57479.85040299254, 601957.0, 609390.0, 611915.0, 612140.0, 615201.0, 43583.0, 43815.34276985784, 44255.0, 44484.33273500836, 44684.0, 48004.5199548, 48422.75788621034, 48561.757191213816, 49433.01133977372, 49642.751786240835, 35061.24693765352, 38944.41583376195, 39812.80093599513, 40287.0, 40580.79709601433, 33943.83028084844, 33966.0, 39598.2080358397, 39730.0, 40108.799456003704, 32805.5554166809, 37901.43147852839, 38125.2374952505, 38764.806175970065, 38963.0, 31581.210469738442, 32629.673703263612, 34222.31555368929, 35027.47458788069, 35168.47247291344, 20008.0, 20475.59048819045, 23190.884045579664, 26074.0, 26465.33836654099], "value": 20165.98158829854, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [333.2501870790721, 381.1899713109642, 386.25645632158097, 387.95732469428367, 396.7678907838914, 19357.516062098453, 19934.903580303097, 21018.474538136554, 21019.57960840786, 21106.683399749018, 20393.286234981777, 20842.68735968962, 21023.369298921058, 21215.893920530416, 21545.46136346588, 5413.810516631918, 5643.661380317194, 5975.9701201494145, 5989.460948514633, 6016.639001659914, 5831.708414579275, 5919.526437884959, 5935.49548288396, 5953.910691339634, 5956.047032474805, 5557.638753481011, 5861.0915308127305, 5884.323302820188, 5959.910601340984, 6047.606905551125, 5847.239858818348, 5950.7917222896995, 6009.1587177795145, 6117.204763380777, 6127.816165515042, 5813.505852002585, 5832.270966129234, 5848.7075646217945, 5870.677112758796, 5896.086106653475, 12328.260304381765, 13198.076134670577, 13212.669683257995, 13212.801807972888, 13227.669308267274, 2155.234891613486, 2156.762756096828, 2163.0482587661536, 2246.9101235950543, 2247.392576129796, 9265.16613504781, 9936.304458687895, 9951.502424878727, 10221.846672299922, 10437.530311136017, 1829.0854572713642, 1843.7787465504225, 1857.9721304180448, 1868.0099547239984, 1896.506908203877, 130867.0, 131118.3444082783, 131163.0, 131490.0, 132573.6742632571, 11500.597479088192, 11684.941575292069, 11721.824172637418, 11813.881861181279, 11900.821487677691, 14417.42330306776, 14437.711245775236, 14469.782953255499, 14488.058276212012, 14498.420063197565, 8631.913680863237, 8710.692292781805, 8713.91286087131, 8804.427712198814, 8919.394508988444, 7162.785116446515, 8836.513991730388, 8842.823143537093, 8874.112588741074, 8974.28205743539, 3807.904802379963, 3897.4543563901075, 3984.943989842694, 4554.931676024862, 4608.746518941491, 1964.646363654556, 1972.5660354721938, 1974.6840505519049, 2013.7180794688754, 2021.6563184258712, 917.8347897378402, 959.7792507723262, 987.5457289646699, 1019.0268293779422, 1025.415513157493, 20882.164713411596, 20955.58088838215, 21059.894700526398, 21355.25256616011, 21414.25050123238, 861.543382007537, 939.272064150289, 994.796066806303, 1011.8026984738052, 1048.9527971241312, 10228.488575571191, 11244.325340479598, 11251.94374028141, 11271.830922536168, 11345.546178152947, 512999.0, 604019.0, 606839.0, 607236.0, 615560.0, 128795.35602322116, 131132.0, 132777.0, 137671.0, 141672.26543643067, 993.7714325704984, 1014.1379827146866, 1042.2391654092555, 1044.1072882685346, 1044.1803184500131, 17178.0, 18310.908445457688, 18679.813201867808, 19058.80941190626, 19380.806191938464, 50602.49397505978, 51559.226611600105, 55665.443345566026, 56315.0, 57288.0, 80696.59651701704, 80845.19154808612, 81420.0, 82455.0, 82829.95945344472, 6782.457403407814, 7766.961165194138, 7842.177061107263, 8343.624536895975, 8354.955630546181, 9665.0, 13136.0, 13255.66860828487, 13494.52769153075, 13597.932010339884, 11369.431528423711, 11453.083753299883, 11604.535818567163, 11737.765244695229, 11766.117541184274, 11365.147613928822, 11410.714732131763, 11506.482208300815, 11540.538378464767, 11575.363355015555, 11670.88329116732, 11775.116866234895, 11857.644270671894, 11889.881101189223, 11982.0, 8260.005254834687, 8293.83412331762, 8334.49993000422, 8353.289970352587, 8432.241098301183, 8221.958890205511, 9184.173424391836, 10274.537645805807, 11635.88364116348, 11792.70518237051], "value": 9515.501596220622, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1524.9020705092337, 1559.446396529232, 1599.5761123302323, 1873.36305656077, 1901.1444849817585, 8069.03171619405, 8600.35497337699, 8640.35197360198, 9154.725358239248, 9200.585973631187, 8706.25996790272, 8817.603207855645, 8951.194392504673, 8968.282537397008, 8978.685745998891, 2006.3780228129326, 2358.6226203807396, 2397.700287464067, 2405.4707964247837, 2410.421498840283, 2343.7773411525964, 2346.765323467657, 2407.6990376202975, 2421.69728783902, 2435.7198922124007, 2409.783119519243, 2414.8188885833547, 2415.3237093613816, 2426.793722533587, 2426.817988650849, 2384.1655420602824, 2397.580423425902, 2412.4089598048413, 2414.1791790791217, 2418.814780757425, 2269.6028195065965, 2377.583922813518, 2382.309130352196, 2401.5317013182434, 2414.9879250603635, 8891.466512009236, 8972.416792908505, 8978.910210897873, 8996.235319997808, 9203.079692030811, 5269.104252277122, 5418.2685337479725, 5433.347998240237, 5439.347278326587, 5455.536279416255, 3539.2744487380023, 3590.8204589770407, 3657.3965295726175, 3659.2315613721153, 3690.0774806298427, 1079.438691880218, 1091.165258577189, 1103.3545375955075, 1104.1608377632976, 1111.1000089927104, 11478.483468243949, 11592.999999999916, 11615.825762613567, 11625.186236963416, 11626.76746465066, 4757.310190022427, 4772.673408121349, 4876.975615121902, 4893.828715994923, 4903.8966232598095, 9935.0, 9978.151857092229, 9987.750306242402, 9994.850077248848, 10019.849702254473, 5334.5732341412595, 5390.568754499631, 5439.401665816757, 5451.809186678447, 5521.309836270466, 4339.869803905888, 4667.953320466752, 4801.591864691471, 4804.95195048045, 4991.850244492671, 4074.490688663917, 4099.692523060723, 4114.115465175002, 4118.248903958595, 4124.876253712393, 1323.7484877873173, 1334.50623269389, 1337.9264140472367, 1343.8387393512842, 1350.6150747037243, 902.1880307722971, 922.7923717163585, 929.2658799548416, 945.9952700236593, 985.2609347526155, 5915.822525324247, 5938.198343223696, 5979.5814292999075, 6014.578979471395, 6112.908306375408, 364.3750967091451, 439.0385056725824, 439.5538528393683, 449.2946074662748, 453.26570955052364, 3090.3201295714907, 3964.5440774310746, 3971.7418367806, 4027.2348253832265, 4052.5542190359038, 10403.84394234087, 10830.94584527088, 10903.672889813319, 10948.233623646427, 10972.396518191417, 10551.208659350426, 10830.67507974762, 10908.290961087503, 10917.39954302521, 10926.617568385069, 6981.197162326296, 8368.707095251637, 8426.915730842613, 8450.028246751579, 8463.873041904377, 5885.676287804212, 5911.142884281841, 5930.11048342752, 5956.344802071682, 6023.939760602338, 9747.561359738687, 9891.060349266809, 10194.745131371776, 10217.795644086927, 10217.897821021992, 10243.0, 10305.896941030494, 10316.226283028953, 10326.01902819231, 10365.274430789772, 7033.648317584202, 7426.0, 7604.353629941517, 7683.34691551202, 7748.65131069092, 8499.0, 8505.489670619783, 8543.61553730096, 8585.399022068645, 8599.96800383958, 7522.322990930843, 7676.6161691916295, 7681.7695469136015, 7703.499272547267, 7791.92208077912, 7052.294770523112, 7229.313215244543, 7454.217307182885, 7549.698012079455, 7629.427792915664, 6980.406665433495, 7034.050403195503, 7038.788836334918, 7091.43268538526, 7140.6072666003865, 4923.704577725348, 5031.899362012666, 5103.311053007945, 5106.872328191825, 5116.104681680766, 4986.875328116681, 5052.494750524918, 5094.159463688598, 5153.175491921274, 5242.082635538842], "value": 4565.022361021681, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [311.9922001949951, 313.96389415217243, 315.9320746039602, 318.70678975342685, 321.13294105914036, 5009.423916249637, 5032.031101650025, 5300.6289559730785, 5781.537477001841, 5797.217375654285, 4502.716725733167, 4708.599769019637, 4901.877453063676, 5357.919631205526, 5668.943310566893, 3490.354284457377, 4146.523149837762, 4274.187904298174, 4280.850170244042, 4298.914021719564, 3728.459373390857, 4210.957890421102, 4213.588447869952, 4268.359746038088, 4288.914221715564, 3683.576388715292, 4149.493677842219, 4243.469566304212, 4260.914781704364, 4291.485021797389, 3661.212839239576, 4123.721646289645, 4251.319788833787, 4254.978725106354, 4294.1105913398005, 3087.8539415106284, 3643.526341575605, 3651.881908493068, 3656.232191239843, 3693.113652723354, 5172.922406163911, 5408.513233808937, 5414.3232095988005, 5475.247920665389, 5532.889342213133, 4366.519682834885, 4688.179568575486, 4908.337374454474, 4921.581665558432, 4973.5772459341, 5072.467390923974, 5304.419516826127, 5965.150803251006, 5983.282006159246, 6050.183225264577, 4089.161721847014, 4118.12625255508, 4121.711480196387, 4138.813753381105, 4149.460570125864, 5858.2677165354335, 6011.549133814981, 6058.545609079337, 6267.490205484943, 6337.524685648595, 3439.9312013759586, 4120.464339635888, 4160.812763425653, 4168.895777605584, 4191.0, 3549.4853246279145, 3743.288775132716, 3752.418375151856, 3977.76133431995, 4235.43756027605, 4399.912001759947, 4407.933880991788, 4495.279956046138, 4962.245953495844, 4995.550400463976, 4985.977874535712, 5504.091824848935, 5568.053430916754, 5581.609287349846, 6093.634381937098, 1240.7034648792035, 1248.5193200617646, 1450.58658282389, 1454.941802327916, 1455.5997100797365, 749.5540153608595, 833.4332653795356, 881.8456770065213, 892.6652505310509, 910.4446287764591, 4857.247126695368, 5374.059539580558, 5406.54044406222, 5438.91841622376, 5488.643238189505, 4967.2549117631925, 5215.035218484592, 5570.693611851387, 6082.300535438481, 6095.847603809941, 4856.514348565115, 5296.496832800878, 5357.19642053695, 5511.724413779295, 5551.611387202857, 2910.661095895912, 3233.3694929488993, 3270.31323422084, 3276.2144631176066, 3277.5903012123485, 6054.606450580786, 6091.604045737013, 6342.207224096988, 6416.903746443807, 6423.839404014843, 5443.755031023614, 5920.171176035358, 6331.810045698544, 6371.904421433589, 6385.329540398284, 5363.570914326844, 5587.972060139673, 6359.682015899279, 6369.840753981188, 6409.967950160312, 5435.586747445614, 5519.448055194448, 6132.6627035513475, 6185.103160041679, 6233.96883015582, 5594.916076258941, 5637.57718171147, 5647.774089036392, 5648.802291919763, 6123.84690382744, 5591.161325800999, 6075.939240607538, 6351.93648063532, 6385.297617262005, 6413.454856337077, 3381.5265862779725, 3395.8641654334538, 3532.869481765913, 3849.230153969161, 4162.7502349859105, 5486.835394938158, 6067.696615169312, 6107.786227482017, 6218.393331867596, 6245.781397651061, 5044.621653376085, 5640.364294354756, 5744.0, 5966.166071116359, 5995.8008398319635, 4686.437627484587, 5965.313988891333, 5984.431479009487, 5989.3711160329285, 6005.579609427298, 5160.509751573594, 5376.704281264411, 5767.307923049261, 5792.652440853562, 5838.766449342149, 5509.972450137884, 5518.365387980433, 5673.723412232214, 5682.516986056232, 5793.246877905845, 5011.9498805012945, 5040.546350828443, 5867.354590994902, 5907.409259074058, 5935.40645935403], "value": 4260.378913358076, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [725.8330583965684, 735.2794261623609, 750.5346685055263, 776.2780614028958, 854.4019186569403, 14612.561623151296, 14837.25813709313, 15046.774298385533, 15216.315265813037, 15273.465428709997, 13075.28085955272, 14073.859261407382, 14147.717045659107, 14152.0, 14179.645508862284, 863.5897948474487, 868.340061553221, 881.7795551112222, 882.496976723268, 882.8631562107884, 879.2702057292464, 889.9332550058739, 892.2861710631502, 892.7678803511069, 893.1648908270755, 932.0539652252969, 936.2697096264924, 938.1509733691021, 939.0984654731466, 941.7080704981478, 928.2202949522366, 929.6420877961966, 932.8460803967337, 935.2891802230286, 936.1434287626813, 673.6429692263108, 677.6069879469895, 679.6669631880393, 693.8820400531922, 698.3400686351349, 13049.282289474075, 13049.478020879153, 14287.428502859873, 14741.926290368587, 14774.556763297118, 13182.934085329513, 13185.274809885452, 13205.301166574058, 13294.601161965156, 13537.984651151104, 11557.88442115585, 11664.475098620582, 11726.648200553997, 12135.393230338535, 12312.507499700001, 3751.4747935289083, 3801.543814742221, 3869.4267515923457, 3877.0888841122314, 3944.211157768429, 78645.60677196634, 80825.59587202086, 81127.0, 81424.0, 81605.77591336134, 10468.47657617116, 10621.787564248672, 10649.0, 10748.623798167184, 10809.67570972872, 20869.791302086785, 20870.58258834815, 20887.373378798355, 20911.268105616535, 20924.58150836975, 7706.229377062249, 7774.611269436506, 7853.293203611588, 7873.724419645285, 7989.241022102891, 4400.405945197357, 4455.086707225011, 4513.50351461339, 4542.68201225911, 4624.884377890579, 3429.53701250328, 3493.283876805249, 3521.506989021539, 3534.1341371363665, 3538.115471132217, 660.7687309441657, 663.4360793325635, 677.2448719677524, 691.0, 691.239636399956, 540.3138014721281, 618.5206464989669, 676.2865177238061, 681.4854784637666, 706.2690115730195, 8567.614457349435, 8718.956405217934, 9187.035361287102, 9197.494137822485, 9260.814783704289, 590.6456126324257, 616.9413905678954, 631.0912286307703, 657.9768460044677, 704.432931490145, 3467.7052450541482, 4331.97834010828, 4402.273624851863, 4416.403785488982, 4491.214037543482, 86696.56651716701, 91098.54450727836, 91637.92503652787, 92149.0, 94127.0, 56603.71698141565, 57612.135817962764, 61588.0, 80969.59515202386, 81492.59253703694, 54681.45318546764, 71480.0, 71587.92618110732, 72078.63960680059, 73378.0, 6705.295943926013, 7459.515131516434, 8756.343274254328, 8758.167974042455, 8886.0, 41015.0, 45215.54784452245, 45685.85785355393, 45778.084438311715, 45967.08065838731, 59224.0, 62077.37922620716, 62132.37867621266, 62399.0, 62693.68653156705, 10907.563697452013, 11705.0, 11816.40917954116, 11845.170838041255, 11976.76046479083, 12687.936560317139, 12715.427805748579, 12755.744885102431, 12769.297688627215, 13201.867981320449, 11942.104342174198, 11970.820437693268, 12077.39613019363, 12269.141160118706, 12330.568430104904, 11694.649160525198, 11949.342786146497, 12092.911637952626, 12227.69430764238, 12407.751844963232, 9509.286803489627, 11822.377151458748, 12002.519899204284, 12090.758184836079, 12135.211211271238, 9837.360571562825, 9910.950445247727, 10195.439250841275, 10201.234907381828, 10224.926382730004, 8430.241278284984, 9590.616375345187, 10107.7473063174, 10251.333663311862, 10274.897251027394], "value": 7056.133774054874, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1600.4, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 158.0, 98.0, 162.0, 156.0, 166.0, 170.0, 160.0, 113.0, 124.0], "value": 144.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 120.0, 141.0, 181.0, 113.0, 160.0, 164.0, 145.0, 183.0, 123.0], "value": 148.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [200.0, 207.0, 229.0, 200.0, 198.0, 198.0, 233.0, 280.0, 194.0, 190.0], "value": 212.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 81.0, 74.0, 141.0, 65.0, 81.0, 50.0, 67.0, 160.0, 82.0], "value": 86.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 72.0, 115.0, 83.0, 98.0, 92.0, 115.0, 69.0, 72.0, 117.0], "value": 90.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 86.0, 88.0, 88.0, 91.0, 85.0, 88.0, 86.0, 89.0, 85.0], "value": 87.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [123.0, 113.0, 151.0, 151.0, 118.0, 95.0, 94.0, 94.0, 94.0, 95.0], "value": 112.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 100.0, 90.0, 128.0, 147.0, 102.0, 92.0, 90.0, 91.0, 90.0], "value": 101.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 56.0, 58.0, 57.0, 58.0, 55.0, 57.0, 57.0, 58.0, 57.0], "value": 57.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 70.0, 72.0, 74.0, 72.0, 82.0, 76.0, 70.0, 70.0, 69.0], "value": 72.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 87.0, 85.0, 88.0, 89.0, 86.0, 86.0, 90.0, 122.0, 93.0], "value": 91.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 158.0, 151.0, 154.0, 174.0, 155.0, 147.0, 140.0, 140.0, 136.0], "value": 149.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 167.0, 184.0, 202.0, 152.0, 192.0, 226.0, 178.0, 168.0, 168.0], "value": 180.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 66.0, 66.0, 64.0, 63.0, 66.0, 66.0, 66.0, 62.0], "value": 65.4, "unit": "score"}]}]} 06:54:15 INFO - Return code: 0 06:54:15 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 06:54:15 ERROR - # TBPL SUCCESS # 06:54:15 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 06:54:15 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 06:54:15 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 06:54:15 INFO - 2016-05-28 06:54:15.718 screenresolution[1681:11089] starting screenresolution argv=screenresolution get 06:54:15 INFO - 2016-05-28 06:54:15.721 screenresolution[1681:11089] Display 0: 1600x1200x32@60 06:54:15 INFO - 2016-05-28 06:54:15.727 screenresolution[1682:11092] starting screenresolution argv=screenresolution list 06:54:15 INFO - Available Modes on Display 0 06:54:15 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 06:54:15 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 06:54:15 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 06:54:15 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 06:54:15 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 06:54:15 INFO - Intel Iris: 06:54:15 INFO - Chipset Model: Intel Iris 06:54:15 INFO - Type: GPU 06:54:15 INFO - Bus: Built-In 06:54:15 INFO - VRAM (Dynamic, Max): 1536 MB 06:54:15 INFO - Vendor: Intel (0x8086) 06:54:15 INFO - Device ID: 0x0a2e 06:54:15 INFO - Revision ID: 0x0009 06:54:15 INFO - Displays: 06:54:15 INFO - Display: 06:54:15 INFO - Resolution: 1600 x 1200 @ 60 Hz 06:54:15 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 06:54:15 INFO - Display Serial Number: 1600x1200 60 06:54:15 INFO - Main Display: Yes 06:54:15 INFO - Mirror: Off 06:54:15 INFO - Online: Yes 06:54:15 INFO - Rotation: Supported 06:54:15 INFO - Return code: 0 06:54:15 INFO - Running post-action listener: _resource_record_post_action 06:54:15 INFO - ##### 06:54:15 INFO - ##### Finished run-tests step (success) 06:54:15 INFO - ##### 06:54:15 INFO - Running post-run listener: _resource_record_post_run 06:54:16 INFO - Total resource usage - Wall time: 1208s; CPU: 54.0%; Read bytes: 31424000; Write bytes: 698482688; Read time: 193; Write time: 1981 06:54:16 INFO - TinderboxPrint: CPU usage
54.4% 06:54:16 INFO - TinderboxPrint: I/O read bytes / time
31,424,000 / 193 06:54:16 INFO - TinderboxPrint: I/O write bytes / time
698,482,688 / 1,981 06:54:16 INFO - TinderboxPrint: CPU idle
2,206.2 (45.6%) 06:54:16 INFO - TinderboxPrint: CPU system
969.6 (20.1%) 06:54:16 INFO - TinderboxPrint: CPU user
1,657.9 (34.3%) 06:54:16 INFO - TinderboxPrint: Swap in / out
425,123,840 / 0 06:54:16 INFO - install - Wall time: 34s; CPU: 55.0%; Read bytes: 398770688; Write bytes: 400377344; Read time: 29763; Write time: 866 06:54:16 INFO - run-tests - Wall time: 1175s; CPU: 54.0%; Read bytes: 29642240; Write bytes: 297155072; Read time: 177; Write time: 1112 06:54:16 INFO - Running post-run listener: _upload_blobber_files 06:54:16 INFO - Blob upload gear active. 06:54:16 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:54:16 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 06:54:16 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'] 06:54:16 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 06:54:16 INFO - (blobuploader) - INFO - Open directory for files ... 06:54:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 06:54:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:54:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:54:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 06:54:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:54:17 INFO - (blobuploader) - INFO - Done attempting. 06:54:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 06:54:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:54:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:54:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 06:54:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:54:18 INFO - (blobuploader) - INFO - Done attempting. 06:54:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:54:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:54:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:54:21 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:54:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:54:21 INFO - (blobuploader) - INFO - Done attempting. 06:54:21 INFO - (blobuploader) - INFO - Iteration through files over. 06:54:21 INFO - Return code: 0 06:54:21 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:54:21 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:54:21 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d1e9c746e1a1fb14dbf92eb3cac13c73860398a44e5d4cade04ad4af4b3e385d745e28f15757c4aa4d389d30dbfe80f335945da1dd20500c4873d7600a42a3f2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bd535d59fa670e2967343eff731f0fa8f605f2b0c241d1d719dd728a3afd3da5a1162f7cdc80cd403b0564a1532e865075ff0019ade44d9302961d96aca2af78", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/89de88dae9f10dca8fedaffd25497bfe8f96b28eebd316e1e13cd6e203385fda3127b4106869488acf9d8e22e150af87d3f5a51aeecdded7bec851431b3a1309"} 06:54:21 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:54:21 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:54:21 INFO - Contents: 06:54:21 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d1e9c746e1a1fb14dbf92eb3cac13c73860398a44e5d4cade04ad4af4b3e385d745e28f15757c4aa4d389d30dbfe80f335945da1dd20500c4873d7600a42a3f2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bd535d59fa670e2967343eff731f0fa8f605f2b0c241d1d719dd728a3afd3da5a1162f7cdc80cd403b0564a1532e865075ff0019ade44d9302961d96aca2af78", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/89de88dae9f10dca8fedaffd25497bfe8f96b28eebd316e1e13cd6e203385fda3127b4106869488acf9d8e22e150af87d3f5a51aeecdded7bec851431b3a1309"} 06:54:21 INFO - Running post-run listener: copy_logs_to_upload_dir 06:54:21 INFO - Copying logs to upload dir... 06:54:21 INFO - mkdir: /builds/slave/test/build/upload/logs 06:54:21 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1301.882143 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 41 secs) (at 2016-05-28 06:54:21.374435) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-28 06:54:21.377712) ========= 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.PYp9ygSX1b/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.HpJi1QcLvv/Listeners TMPDIR=/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/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/d1e9c746e1a1fb14dbf92eb3cac13c73860398a44e5d4cade04ad4af4b3e385d745e28f15757c4aa4d389d30dbfe80f335945da1dd20500c4873d7600a42a3f2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bd535d59fa670e2967343eff731f0fa8f605f2b0c241d1d719dd728a3afd3da5a1162f7cdc80cd403b0564a1532e865075ff0019ade44d9302961d96aca2af78", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/89de88dae9f10dca8fedaffd25497bfe8f96b28eebd316e1e13cd6e203385fda3127b4106869488acf9d8e22e150af87d3f5a51aeecdded7bec851431b3a1309"} build_url:https://queue.taskcluster.net/v1/task/eYj2REvAQQeyS2Ff3U0M8A/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011082 build_url: 'https://queue.taskcluster.net/v1/task/eYj2REvAQQeyS2Ff3U0M8A/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/d1e9c746e1a1fb14dbf92eb3cac13c73860398a44e5d4cade04ad4af4b3e385d745e28f15757c4aa4d389d30dbfe80f335945da1dd20500c4873d7600a42a3f2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bd535d59fa670e2967343eff731f0fa8f605f2b0c241d1d719dd728a3afd3da5a1162f7cdc80cd403b0564a1532e865075ff0019ade44d9302961d96aca2af78", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/89de88dae9f10dca8fedaffd25497bfe8f96b28eebd316e1e13cd6e203385fda3127b4106869488acf9d8e22e150af87d3f5a51aeecdded7bec851431b3a1309"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-28 06:54:21.407817) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-28 06:54:21.408107) ========= 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.PYp9ygSX1b/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.HpJi1QcLvv/Listeners TMPDIR=/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/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.004495 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-28 06:54:21.455801) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-28 06:54:21.456086) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-28 06:54:21.456407) ========= ========= Total master_lag: 0.17 =========