builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0116 starttime: 1464179852.22 results: success (0) buildid: 20160525042639 builduid: 4e1342f98acb4d50963aad46a9cf2f5b revision: 2a2ce43bcafb42f0f5fcf4dd0f135eefdfe085b7 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-25 05:37:32.216201) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-25 05:37:32.216674) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-25 05:37:32.217013) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-25 05:37:32.247787) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-25 05:37:32.248138) ========= 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.RyaXNb7EQn/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.LN64wk4KyS/Listeners TMPDIR=/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/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-25 05:37:31-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 154M=0s 2016-05-25 05:37:31 (154 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.142591 ========= master_lag: 0.10 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-25 05:37:32.491774) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-25 05:37:32.492138) ========= 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.RyaXNb7EQn/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.LN64wk4KyS/Listeners TMPDIR=/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/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.020092 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-25 05:37:32.534544) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-05-25 05:37:32.536980) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 2a2ce43bcafb42f0f5fcf4dd0f135eefdfe085b7 --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 2a2ce43bcafb42f0f5fcf4dd0f135eefdfe085b7 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.RyaXNb7EQn/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.LN64wk4KyS/Listeners TMPDIR=/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/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-25 05:37:31,987 truncating revision to first 12 chars 2016-05-25 05:37:31,987 Setting DEBUG logging. 2016-05-25 05:37:31,987 attempt 1/10 2016-05-25 05:37:31,987 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/2a2ce43bcafb?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-25 05:37:33,065 unpacking tar archive at: fx-team-2a2ce43bcafb/testing/mozharness/ program finished with exit code 0 elapsedTime=1.996499 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-05-25 05:37:34.557607) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-25 05:37:34.558389) ========= script_repo_revision: 2a2ce43bcafb42f0f5fcf4dd0f135eefdfe085b7 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-25 05:37:34.559322) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-25 05:37:34.560015) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-25 05:37:34.577696) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2016-05-25 05:37:34.578394) ========= /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.RyaXNb7EQn/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.LN64wk4KyS/Listeners TMPDIR=/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 05:37:34 INFO - MultiFileLogger online at 20160525 05:37:34 in /builds/slave/test 05:37:34 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 05:37:34 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:37:34 INFO - {'append_to_log': False, 05:37:34 INFO - 'base_work_dir': '/builds/slave/test', 05:37:34 INFO - 'blob_upload_branch': 'Fx-Team', 05:37:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:37:34 INFO - 'branch': 'Fx-Team', 05:37:34 INFO - 'buildbot_json_path': 'buildprops.json', 05:37:34 INFO - 'config_files': ('talos/mac_config.py',), 05:37:34 INFO - 'default_actions': ('clobber', 05:37:34 INFO - 'read-buildbot-config', 05:37:34 INFO - 'download-and-extract', 05:37:34 INFO - 'populate-webroot', 05:37:34 INFO - 'create-virtualenv', 05:37:34 INFO - 'install', 05:37:34 INFO - 'run-tests'), 05:37:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:37:34 INFO - 'download_minidump_stackwalk': True, 05:37:34 INFO - 'download_symbols': 'ondemand', 05:37:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:37:34 INFO - 'tooltool.py': '/tools/tooltool.py', 05:37:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:37:34 INFO - '/tools/misc-python/virtualenv.py')}, 05:37:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:37:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:37:34 INFO - 'installer_path': 'installer.exe', 05:37:34 INFO - 'log_level': 'info', 05:37:34 INFO - 'log_name': 'talos', 05:37:34 INFO - 'log_to_console': True, 05:37:34 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 05:37:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 05:37:34 INFO - 'opt_config_files': (), 05:37:34 INFO - 'pip_index': False, 05:37:34 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:37:34 INFO - 'cmd': ('bash', 05:37:34 INFO - '-c', 05:37:34 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:37:34 INFO - 'enabled': True, 05:37:34 INFO - 'halt_on_failure': False, 05:37:34 INFO - 'name': 'check_screen_resolution'},), 05:37:34 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:37:34 INFO - 'cmd': ('bash', 05:37:34 INFO - '-c', 05:37:34 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:37:34 INFO - 'enabled': True, 05:37:34 INFO - 'halt_on_failure': False, 05:37:34 INFO - 'name': 'check_screen_resolution'},), 05:37:34 INFO - 'run_cmd_checks_enabled': True, 05:37:34 INFO - 'sps_profile': False, 05:37:34 INFO - 'sps_profile_interval': 0, 05:37:34 INFO - 'suite': 'dromaeojs-e10s', 05:37:34 INFO - 'system_bits': '32', 05:37:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:37:34 INFO - 'title': 't-yosemite-r7-0116', 05:37:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:37:34 INFO - 'use_talos_json': True, 05:37:34 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:37:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:37:34 INFO - 'work_dir': 'build'} 05:37:34 INFO - ##### 05:37:34 INFO - ##### Running clobber step. 05:37:34 INFO - ##### 05:37:34 INFO - Running pre-action listener: _resource_record_pre_action 05:37:34 INFO - Running main action method: clobber 05:37:34 INFO - rmtree: /builds/slave/test/build 05:37:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:37:35 INFO - Running post-action listener: _resource_record_post_action 05:37:35 INFO - ##### 05:37:35 INFO - ##### Finished clobber step (success) 05:37:35 INFO - ##### 05:37:35 INFO - ##### 05:37:35 INFO - ##### Running read-buildbot-config step. 05:37:35 INFO - ##### 05:37:35 INFO - Running pre-action listener: _resource_record_pre_action 05:37:35 INFO - Running main action method: read_buildbot_config 05:37:35 INFO - Using buildbot properties: 05:37:35 INFO - { 05:37:35 INFO - "project": "", 05:37:35 INFO - "product": "firefox", 05:37:35 INFO - "script_repo_revision": "production", 05:37:35 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 05:37:35 INFO - "repository": "", 05:37:35 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 05:37:35 INFO - "buildid": "20160525042639", 05:37:35 INFO - "pgo_build": "False", 05:37:35 INFO - "basedir": "/builds/slave/test", 05:37:35 INFO - "buildnumber": 682, 05:37:35 INFO - "slavename": "t-yosemite-r7-0116", 05:37:35 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 05:37:35 INFO - "platform": "yosemite_r7", 05:37:35 INFO - "scheduler": "tests-fx-team-macosx64-talos-7-3600", 05:37:35 INFO - "branch": "fx-team", 05:37:35 INFO - "repo_path": "integration/fx-team", 05:37:35 INFO - "revision": "2a2ce43bcafb42f0f5fcf4dd0f135eefdfe085b7", 05:37:35 INFO - "stage_platform": "macosx64", 05:37:35 INFO - "builduid": "4e1342f98acb4d50963aad46a9cf2f5b", 05:37:35 INFO - "slavebuilddir": "test" 05:37:35 INFO - } 05:37:35 INFO - Found installer url https://queue.taskcluster.net/v1/task/E-BVgxdjTFGG_0n4iN9GSA/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg. 05:37:35 INFO - Running post-action listener: _resource_record_post_action 05:37:35 INFO - ##### 05:37:35 INFO - ##### Finished read-buildbot-config step (success) 05:37:35 INFO - ##### 05:37:35 INFO - ##### 05:37:35 INFO - ##### Running download-and-extract step. 05:37:35 INFO - ##### 05:37:35 INFO - Running pre-action listener: _resource_record_pre_action 05:37:35 INFO - Running main action method: download_and_extract 05:37:35 INFO - mkdir: /builds/slave/test/build/tests 05:37:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:37:35 INFO - https://queue.taskcluster.net/v1/task/E-BVgxdjTFGG_0n4iN9GSA/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 05:37:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E-BVgxdjTFGG_0n4iN9GSA/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json 05:37:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E-BVgxdjTFGG_0n4iN9GSA/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json 05:37:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E-BVgxdjTFGG_0n4iN9GSA/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.mac.test_packages.json 05:37:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E-BVgxdjTFGG_0n4iN9GSA/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.mac.test_packages.json'}, attempt #1 05:37:36 INFO - Downloaded 1199 bytes. 05:37:36 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.mac.test_packages.json 05:37:36 INFO - Using the following test package requirements: 05:37:36 INFO - {u'common': [u'firefox-49.0a1.en-US.mac.common.tests.zip'], 05:37:36 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 05:37:36 INFO - u'firefox-49.0a1.en-US.mac.cppunittest.tests.zip'], 05:37:36 INFO - u'gtest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 05:37:36 INFO - u'firefox-49.0a1.en-US.mac.gtest.tests.zip'], 05:37:36 INFO - u'jittest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 05:37:36 INFO - u'jsshell-mac.zip'], 05:37:36 INFO - u'mochitest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 05:37:36 INFO - u'firefox-49.0a1.en-US.mac.mochitest.tests.zip'], 05:37:36 INFO - u'mozbase': [u'firefox-49.0a1.en-US.mac.common.tests.zip'], 05:37:36 INFO - u'reftest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 05:37:36 INFO - u'firefox-49.0a1.en-US.mac.reftest.tests.zip'], 05:37:36 INFO - u'talos': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 05:37:36 INFO - u'firefox-49.0a1.en-US.mac.talos.tests.zip'], 05:37:36 INFO - u'web-platform': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 05:37:36 INFO - u'firefox-49.0a1.en-US.mac.web-platform.tests.zip'], 05:37:36 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 05:37:36 INFO - u'firefox-49.0a1.en-US.mac.xpcshell.tests.zip']} 05:37:36 INFO - Downloading packages: [u'firefox-49.0a1.en-US.mac.common.tests.zip'] for test suite category: common 05:37:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:37:36 INFO - https://queue.taskcluster.net/v1/task/E-BVgxdjTFGG_0n4iN9GSA/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 05:37:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E-BVgxdjTFGG_0n4iN9GSA/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 05:37:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E-BVgxdjTFGG_0n4iN9GSA/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 05:37:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E-BVgxdjTFGG_0n4iN9GSA/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip 05:37:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E-BVgxdjTFGG_0n4iN9GSA/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip'}, attempt #1 05:37:37 INFO - Downloaded 18632965 bytes. 05:37:37 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:37:37 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 05:37:40 INFO - Return code: 0 05:37:40 INFO - Downloading packages: [u'firefox-49.0a1.en-US.mac.common.tests.zip', u'firefox-49.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 05:37:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:37:40 INFO - https://queue.taskcluster.net/v1/task/E-BVgxdjTFGG_0n4iN9GSA/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 05:37:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E-BVgxdjTFGG_0n4iN9GSA/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 05:37:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E-BVgxdjTFGG_0n4iN9GSA/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 05:37:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E-BVgxdjTFGG_0n4iN9GSA/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip 05:37:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E-BVgxdjTFGG_0n4iN9GSA/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip'}, attempt #1 05:37:41 INFO - Downloaded 18632965 bytes. 05:37:41 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:37:41 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 05:37:45 INFO - Return code: 0 05:37:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:37:45 INFO - https://queue.taskcluster.net/v1/task/E-BVgxdjTFGG_0n4iN9GSA/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 05:37:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E-BVgxdjTFGG_0n4iN9GSA/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip 05:37:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E-BVgxdjTFGG_0n4iN9GSA/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip 05:37:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E-BVgxdjTFGG_0n4iN9GSA/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.mac.talos.tests.zip 05:37:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E-BVgxdjTFGG_0n4iN9GSA/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.talos.tests.zip'}, attempt #1 05:37:46 INFO - Downloaded 10840359 bytes. 05:37:46 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:37:46 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 05:37:47 INFO - Return code: 0 05:37:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:37:47 INFO - https://queue.taskcluster.net/v1/task/E-BVgxdjTFGG_0n4iN9GSA/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 05:37:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E-BVgxdjTFGG_0n4iN9GSA/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 05:37:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E-BVgxdjTFGG_0n4iN9GSA/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 05:37:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E-BVgxdjTFGG_0n4iN9GSA/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-49.0a1.en-US.mac.dmg 05:37:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E-BVgxdjTFGG_0n4iN9GSA/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.mac.dmg'}, attempt #1 05:37:50 INFO - Downloaded 110255734 bytes. 05:37:50 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/E-BVgxdjTFGG_0n4iN9GSA/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 05:37:50 INFO - mkdir: /builds/slave/test/properties 05:37:50 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:37:50 INFO - Writing to file /builds/slave/test/properties/build_url 05:37:50 INFO - Contents: 05:37:50 INFO - build_url:https://queue.taskcluster.net/v1/task/E-BVgxdjTFGG_0n4iN9GSA/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 05:37:51 INFO - Running post-action listener: _resource_record_post_action 05:37:51 INFO - Running post-action listener: set_extra_try_arguments 05:37:51 INFO - ##### 05:37:51 INFO - ##### Finished download-and-extract step (success) 05:37:51 INFO - ##### 05:37:51 INFO - ##### 05:37:51 INFO - ##### Running populate-webroot step. 05:37:51 INFO - ##### 05:37:51 INFO - Running pre-action listener: _resource_record_pre_action 05:37:51 INFO - Running main action method: populate_webroot 05:37:51 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:37:51 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:37:51 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:37:51 INFO - '--tppagecycles', 05:37:51 INFO - '7'], 05:37:51 INFO - 'tests': ['tsvgm']}}, 05:37:51 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:37:51 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:37:51 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:37:51 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:37:51 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:37:51 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:37:51 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:37:51 INFO - 'talos_options': ['--disable-e10s'], 05:37:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:37:51 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:37:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:37:51 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:37:51 INFO - 'talos_options': ['--disable-e10s'], 05:37:51 INFO - 'tests': ['damp', 'tps']}, 05:37:51 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:37:51 INFO - 'tests': ['damp', 'tps']}, 05:37:51 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:37:51 INFO - 'tests': ['dromaeo_dom']}, 05:37:51 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:37:51 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:37:51 INFO - 'tests': ['a11yr', 05:37:51 INFO - 'ts_paint', 05:37:51 INFO - 'tpaint', 05:37:51 INFO - 'sessionrestore', 05:37:51 INFO - 'sessionrestore_no_auto_restore', 05:37:51 INFO - 'tabpaint']}, 05:37:51 INFO - 'other-e10s': {'tests': ['a11yr', 05:37:51 INFO - 'ts_paint', 05:37:51 INFO - 'tpaint', 05:37:51 INFO - 'sessionrestore', 05:37:51 INFO - 'sessionrestore_no_auto_restore', 05:37:51 INFO - 'tabpaint']}, 05:37:51 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:37:51 INFO - 'ts_paint', 05:37:51 INFO - 'tpaint', 05:37:51 INFO - 'sessionrestore', 05:37:51 INFO - 'sessionrestore_no_auto_restore', 05:37:51 INFO - 'tabpaint']}, 05:37:51 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:37:51 INFO - 'ts_paint', 05:37:51 INFO - 'tpaint', 05:37:51 INFO - 'sessionrestore', 05:37:51 INFO - 'sessionrestore_no_auto_restore', 05:37:51 INFO - 'tabpaint']}, 05:37:51 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:37:51 INFO - 'tests': ['a11yr', 05:37:51 INFO - 'ts_paint', 05:37:51 INFO - 'tpaint', 05:37:51 INFO - 'sessionrestore', 05:37:51 INFO - 'sessionrestore_no_auto_restore', 05:37:51 INFO - 'tabpaint']}, 05:37:51 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:37:51 INFO - 'tests': ['a11yr', 05:37:51 INFO - 'ts_paint', 05:37:51 INFO - 'tpaint', 05:37:51 INFO - 'sessionrestore', 05:37:51 INFO - 'sessionrestore_no_auto_restore', 05:37:51 INFO - 'tabpaint']}, 05:37:51 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:37:51 INFO - 'tests': ['tsvgx', 05:37:51 INFO - 'tsvgr_opacity', 05:37:51 INFO - 'tart', 05:37:51 INFO - 'tscrollx', 05:37:51 INFO - 'cart']}, 05:37:51 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:37:51 INFO - 'tsvgr_opacity', 05:37:51 INFO - 'tart', 05:37:51 INFO - 'tscrollx', 05:37:51 INFO - 'cart']}, 05:37:51 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:37:51 INFO - 'talos_options': ['--disable-e10s'], 05:37:51 INFO - 'tests': ['tp5o']}, 05:37:51 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:37:51 INFO - 'tests': ['tp5o']}, 05:37:51 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:37:51 INFO - 'talos_options': ['--disable-e10s', 05:37:51 INFO - '--xperf_path', 05:37:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:37:51 INFO - 'tests': ['tp5n']}, 05:37:51 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:37:51 INFO - 'talos_options': ['--xperf_path', 05:37:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:37:51 INFO - 'tests': ['tp5n']}}, 05:37:51 INFO - 'talos.zip': {'path': '', 05:37:51 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:37:51 INFO - Running post-action listener: _resource_record_post_action 05:37:51 INFO - ##### 05:37:51 INFO - ##### Finished populate-webroot step (success) 05:37:51 INFO - ##### 05:37:51 INFO - ##### 05:37:51 INFO - ##### Running create-virtualenv step. 05:37:51 INFO - ##### 05:37:51 INFO - Running pre-action listener: _resource_record_pre_action 05:37:51 INFO - Running main action method: create_virtualenv 05:37:51 INFO - Creating virtualenv /builds/slave/test/build/venv 05:37:51 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 05:37:51 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:37:51 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:37:51 INFO - Using real prefix '/tools/python27' 05:37:51 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:37:52 INFO - Installing distribute.............................................................................................................................................................................................done. 05:37:55 INFO - Installing pip.................done. 05:37:55 INFO - Return code: 0 05:37:55 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:37:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:37:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:37:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:37:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:37:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:37:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:37:55 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 0x10caa1a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10caa7570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc5e3dd86a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c945d30>, '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 0x10c769db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c93cb20>, '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.RyaXNb7EQn/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.LN64wk4KyS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:37:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 05:37:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:37:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RyaXNb7EQn/Render', 05:37:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:37:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:37:55 INFO - 'HOME': '/Users/cltbld', 05:37:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:37:55 INFO - 'LOGNAME': 'cltbld', 05:37:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:37:55 INFO - 'MOZ_NO_REMOTE': '1', 05:37:55 INFO - 'NO_EM_RESTART': '1', 05:37:55 INFO - 'PAGER': '/bin/cat', 05:37:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:37:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:37:55 INFO - 'PWD': '/builds/slave/test', 05:37:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:37:55 INFO - 'SHELL': '/bin/bash', 05:37:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LN64wk4KyS/Listeners', 05:37:55 INFO - 'TMPDIR': '/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/', 05:37:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:37:55 INFO - 'USER': 'cltbld', 05:37:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:37:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:37:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:37:55 INFO - 'XPC_FLAGS': '0x0', 05:37:55 INFO - 'XPC_SERVICE_NAME': '0', 05:37:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:37:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:37:55 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 05:37:55 INFO - Cleaning up... 05:37:55 INFO - Return code: 0 05:37:55 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:37:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:37:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:37:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:37:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:37:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:37:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:37:55 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 0x10caa1a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10caa7570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc5e3dd86a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c945d30>, '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 0x10c769db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c93cb20>, '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.RyaXNb7EQn/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.LN64wk4KyS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:37:55 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 05:37:55 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 05:37:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RyaXNb7EQn/Render', 05:37:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:37:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:37:55 INFO - 'HOME': '/Users/cltbld', 05:37:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:37:55 INFO - 'LOGNAME': 'cltbld', 05:37:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:37:55 INFO - 'MOZ_NO_REMOTE': '1', 05:37:55 INFO - 'NO_EM_RESTART': '1', 05:37:55 INFO - 'PAGER': '/bin/cat', 05:37:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:37:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:37:55 INFO - 'PWD': '/builds/slave/test', 05:37:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:37:55 INFO - 'SHELL': '/bin/bash', 05:37:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LN64wk4KyS/Listeners', 05:37:55 INFO - 'TMPDIR': '/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/', 05:37:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:37:55 INFO - 'USER': 'cltbld', 05:37:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:37:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:37:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:37:55 INFO - 'XPC_FLAGS': '0x0', 05:37:55 INFO - 'XPC_SERVICE_NAME': '0', 05:37:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:37:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:37:55 INFO - Downloading/unpacking psutil>=3.1.1 05:37:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:37:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:37:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:37:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:37:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:37:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:37:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:37:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:37:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:37:58 INFO - Installing collected packages: psutil 05:37:58 INFO - Running setup.py install for psutil 05:37:58 INFO - building 'psutil._psutil_osx' extension 05:37:58 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 05:37:58 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 05:37:58 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 05:37:58 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 05:37:58 INFO - building 'psutil._psutil_posix' extension 05:37:58 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 05:37:58 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 05:37:58 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 05:37:58 INFO - ^ 05:37:59 INFO - 1 warning generated. 05:37:59 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 05:37:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:37:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:37:59 INFO - Successfully installed psutil 05:37:59 INFO - Cleaning up... 05:37:59 INFO - Return code: 0 05:37:59 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:37: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')]} 05:37:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:37:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:37: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')]} 05:37:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:37:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:37: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10caa1a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10caa7570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc5e3dd86a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c945d30>, '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 0x10c769db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c93cb20>, '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.RyaXNb7EQn/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.LN64wk4KyS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:37: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 05:37: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 mozsystemmonitor==0.3 05:37:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RyaXNb7EQn/Render', 05:37:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:37:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:37:59 INFO - 'HOME': '/Users/cltbld', 05:37:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:37:59 INFO - 'LOGNAME': 'cltbld', 05:37:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:37:59 INFO - 'MOZ_NO_REMOTE': '1', 05:37:59 INFO - 'NO_EM_RESTART': '1', 05:37:59 INFO - 'PAGER': '/bin/cat', 05:37:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:37:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:37:59 INFO - 'PWD': '/builds/slave/test', 05:37:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:37:59 INFO - 'SHELL': '/bin/bash', 05:37:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LN64wk4KyS/Listeners', 05:37:59 INFO - 'TMPDIR': '/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/', 05:37:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:37:59 INFO - 'USER': 'cltbld', 05:37:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:37:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:37:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:37:59 INFO - 'XPC_FLAGS': '0x0', 05:37:59 INFO - 'XPC_SERVICE_NAME': '0', 05:37:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:37:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:37:59 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:37: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 05:37: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 05:37: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 05:37: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 05:37: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 05:37: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 05:38:01 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:38:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:38:02 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:38:02 INFO - Installing collected packages: mozsystemmonitor 05:38:02 INFO - Running setup.py install for mozsystemmonitor 05:38:02 INFO - Successfully installed mozsystemmonitor 05:38:02 INFO - Cleaning up... 05:38:02 INFO - Return code: 0 05:38:02 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:38: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')]} 05:38:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:38:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:38: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')]} 05:38:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:38:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:38: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', '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 0x10caa1a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10caa7570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc5e3dd86a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c945d30>, '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 0x10c769db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c93cb20>, '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.RyaXNb7EQn/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.LN64wk4KyS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:38: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:38: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 blobuploader==1.2.4 05:38:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RyaXNb7EQn/Render', 05:38:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:38:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:38:02 INFO - 'HOME': '/Users/cltbld', 05:38:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:38:02 INFO - 'LOGNAME': 'cltbld', 05:38:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:38:02 INFO - 'MOZ_NO_REMOTE': '1', 05:38:02 INFO - 'NO_EM_RESTART': '1', 05:38:02 INFO - 'PAGER': '/bin/cat', 05:38:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:38:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:38:02 INFO - 'PWD': '/builds/slave/test', 05:38:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:38:02 INFO - 'SHELL': '/bin/bash', 05:38:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LN64wk4KyS/Listeners', 05:38:02 INFO - 'TMPDIR': '/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/', 05:38:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:38:02 INFO - 'USER': 'cltbld', 05:38:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:38:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:38:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:38:02 INFO - 'XPC_FLAGS': '0x0', 05:38:02 INFO - 'XPC_SERVICE_NAME': '0', 05:38:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:38:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:38:02 INFO - Downloading/unpacking blobuploader==1.2.4 05:38: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 05:38: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 05:38: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 05:38: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 05:38: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 05:38: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 05:38:04 INFO - Downloading blobuploader-1.2.4.tar.gz 05:38:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:38:05 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:38: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 05:38: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 05:38: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 05:38: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 05:38: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 05:38: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 05:38:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:38:05 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:38: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 05:38: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 05:38: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 05:38: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 05:38: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 05:38: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 05:38:06 INFO - Downloading docopt-0.6.1.tar.gz 05:38:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:38:06 INFO - Installing collected packages: blobuploader, requests, docopt 05:38:06 INFO - Running setup.py install for blobuploader 05:38:06 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:38:06 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:38:06 INFO - Running setup.py install for requests 05:38:06 INFO - Running setup.py install for docopt 05:38:07 INFO - Successfully installed blobuploader requests docopt 05:38:07 INFO - Cleaning up... 05:38:07 INFO - Return code: 0 05:38:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:38:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:38:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:38:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:38:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:38:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:38:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:38:07 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 0x10caa1a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10caa7570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc5e3dd86a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c945d30>, '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 0x10c769db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c93cb20>, '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.RyaXNb7EQn/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.LN64wk4KyS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:38:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:38:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:38:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RyaXNb7EQn/Render', 05:38:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:38:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:38:07 INFO - 'HOME': '/Users/cltbld', 05:38:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:38:07 INFO - 'LOGNAME': 'cltbld', 05:38:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:38:07 INFO - 'MOZ_NO_REMOTE': '1', 05:38:07 INFO - 'NO_EM_RESTART': '1', 05:38:07 INFO - 'PAGER': '/bin/cat', 05:38:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:38:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:38:07 INFO - 'PWD': '/builds/slave/test', 05:38:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:38:07 INFO - 'SHELL': '/bin/bash', 05:38:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LN64wk4KyS/Listeners', 05:38:07 INFO - 'TMPDIR': '/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/', 05:38:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:38:07 INFO - 'USER': 'cltbld', 05:38:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:38:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:38:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:38:07 INFO - 'XPC_FLAGS': '0x0', 05:38:07 INFO - 'XPC_SERVICE_NAME': '0', 05:38:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:38:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:38:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:38:07 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-mCtqEy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:38:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:38:07 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-uECbni-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:38:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:38:07 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-Ll3oaV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:38:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:38:07 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-DZhiad-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:38:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:38:07 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-_IqEBS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:38:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:38:07 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-hx7S4A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:38:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:38:08 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-iBCITO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:38:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:38:08 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-q4Q2fL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:38:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:38:08 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-7wTFAL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:38:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:38:08 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-HXdboH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:38:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:38:08 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-AAOZFH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:38:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:38:08 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-ErJRv1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:38:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:38:08 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-pQIzOT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:38:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:38:08 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-KBFdlS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:38:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:38:08 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-bme0Uh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:38:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:38:08 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-ieBxzq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:38:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:38:09 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-YcPOHR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:38:09 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:38:09 INFO - Running setup.py install for manifestparser 05:38:09 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:38:09 INFO - Running setup.py install for mozcrash 05:38:09 INFO - Running setup.py install for mozdebug 05:38:09 INFO - Running setup.py install for mozdevice 05:38:09 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:38:09 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:38:09 INFO - Running setup.py install for mozfile 05:38:09 INFO - Running setup.py install for mozhttpd 05:38:10 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:38:10 INFO - Running setup.py install for mozinfo 05:38:10 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:38:10 INFO - Running setup.py install for mozInstall 05:38:10 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:38:10 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:38:10 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:38:10 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:38:10 INFO - Running setup.py install for mozleak 05:38:10 INFO - Running setup.py install for mozlog 05:38:10 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:38:10 INFO - Running setup.py install for moznetwork 05:38:10 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:38:10 INFO - Running setup.py install for mozprocess 05:38:10 INFO - Running setup.py install for mozprofile 05:38:11 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:38:11 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:38:11 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:38:11 INFO - Running setup.py install for mozrunner 05:38:11 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:38:11 INFO - Running setup.py install for mozscreenshot 05:38:11 INFO - Running setup.py install for moztest 05:38:11 INFO - Running setup.py install for mozversion 05:38:11 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:38:11 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:38:11 INFO - Cleaning up... 05:38:11 INFO - Return code: 0 05:38:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:38:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:38:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:38:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:38:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:38:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:38:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:38:11 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 0x10caa1a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10caa7570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc5e3dd86a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c945d30>, '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 0x10c769db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c93cb20>, '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.RyaXNb7EQn/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.LN64wk4KyS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:38:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:38:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:38:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RyaXNb7EQn/Render', 05:38:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:38:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:38:11 INFO - 'HOME': '/Users/cltbld', 05:38:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:38:11 INFO - 'LOGNAME': 'cltbld', 05:38:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:38:11 INFO - 'MOZ_NO_REMOTE': '1', 05:38:11 INFO - 'NO_EM_RESTART': '1', 05:38:11 INFO - 'PAGER': '/bin/cat', 05:38:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:38:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:38:11 INFO - 'PWD': '/builds/slave/test', 05:38:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:38:11 INFO - 'SHELL': '/bin/bash', 05:38:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LN64wk4KyS/Listeners', 05:38:11 INFO - 'TMPDIR': '/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/', 05:38:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:38:11 INFO - 'USER': 'cltbld', 05:38:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:38:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:38:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:38:11 INFO - 'XPC_FLAGS': '0x0', 05:38:11 INFO - 'XPC_SERVICE_NAME': '0', 05:38:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:38:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:38:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:38:11 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-RiSMt8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:38:12 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 05:38:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:38:12 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-dqNdk2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:38:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:38:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:38:12 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-ewfPAR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:38:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:38:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:38:12 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-j9Mz9x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:38:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:38:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:38:12 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-l5W_79-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:38:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 05:38:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:38:12 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-UIDeGx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:38:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 05:38:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:38:12 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-f32SrC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:38:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 05:38:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:38:12 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-EhEMAo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:38:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 05:38:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:38:12 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-EUPYdt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:38:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 05:38:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:38:12 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-Gfn1S3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:38:13 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)) 05:38:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:38:13 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-i51yWv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:38:13 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 05:38:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:38:13 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-mN5ZPv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:38:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 05:38:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:38:13 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-Ybgui2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:38:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 05:38:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:38:13 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-2P3WDO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:38:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 05:38:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:38:13 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-RfHr0a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:38:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 05:38:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:38:13 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-1DKdSG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:38:13 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 05:38:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:38:13 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-Qdb6Uc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:38:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 05:38:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:38:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:38:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:38:13 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:38:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:38:13 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:38:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:38:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:38:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:38:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:38:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:38:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:38:16 INFO - Downloading blessings-1.6.tar.gz 05:38:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:38:16 INFO - Installing collected packages: blessings 05:38:16 INFO - Running setup.py install for blessings 05:38:16 INFO - Successfully installed blessings 05:38:16 INFO - Cleaning up... 05:38:16 INFO - Return code: 0 05:38:16 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:38:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:38:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:38:16 INFO - Reading from file tmpfile_stdout 05:38:16 INFO - Current package versions: 05:38:16 INFO - blessings == 1.6 05:38:16 INFO - blobuploader == 1.2.4 05:38:16 INFO - docopt == 0.6.1 05:38:16 INFO - manifestparser == 1.1 05:38:16 INFO - mozInstall == 1.12 05:38:16 INFO - mozcrash == 0.17 05:38:16 INFO - mozdebug == 0.1 05:38:16 INFO - mozdevice == 0.48 05:38:16 INFO - mozfile == 1.2 05:38:16 INFO - mozhttpd == 0.7 05:38:16 INFO - mozinfo == 0.9 05:38:16 INFO - mozleak == 0.1 05:38:16 INFO - mozlog == 3.2 05:38:16 INFO - moznetwork == 0.27 05:38:16 INFO - mozprocess == 0.22 05:38:16 INFO - mozprofile == 0.28 05:38:16 INFO - mozrunner == 6.11 05:38:16 INFO - mozscreenshot == 0.1 05:38:16 INFO - mozsystemmonitor == 0.3 05:38:16 INFO - moztest == 0.7 05:38:16 INFO - mozversion == 1.4 05:38:16 INFO - psutil == 3.1.1 05:38:16 INFO - requests == 1.2.3 05:38:16 INFO - wsgiref == 0.1.2 05:38:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:38:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:38:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:38:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:38:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:38:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:38:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:38:16 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 0x10caa1a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10caa7570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc5e3dd86a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c945d30>, '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 0x10c769db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c93cb20>, '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.RyaXNb7EQn/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.LN64wk4KyS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:38:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 05:38:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:38:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RyaXNb7EQn/Render', 05:38:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:38:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:38:16 INFO - 'HOME': '/Users/cltbld', 05:38:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:38:16 INFO - 'LOGNAME': 'cltbld', 05:38:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:38:16 INFO - 'MOZ_NO_REMOTE': '1', 05:38:16 INFO - 'NO_EM_RESTART': '1', 05:38:16 INFO - 'PAGER': '/bin/cat', 05:38:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:38:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:38:16 INFO - 'PWD': '/builds/slave/test', 05:38:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:38:16 INFO - 'SHELL': '/bin/bash', 05:38:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LN64wk4KyS/Listeners', 05:38:16 INFO - 'TMPDIR': '/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/', 05:38:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:38:16 INFO - 'USER': 'cltbld', 05:38:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:38:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:38:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:38:16 INFO - 'XPC_FLAGS': '0x0', 05:38:16 INFO - 'XPC_SERVICE_NAME': '0', 05:38:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:38:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:38:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:38:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 05:38:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 05:38:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:38:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 05:38:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 05:38:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 05:38:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 05:38:17 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 05:38:17 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:38:17 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:38:17 INFO - Cleaning up... 05:38:17 INFO - Return code: 0 05:38:17 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:38:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:38:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:38:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:38:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:38:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:38:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:38:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10caa1a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10caa7570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc5e3dd86a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c945d30>, '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 0x10c769db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c93cb20>, '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.RyaXNb7EQn/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.LN64wk4KyS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:38:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 05:38:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:38:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RyaXNb7EQn/Render', 05:38:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:38:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:38:17 INFO - 'HOME': '/Users/cltbld', 05:38:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:38:17 INFO - 'LOGNAME': 'cltbld', 05:38:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:38:17 INFO - 'MOZ_NO_REMOTE': '1', 05:38:17 INFO - 'NO_EM_RESTART': '1', 05:38:17 INFO - 'PAGER': '/bin/cat', 05:38:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:38:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:38:17 INFO - 'PWD': '/builds/slave/test', 05:38:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:38:17 INFO - 'SHELL': '/bin/bash', 05:38:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LN64wk4KyS/Listeners', 05:38:17 INFO - 'TMPDIR': '/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/', 05:38:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:38:17 INFO - 'USER': 'cltbld', 05:38:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:38:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:38:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:38:17 INFO - 'XPC_FLAGS': '0x0', 05:38:17 INFO - 'XPC_SERVICE_NAME': '0', 05:38:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:38:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:38:17 INFO - Downloading/unpacking jsonschema 05:38:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:38:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:38:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:38:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:38:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:38:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:38:19 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:38:19 INFO - Downloading/unpacking functools32 (from jsonschema) 05:38:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:38:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:38:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:38:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:38:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:38:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:38:20 INFO - Downloading functools32-3.2.3-2.tar.gz 05:38:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:38:20 INFO - warning: no files found matching '*.txt' 05:38:20 INFO - no previously-included directories found matching 'build' 05:38:20 INFO - no previously-included directories found matching 'dist' 05:38:20 INFO - no previously-included directories found matching '.git*' 05:38:20 INFO - Installing collected packages: jsonschema, functools32 05:38:20 INFO - Running setup.py install for functools32 05:38:20 INFO - warning: no files found matching '*.txt' 05:38:20 INFO - no previously-included directories found matching 'build' 05:38:20 INFO - no previously-included directories found matching 'dist' 05:38:20 INFO - no previously-included directories found matching '.git*' 05:38:20 INFO - Successfully installed jsonschema functools32 05:38:20 INFO - Cleaning up... 05:38:20 INFO - Return code: 0 05:38:20 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 05:38:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:38:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:38:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:38:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:38:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:38:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:38:20 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 0x10caa1a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10caa7570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc5e3dd86a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c945d30>, '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 0x10c769db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c93cb20>, '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.RyaXNb7EQn/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.LN64wk4KyS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:38:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 05:38:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 05:38:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RyaXNb7EQn/Render', 05:38:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:38:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:38:20 INFO - 'HOME': '/Users/cltbld', 05:38:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:38:20 INFO - 'LOGNAME': 'cltbld', 05:38:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:38:20 INFO - 'MOZ_NO_REMOTE': '1', 05:38:20 INFO - 'NO_EM_RESTART': '1', 05:38:20 INFO - 'PAGER': '/bin/cat', 05:38:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:38:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:38:20 INFO - 'PWD': '/builds/slave/test', 05:38:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:38:20 INFO - 'SHELL': '/bin/bash', 05:38:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LN64wk4KyS/Listeners', 05:38:20 INFO - 'TMPDIR': '/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/', 05:38:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:38:20 INFO - 'USER': 'cltbld', 05:38:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:38:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:38:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:38:20 INFO - 'XPC_FLAGS': '0x0', 05:38:20 INFO - 'XPC_SERVICE_NAME': '0', 05:38:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:38:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:38:20 INFO - Downloading/unpacking flake8 05:38:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:38:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:38:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:38:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:38:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:38:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:38:23 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:38:23 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:38:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:38:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:38:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:38:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:38:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:38:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:38:23 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:38:23 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:38:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:38:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:38:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:38:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:38:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:38:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:38:23 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:38:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:38:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:38:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:38:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:38:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:38:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:38:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 05:38:24 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:38:24 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:38:24 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:38:24 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:38:24 INFO - no previously-included directories found matching 'docs/_build' 05:38:24 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:38:24 INFO - Running setup.py install for pep8 05:38:24 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:38:24 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:38:24 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:38:24 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:38:24 INFO - no previously-included directories found matching 'docs/_build' 05:38:24 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 05:38:24 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:38:24 INFO - Cleaning up... 05:38:24 INFO - Return code: 0 05:38:24 INFO - Running post-action listener: _resource_record_post_action 05:38:24 INFO - Running post-action listener: _start_resource_monitoring 05:38:24 INFO - Starting resource monitoring. 05:38:24 INFO - ##### 05:38:24 INFO - ##### Finished create-virtualenv step (success) 05:38:24 INFO - ##### 05:38:24 INFO - ##### 05:38:24 INFO - ##### Running install step. 05:38:24 INFO - ##### 05:38:24 INFO - Running pre-action listener: _resource_record_pre_action 05:38:24 INFO - Running main action method: install 05:38:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:38:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:38:25 INFO - Reading from file tmpfile_stdout 05:38:25 INFO - Detecting whether we're running mozinstall >=1.0... 05:38:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:38:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:38:25 INFO - Reading from file tmpfile_stdout 05:38:25 INFO - Output received: 05:38:25 INFO - Usage: mozinstall [options] installer 05:38:25 INFO - Options: 05:38:25 INFO - -h, --help show this help message and exit 05:38:25 INFO - -d DEST, --destination=DEST 05:38:25 INFO - Directory to install application into. [default: 05:38:25 INFO - "/builds/slave/test"] 05:38:25 INFO - --app=APP Application being installed. [default: firefox] 05:38:25 INFO - mkdir: /builds/slave/test/build/application 05:38:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 05:38:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 05:38:59 INFO - Reading from file tmpfile_stdout 05:38:59 INFO - Output received: 05:38:59 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 05:38:59 INFO - Running post-action listener: _resource_record_post_action 05:38:59 INFO - ##### 05:38:59 INFO - ##### Finished install step (success) 05:38:59 INFO - ##### 05:38:59 INFO - ##### 05:38:59 INFO - ##### Running run-tests step. 05:38:59 INFO - ##### 05:38:59 INFO - Running pre-action listener: _resource_record_pre_action 05:38:59 INFO - Running main action method: run_tests 05:38:59 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:38:59 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:38:59 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:38:59 INFO - 2016-05-25 05:38:59.045 screenresolution[1977:14046] starting screenresolution argv=screenresolution get 05:38:59 INFO - 2016-05-25 05:38:59.048 screenresolution[1977:14046] Display 0: 1600x1200x32@60 05:38:59 INFO - 2016-05-25 05:38:59.054 screenresolution[1978:14048] starting screenresolution argv=screenresolution list 05:38:59 INFO - Available Modes on Display 0 05:38:59 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:38:59 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:38:59 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:38:59 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:38:59 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:38:59 INFO - Intel Iris: 05:38:59 INFO - Chipset Model: Intel Iris 05:38:59 INFO - Type: GPU 05:38:59 INFO - Bus: Built-In 05:38:59 INFO - VRAM (Dynamic, Max): 1536 MB 05:38:59 INFO - Vendor: Intel (0x8086) 05:38:59 INFO - Device ID: 0x0a2e 05:38:59 INFO - Revision ID: 0x0009 05:38:59 INFO - Displays: 05:38:59 INFO - Display: 05:38:59 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:38:59 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:38:59 INFO - Display Serial Number: 1600x1200 60 05:38:59 INFO - Main Display: Yes 05:38:59 INFO - Mirror: Off 05:38:59 INFO - Online: Yes 05:38:59 INFO - Rotation: Supported 05:38:59 INFO - Return code: 0 05:38:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:38:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:38:59 INFO - Python 2.7.3 05:38:59 INFO - Return code: 0 05:38:59 INFO - grabbing minidump binary from tooltool 05:38: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')]} 05:38:59 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 0x10c945d30>, '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 0x10c769db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c93cb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:38:59 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 05:38:59 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 05:38:59 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 05:38:59 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:38:59 INFO - Return code: 0 05:38:59 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 05:38:59 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:38:59 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:38:59 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 05:38:59 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:38:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 05:38:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 05:39:00 INFO - Return code: 0 05:39:00 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/E-BVgxdjTFGG_0n4iN9GSA/artifacts/public/build/firefox-49.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0116', '--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 05:39:00 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/E-BVgxdjTFGG_0n4iN9GSA/artifacts/public/build/firefox-49.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0116 --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 05:39:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RyaXNb7EQn/Render', 05:39:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:39:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:39:00 INFO - 'HOME': '/Users/cltbld', 05:39:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:39:00 INFO - 'LOGNAME': 'cltbld', 05:39:00 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:39:00 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 05:39:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:39:00 INFO - 'MOZ_NO_REMOTE': '1', 05:39:00 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:39:00 INFO - 'NO_EM_RESTART': '1', 05:39:00 INFO - 'PAGER': '/bin/cat', 05:39:00 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:39:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:39:00 INFO - 'PWD': '/builds/slave/test', 05:39:00 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:39:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:39:00 INFO - 'SHELL': '/bin/bash', 05:39:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LN64wk4KyS/Listeners', 05:39:00 INFO - 'TMPDIR': '/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/', 05:39:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:39:00 INFO - 'USER': 'cltbld', 05:39:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:39:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:39:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:39:00 INFO - 'XPC_FLAGS': '0x0', 05:39:00 INFO - 'XPC_SERVICE_NAME': '0', 05:39:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:39:00 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/E-BVgxdjTFGG_0n4iN9GSA/artifacts/public/build/firefox-49.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0116', '--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 05:39:00 INFO - mozversion application_buildid: 20160525042639 05:39:00 INFO - mozversion application_changeset: 2a2ce43bcafb42f0f5fcf4dd0f135eefdfe085b7 05:39:00 INFO - mozversion application_display_name: Nightly 05:39:00 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:39:00 INFO - mozversion application_name: Firefox 05:39:00 INFO - mozversion application_remotingname: firefox 05:39:00 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 05:39:00 INFO - mozversion application_vendor: Mozilla 05:39:00 INFO - mozversion application_version: 49.0a1 05:39:00 INFO - mozversion platform_buildid: 20160525042639 05:39:00 INFO - mozversion platform_changeset: 2a2ce43bcafb42f0f5fcf4dd0f135eefdfe085b7 05:39:00 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 05:39:00 INFO - mozversion platform_version: 49.0a1 05:39:00 INFO - using testdate: 1464179940 05:39:00 INFO - actual date: 1464179940 05:39:00 INFO - starting webserver on 'localhost:51371' 05:39:00 INFO - SUITE-START | Running 2 tests 05:39:00 INFO - TEST-START | dromaeo_css 05:39:00 INFO - operating with platform_type : mac_ 05:39:00 INFO - Initialising browser for dromaeo_css test... 05:39:00 INFO - TEST-INFO | started process 1996 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/tmpexHJKu/profile http://localhost:51371/getInfo.html) 05:39:03 INFO - PROCESS | 1996 | __metrics Screen width/height:1600/1200 05:39:03 INFO - PROCESS | 1996 | colorDepth:24 05:39:03 INFO - PROCESS | 1996 | Browser inner width/height: 1024/689 05:39:03 INFO - PROCESS | 1996 | __metrics 05:39:03 ERROR - PROCESS | 1996 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 05:39:04 INFO - TEST-INFO | 1996: exit 0 05:39:04 INFO - Browser initialized. 05:39:04 INFO - Running cycle 1/1 for dromaeo_css test... 05:39:04 INFO - TEST-INFO | started process 1999 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/tmpexHJKu/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:39:16 INFO - PROCESS | 1999 | RSS: Main: 249937920 05:39:16 INFO - PROCESS | 1999 | 05:40:06 INFO - PROCESS | 1999 | 1464180006123 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 05:42:16 INFO - PROCESS | 1999 | Cycle 1(1): loaded http://localhost:51371/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51371/tests/dromaeo/cssquery-ext.html) 05:42:18 INFO - PROCESS | 1999 | RSS: Main: 261279744 05:42:18 INFO - PROCESS | 1999 | 05:45:20 INFO - PROCESS | 1999 | Cycle 1(1): loaded http://localhost:51371/tests/dromaeo/cssquery-ext.html (next: http://localhost:51371/tests/dromaeo/cssquery-jquery.html) 05:45:21 INFO - PROCESS | 1999 | RSS: Main: 273481728 05:45:21 INFO - PROCESS | 1999 | 05:48:23 INFO - PROCESS | 1999 | Cycle 1(1): loaded http://localhost:51371/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51371/tests/dromaeo/cssquery-mootools.html) 05:48:23 INFO - PROCESS | 1999 | RSS: Main: 276049920 05:48:23 INFO - PROCESS | 1999 | 05:51:25 INFO - PROCESS | 1999 | Cycle 1(1): loaded http://localhost:51371/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51371/tests/dromaeo/cssquery-prototype.html) 05:51:26 INFO - PROCESS | 1999 | RSS: Main: 277311488 05:51:26 INFO - PROCESS | 1999 | 05:54:28 INFO - PROCESS | 1999 | Cycle 1(1): loaded http://localhost:51371/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51371/tests/dromaeo/cssquery-yui.html) 05:54:29 INFO - PROCESS | 1999 | RSS: Main: 280363008 05:54:29 INFO - PROCESS | 1999 | 05:57:32 INFO - PROCESS | 1999 | Cycle 1(1): loaded http://localhost:51371/tests/dromaeo/cssquery-yui.html (next: http://localhost:51371/tests/dromaeo/cssquery-dojo.html) 05:57:32 INFO - PROCESS | 1999 | RSS: Main: 281219072 05:57:32 INFO - PROCESS | 1999 | 05:57:32 INFO - PROCESS | 1999 | __start_tp_report 05:57:32 INFO - PROCESS | 1999 | _x_x_mozilla_page_load 05:57:32 INFO - PROCESS | 1999 | _x_x_mozilla_page_load_details 05:57:32 INFO - PROCESS | 1999 | |i|pagename|runs| 05:57:32 INFO - PROCESS | 1999 | |0;dojo.html;3107.937841243175;3522.3131489359575;3524.7004004659602;3540.6990405815504;3588.4079126944057;4693.296005599162;5784.68184249866;5842.853928651786;5863.120531920209;5965.433283838029;5772.076467765159;5821.476067153955;5821.708914554277;5921.230240068796;5999.43005414486;4047.2107938951917;4289.335153051282;5308.840734777944;5403.567714582824;5497.47773961473;505.15103662123823;4667.7199368037855;5298.6555873868265;5427.538659213971;5445;5358.678479291255;5361.195820626898;5362.490563396471;5394.217838413448;5421.83734487962;5306.071437498423;5430.945690543083;5461.617686761928;5470.070088084995;5499.175123731432;5332.173513105436;5336.959292937879;5393.002294575516;5401.864953376158;5427.1316589345515;5717.542596592262;5848.97075514624;5869.8239052828485;5875.970620146872;5894.528437724972;6210.96894515529;6219.564630475868;6256.436920677161;6298.307186209513;6310.053491976194;6237.469815065725;6315.494760419156;6316.463100636452;6323.557350985433;6342.809715708536;6055.364186760371;6058.575899687024;6062.636241825505;6067.302260240041;6074.2103526541705;6252.343503932113;6317.526185536011;6317.873642527215;6439.67801609927;6475.4819614430735;6271.310155882849;6292.811215663537;6309.463695585835;6330.968345158245;6342.175517182829;6260.780872669435;6345.777897773648;6348.841278968062;6362.236531616236;6367.140436041075;6192.659403732838;6266.154069200691;6300.558960872787;6310.873782524323;6361.968190159112;6203.193584834033;6260.40526150015;6283.717232724538;6288.339724328971;6325;5111.642185047011;5119.513646203604;5123.103456895028;5129.307543481582;5145.562627176732;4452.48796388413;4457.331400289982;4478.977605111953;4552.931706024412;4592.530807193112;5904.527637788967;5982.700864956735;5985.25184351956;5988.191594134823;6002.879942401128;5977.402259773988;6321.399467050623;6321.936780632135;6336.493080553545;6338.207724034496;5836.2412886325355;5882.882342353215;5907.527397808165;5931.347551769302;5986.6707331097205;5546.334439867242;5575.581831362664;5581.302337207849;5590.357108932443;5635.492805647511;6554.475641948633;6559.278479367265;6570.178727659043;6572.047053177358;6599.934000660028;6251.562390632612;6264.874702506016;6275.592086514362;6308.905366419599;6383.39357761012;6560.44236239925;6601.702923368556;6605;6605.933940660724;6613.702383392662;6333.936660633335;6367.87264254703;6377.394147555975;6384.233891932998;6391;6261.906071409024;6263.843403914939;6297.779577714758;6311.715972781144;6346.270178929298;6207.906881396873;6314.179156709598;6339.587926784744;6343.492520598434;6347.619142851444;5393.217983392465;6281.183446151971;6299.716512756845;6299.779507717208;6341.55609107358;4859.927101093415;6001.399860013964;6001.789937352171;6009.54928380382;6115.357887421935;6111.908321375272;6251.062340648939;6267.091271765659;6277.811665650038;6284.811455656338;6065.5754097212775;6106.642687876592;6170.907436388368;6209.006558950727;6210.534209934182 05:57:32 INFO - PROCESS | 1999 | |1;ext.html;494.3449928844281;495.21013982697605;498.3222816968924;507.8730317420645;568.8919105369977;40196.799016004916;43135.137297254114;43185;43265.99999999996;43275;42361.57638423615;44120.55879441205;44839.77580112103;44947.55052449483;45034.0993180137;9606.471644059575;9697.903020969807;9837.213022958145;9857.162141218005;9864.654737084167;9526.42841429513;9613.423194608311;9645.903540964606;9660.806783864318;9692.709218723414;9620.56707448163;9629.614815407374;9651.903480965206;9676.903230967706;9688.70933871985;9544.42733435996;9588.616455341778;9646.083622055894;9684.709458716214;9696.612135514571;9656.75858103553;9662.9516852416;9730.854037189449;9755.219582433388;9818.361806482628;39988.40017399741;40052;40845;41327.58672413268;41387.37918931218;2787.2753084198052;3070.8925187618324;3159.4628913084603;3359.7648164628486;3389.4915762635555;23905.760942390527;26931.865340673172;27348.72651273482;29133.41733165346;29671.851640741657;2669.8798554065115;2680.1423544465583;2705.580635001578;2768.1557125076843;2780.9165725028283;424131.8793406044;425169;426304.86847565876;428295;428771;34407.967760967214;35175.82412087923;35245.82377088149;35358.93923182309;35369.46945795764;36101;37415.4387684185;37446.5021399141;37487.81256093702;37530.06174845651;13780.690834370718;14885.851141488663;15396.230188490754;15569.377224910877;15579.376824926876;12992.610221693176;13015.284159371326;13056.412461439259;13117.475300987853;13119.409626566827;8156;8183.14077021916;8197.79505512367;8200.58997050145;8264.338852891755;2836.8865245390366;3338.115399419156;3343.632200457948;3353.614334351532;3381.289929114864;880.3793325705362;914.29599208609;1013.8225810483136;1045.46158728255;1060.5068643081004;24115.757233578075;28215.71784282172;29900.252493687833;30993.69006309908;31006;838.5471845203522;982.7297493189287;1051.6476980211562;1060.6446840308583;1065.0361422912276;12784;15630.531084067496;15683.764743528856;15720;16090.034597924163;683718;689439;698428;704673;707555;62752.37247627465;63155;64023;64491.67754161199;64592;1425.4013314407973;1429.0925262458206;1453.4258967707697;1453.6365908522869;1457.8469260727684;23840.761592383853;29481.820727170674;29538.556921645762;30210.84894575513;30533.847330763205;54996.725016374665;55181.724091379285;55276;55461.7226913879;55633.72183139058;618768;618878;619722;620085;622576;27035.72964270332;27110;27470.90116395322;27853.303667408476;27918;46848.531514684415;47836.5216347846;48062.5193748058;48381;48724.26913596228;34315.65684343124;38960;39445.01387465336;40023.39964900471;40325;37666;38139.046523837125;38267.808660956514;38808.80595597117;39109.8044509787;37080.62919370772;38178.0455488615;38595.03512412212;39129.41305880357;39336.6066339333;32555.511667324536;33881.49177762286;34545.82727086348;34782.47826282658;34825;20489.69265461049;24028.75971240265;24697.012119515017;25379.873100634377;25682.295311406877 05:57:32 INFO - PROCESS | 1999 | |2;jquery.html;381.6679488844704;387.27772703907215;387.5001248389577;397.5170168245581;402.7724335750301;15948.521544353658;21578;21971.618836213755;22050.669239961415;22196.334109976706;20643.690344644805;21024;21613.811240381772;21836.8908155459;21843.890780546113;5576.1356989666465;5802.274715660532;5948.1375200595885;5965.970170149165;6019.939800602004;3882.1265215326466;5911.970440147815;7389.5935723535185;7801.3758899288205;7839.764807055797;7634.732784352549;7818.179091195428;7918.326942209919;7958.840823183562;7961.761147165595;7010.614416207107;7610.581418022007;7753.651085701157;7903.367730581568;7946.483478573903;7670.156282808886;7690.500117492345;7690.5770182639935;7708.537487750753;7723.497972631761;28089;28404.058579497218;28832;29008.27479313013;29666.258343541584;2166.880821554814;2290.988545057264;2317.381855795196;2330.4523436992463;2519.48350588129;11760.882391176065;13297.734045319135;16629.085400302978;16670.33318667252;16945.83054169467;1844.769403824522;1904.838088762457;1917.8465722742146;1957.1388589020785;1958.3831093205595;113530;147987.26006370006;153197;154637.22681386635;156580;21271.36185914425;21802.672959905613;21807.127714891543;21904.89047554752;22045.89770511468;28161.155165345073;35362;35471.29057418889;35500.64499355025;36163.095922602144;9117.863232051524;10928.890711092787;11300.717482063013;11325.830112548318;11343.262687925258;9254;9282.21101206405;9307.11582399671;9365.438073715599;9401.153896149379;9003.14470125337;9775.51122443875;9818.65634702782;9953.601855925826;10039.849402258971;3668.724845636588;3682.705383569308;3741.494898188764;3916.4712763777097;4068.613481719232;847.5931552854664;883.3551507399505;937.3953799799227;959.8800149981253;1007.9042490963493;13813.930930345485;20491.69262461064;21136.78863211379;21238.89380553087;21629.891850540647;902.3142411767104;935.5369092299355;982.189693502863;987.9626392288212;1001.6594357918198;10067.798644027078;10149.731283589552;11162.944185279022;11306.321620702784;11336.26314289585;603834;606278;614180;617352;618191;102041.95916081636;129357;134423;134855;135827.32086339506;988.6490295944836;1009.9192064634811;1022.4734261855002;1025.3181634213313;1028.6348346337093;18948.810511895255;19198.232070717015;19306;19310.903445482683;19317.90341048342;54788;55488.72255638696;56030.87938241294;56123.43876561346;56149.71925140348;64925.026124607226;78279;79725.60137199509;79890.6005469969;79999.20000799917;6446.871797435524;7241.312075352833;8025.839483210187;8077.596120193849;8216.507009579444;9192.448453092837;10217.284790064625;11948.445943586014;12104.394780260776;12547;10540.367577945348;10677.878822723813;10758.569657213624;10821.9458902705;10856.565737370416;10463.68608941733;10659.040686338267;10876.45617719095;11087.72280692989;11088.279261847954;8976.28189744832;10720.624778132727;10933.781324373627;11123.549460764329;11406.885931140914;7962.331321287687;8044.127786715613;8185.590720463834;8220.958895205726;8350.03974542911;7943.126256111938;9658.227341812779;10625.25623206368;11083.667489975314;11093.611723589636 05:57:32 INFO - PROCESS | 1999 | |3;mootools.html;1544.4208421841813;1584.3741722019802;1780.9643807123857;1878.755761750973;1906.1708156951718;8014.679412823494;8677.219050285474;8693.913060869389;9207.217386522145;9247.029061948491;8757;8834.646614135427;8995.820083598324;9005.054469280713;9024.593893274801;2372.632242002484;2402.2673084709245;2412.3245491262387;2412.8793560322;2418.6734790803193;2371.3715865295712;2390.8087353011715;2416.794572461343;2419.0928401849305;2421.309926670899;2302.666113413554;2308.3305841306;2367.822413319008;2420.9152679656218;2422.8546287222734;2362.492064206195;2367.360812580611;2372.1341710275797;2374.536965291769;2389.8207634427313;2358.6697862299293;2363.491849252419;2369.5024044950583;2369.5142495788323;2372.466195106105;8768.210861022539;8817.29461643067;8827.249683776887;8938.46369217849;9056.094390560957;4566.4520257568975;5284.603654725911;5382.138857782736;5472.20653005312;5487.6158668893195;2888.436754832808;3555.4489054196642;3595.1731101846462;3603.3153700796765;3611.1513794258326;862.8791969124328;901.2069378946551;1025.0825511167463;1038.4859494550171;1039.9220058495644;11373;11554.826677599844;11668.35824029678;11857.822132668018;11911.285322880654;3862.3240932836643;4504.572065653758;4527.275635898306;4624.167649822997;4665.346851440801;8351.997760268685;8922.598483068148;9278.62885484573;9362.34463587556;9377.671781487616;5204.479552044841;5211.843644690665;5234.9476505235225;5278.788848446019;5293.523582877559;4387.5393083726385;4741.976290118528;4857.1742803723455;4901.142300097468;4907.607391408679;3805.657490825839;3846.4038074098557;3917.216556688674;3927.9018024549046;3952.2885880541203;999.3903718731714;1203.8013727734826;1208.3535308610028;1213.7936550786387;1216.0514798457218;902.5171533229822;909.1499448016126;910.5083255042335;944.4663764972769;944.9055094490633;5764.625299355528;5980.641161530322;6025.969870150621;6036.366181550961;6077.969610152009;442.6105027575713;448.0680185214745;449.5751514818465;460.07754452322877;467.07052964600877;3908.8241029153755;3996.5603783583783;4047.2310261050307;4088.9591104089172;4109.993051702352;10222.795544089076;10696.609440772805;10893.965073318022;10908.836367454494;10937.617183398543;10427.68716938493;10644.467776611138;10658.733531661615;10777.515011824487;10888.67333979966;6879.862402752017;8342.207490288412;8353.164683531599;8354.45696029756;8356.832863342821;5769.134629805562;5863.501602363847;5873.559483038704;5951;6012.819615411545;9583.089606487372;9924.751881203028;10003.749906252402;10209;10212.387256764618;10180.389176649425;10211.183105351405;10221.386716797017;10223.386596804216;10396.376217426978;6962.373386395248;7413.8146546336775;7637.6563054661565;7647.655855486405;7797.454178207471;7045.788626341218;8453.154684531744;8525.701600444203;8542.572871356531;8547.700830470903;7406.07424071991;7561;7584.317411432998;7599.696012159452;7605.771826845204;6978.930210698031;7019.017337572846;7060.3292687194635;7083.150021997393;7110.4667149962925;7007;7098.467614928798;7113.146422429341;7116.964415177891;7121.465890058163;4856;4864.708117512961;4882.780274887709;4958.72727000004;5119.283300337881;4875.341828853059;4920.704757714549;4968.8757781055765;5036.622253330942;5203.11547036997 05:57:32 INFO - PROCESS | 1999 | |4;prototype.html;265.45978932871606;305.1638510481282;320.37207074134693;321.9790713603614;324.592636241517;5292.491639882634;5326.946730532693;5471.701885208212;5516.475934786199;5537.197106419571;4341.848035318764;4716.080364328957;5145.6398052136365;5244.68531888086;5442.727863606824;4139.296319625656;4145.730527515717;4184.979075104636;4194.97902510487;4205.831766729327;3319.68462996015;3350.5476760637366;4183.728057676241;4217.85237516687;4250.808713607879;3727.378590313209;4105.630493255607;4129.669626429878;4161.459010328653;4167.791610419482;3456.7061799747053;4152.16956608678;4158.625723684883;4164.895877603054;4199.118185181115;3022.7732920031085;3458.515807786912;3604.6936010439144;3624.710023198164;3632.8365223565;4122.216778812046;4181.456410666624;4398.582134697199;4570.977145114253;5029.647924645276;3847.7306588538813;3885.533735951704;4502.527234640381;4728.574428301469;4854.344663470457;5199.1161502544655;5414.025475414423;5545.805896793593;5659.349174844863;5734.311882574076;3543.4684797280356;3711.31340701971;3952.636340462536;3956.584558621361;3956.8219430125714;5522.972385138049;5983.055506960255;5984.192134061933;5993.280806303228;6071.878562428727;3352.580927384077;3480.443129099332;3579.427291633326;4003.799810009488;4052.062254865258;3612.8916132516065;3792.8052663410936;3984.6812255019527;4079.265732168238;4096.160287141129;4672.088942656217;4690.695104818176;4697.600703940203;4726.983698504838;4728.810847566127;5048.611631801284;5772.769089236467;5778.595498315161;5821.388754180834;5839.160664390788;1327.6946302350514;1414.2575148047358;1418.5744276716944;1425.5153247895764;1430.4278288684402;754.5925200391837;826.4098660021415;864.1703964194318;869.6477926439676;871.329076611006;3857.5949525300002;3968.047668559525;4000.579939106352;4227.964148783506;4337.934930975975;4374.993751437188;4419.983403817076;4639.628829693616;4675.392199014106;4982.878852258285;4095.685937445334;4319.503257125408;4337.436133302651;4553.317002449659;4619.330197121399;2567.8459292442512;2646.801489888266;2733.562629979194;2843.7203258533327;3030.9393812124076;4880.877978050577;5215.634905556651;5712.428757124338;6274.717637706314;6276.497880169575;4987.077390682735;5905.261842269716;6079.6960151992225;6111.786087486917;6133.26400831903;5587.664740115606;5648.345277719465;5832.83343331327;6082.175347395675;6259.374062593704;5958.404159584007;5959.940400595939;5971.970140149445;5978.312494063064;5991.460768530853;4495.617872480876;4978.626603004716;5541.9168712470155;5855.2095467113095;5886.499647529837;5300.70846103468;6103;6193.314977588328;6207.306652541731;6218.968905155626;3748.7001039917286;3768.924621507609;3906.6326785624806;3940.9211815764097;3947.2697550952016;5083.694978301166;5438.993786149575;5625;5767.884642307046;5774.624649397776;5121.948780512296;5755.309362876482;5880.470757631833;5899.528037756883;5950.196723442453;5379.327584051994;5841.211436456024;5860.912086318794;5886.823395298148;5894.469497745224;5522.447755224445;5655.151727240782;5675.013745189316;5682.374938756816;5713.285839270091;4847.521505940581;5801.158831969256;5826;5840.729191652688;5843.328017277898;5130.6152038598;5365.275687782099;5714.657120572779;5744.827655170351;5771.0189267823735 05:57:32 INFO - PROCESS | 1999 | |5;yui.html;640.9294977552469;667.9064930909674;703.7466512055662;719.5934297122126;734.6951015328639;14680.632984175387;14686.559403217894;15120.546383608496;15248.618784530392;15323.846761532368;13929.791053134186;14021.509247176351;14093.506727264548;14110.365033573487;14121.29393530322;637.9968100159516;723.4935545118412;904.1817155474273;906.755176102452;910.2672348759246;886.0873300500463;909.8589718593629;910.8770316007353;914.1589737441536;918.2470374293082;957.2294303086013;961.8797650293714;965.2808657550135;965.7247684409945;966.1208300446596;953.41365060488;955.4171955107414;959.750464879133;960.1790469148847;962.0619895601802;674.0563211503885;712.5831388637653;712.7220384050224;714.3606472207346;714.6319645382632;14040.297985100704;14487.710245795026;14536.636584085376;14552.781708274384;14587.489437869624;12316.384180790925;12403.875961240363;12416.379181040911;12527.74944501114;12665.620031399072;9817.607295708163;9836.213102951746;10160.441175735332;10346.844797328045;10368.688939331832;3442.535257740223;3447.224374515714;3450.7756995795194;3472;3581.086822860154;76155.6192219041;76456.61771691106;79754.20245797584;80172.5991370051;81055.7841632376;9207.63169473227;9384.67153649619;9386.906130938603;9669.806603868024;9670.90329096714;20192.596148076955;20421.79578204199;20431.182752690023;21208.89395553043;21538.676919846213;6119.2350956130485;7191.568505889663;7226.819329516699;7349.154847192534;7471.327580517779;3854.0750219947013;3935.9212815743526;3943.3099207638547;3948.8420463181724;3949.842006319715;3439.7592168547963;3574.8033858137533;3578.5169002184894;3579.6420357964516;3580.1407662160896;638.6487431912429;643.1735220241967;648.2124219073847;653.0237295243546;653.0856800479272;511.43290416579555;516.6693316277585;594.4887396838715;610.0665981049002;630.3570358234575;8080.474769139987;8112.797180070545;8119.147489513634;8247.051589067214;8248.711295104762;506.6959824105507;540.8701911541202;547.819219657512;604.7529025169983;609.5763444406095;3591.964080359163;3703.925921481555;3869.787161706077;3970.8808735737975;4040.454538637305;93936;94924.30454172633;96608.55087173698;97456.02543974611;99964.50017749864;80856.59571702103;84843.5757821207;84886.575567123;85624;85648.57175714082;59293;75735.24264757392;75859;76382.70851874453;77137;7675.577843218676;7952.52284862887;8109.59452027408;8197.221263979913;8247.257746802816;31054;37918.62081379151;40441.98895027648;40625.59374406218;44341.77829110834;58654;59451.40548594459;59540.427574345675;59892.70053649704;60231.69884150726;9311;10818.188635852186;11007.779844402907;11056.613018544313;11420.771584568429;11898.821517677068;11970.22193557416;12023.63929082129;12041.397930103634;12289.38553072325;11294.378809165575;11364.374959376983;11499.367534785668;11662.53349865996;11760.235584686969;11305.321680699184;11306.152038597302;11489.885101148882;11549.538018479503;11841.230320029515;11333.829992550283;11338;11509.94245028803;11628.360440175871;11972;9637.325387223107;9900.009999000042;9971.351862128939;10053.798924021332;10058.195344372287;9637.662681806103;9815.950920245354;9833.030547538998;9865.013498650078;9871.439173943216 05:57:32 INFO - PROCESS | 1999 | __end_tp_report 05:57:32 INFO - PROCESS | 1999 | __start_cc_report 05:57:32 INFO - PROCESS | 1999 | _x_x_mozilla_cycle_collect,417 05:57:32 INFO - PROCESS | 1999 | __end_cc_report 05:57:32 INFO - PROCESS | 1999 | __startTimestamp1464181052504__endTimestamp 05:57:32 INFO - PROCESS | 1999 | 05:57:32 INFO - PROCESS | 1999 | ------- Summary: start ------- 05:57:32 INFO - PROCESS | 1999 | Number of tests: 6 05:57:32 INFO - PROCESS | 1999 | 05:57:32 INFO - PROCESS | 1999 | [#0] dojo.html Cycles:165 Average:5832.55 Median:6106.64 stddev:796.63 (13.0%) stddev-sans-first:769.87 05:57:32 INFO - PROCESS | 1999 | Values: 3107.9 3522.3 3524.7 3540.7 3588.4 4693.3 5784.7 5842.9 5863.1 5965.4 5772.1 5821.5 5821.7 5921.2 5999.4 4047.2 4289.3 5308.8 5403.6 5497.5 505.2 4667.7 5298.7 5427.5 5445.0 5358.7 5361.2 5362.5 5394.2 5421.8 5306.1 5430.9 5461.6 5470.1 5499.2 5332.2 5337.0 5393.0 5401.9 5427.1 5717.5 5849.0 5869.8 5876.0 5894.5 6211.0 6219.6 6256.4 6298.3 6310.1 6237.5 6315.5 6316.5 6323.6 6342.8 6055.4 6058.6 6062.6 6067.3 6074.2 6252.3 6317.5 6317.9 6439.7 6475.5 6271.3 6292.8 6309.5 6331.0 6342.2 6260.8 6345.8 6348.8 6362.2 6367.1 6192.7 6266.2 6300.6 6310.9 6362.0 6203.2 6260.4 6283.7 6288.3 6325.0 5111.6 5119.5 5123.1 5129.3 5145.6 4452.5 4457.3 4479.0 4552.9 4592.5 5904.5 5982.7 5985.3 5988.2 6002.9 5977.4 6321.4 6321.9 6336.5 6338.2 5836.2 5882.9 5907.5 5931.3 5986.7 5546.3 5575.6 5581.3 5590.4 5635.5 6554.5 6559.3 6570.2 6572.0 6599.9 6251.6 6264.9 6275.6 6308.9 6383.4 6560.4 6601.7 6605.0 6605.9 6613.7 6333.9 6367.9 6377.4 6384.2 6391.0 6261.9 6263.8 6297.8 6311.7 6346.3 6207.9 6314.2 6339.6 6343.5 6347.6 5393.2 6281.2 6299.7 6299.8 6341.6 4859.9 6001.4 6001.8 6009.5 6115.4 6111.9 6251.1 6267.1 6277.8 6284.8 6065.6 6106.6 6170.9 6209.0 6210.5 05:57:32 INFO - PROCESS | 1999 | 05:57:32 INFO - PROCESS | 1999 | [#1] ext.html Cycles:180 Average:69703.87 Median:39119.61 stddev:158999.31 (406.4%) stddev-sans-first:159360.43 05:57:32 INFO - PROCESS | 1999 | Values: 494.3 495.2 498.3 507.9 568.9 40196.8 43135.1 43185.0 43266.0 43275.0 42361.6 44120.6 44839.8 44947.6 45034.1 9606.5 9697.9 9837.2 9857.2 9864.7 9526.4 9613.4 9645.9 9660.8 9692.7 9620.6 9629.6 9651.9 9676.9 9688.7 9544.4 9588.6 9646.1 9684.7 9696.6 9656.8 9663.0 9730.9 9755.2 9818.4 39988.4 40052.0 40845.0 41327.6 41387.4 2787.3 3070.9 3159.5 3359.8 3389.5 23905.8 26931.9 27348.7 29133.4 29671.9 2669.9 2680.1 2705.6 2768.2 2780.9 424131.9 425169.0 426304.9 428295.0 428771.0 34408.0 35175.8 35245.8 35358.9 35369.5 36101.0 37415.4 37446.5 37487.8 37530.1 13780.7 14885.9 15396.2 15569.4 15579.4 12992.6 13015.3 13056.4 13117.5 13119.4 8156.0 8183.1 8197.8 8200.6 8264.3 2836.9 3338.1 3343.6 3353.6 3381.3 880.4 914.3 1013.8 1045.5 1060.5 24115.8 28215.7 29900.3 30993.7 31006.0 838.5 982.7 1051.6 1060.6 1065.0 12784.0 15630.5 15683.8 15720.0 16090.0 683718.0 689439.0 698428.0 704673.0 707555.0 62752.4 63155.0 64023.0 64491.7 64592.0 1425.4 1429.1 1453.4 1453.6 1457.8 23840.8 29481.8 29538.6 30210.8 30533.8 54996.7 55181.7 55276.0 55461.7 55633.7 618768.0 618878.0 619722.0 620085.0 622576.0 27035.7 27110.0 27470.9 27853.3 27918.0 46848.5 47836.5 48062.5 48381.0 48724.3 34315.7 38960.0 39445.0 40023.4 40325.0 37666.0 38139.0 38267.8 38808.8 39109.8 37080.6 38178.0 38595.0 39129.4 39336.6 32555.5 33881.5 34545.8 34782.5 34825.0 20489.7 24028.8 24697.0 25379.9 25682.3 05:57:32 INFO - PROCESS | 1999 | 05:57:32 INFO - PROCESS | 1999 | [#2] jquery.html Cycles:180 Average:37621.57 Median:28920.14 stddev:102491.81 (354.4%) stddev-sans-first:102741.18 05:57:32 INFO - PROCESS | 1999 | Values: 381.7 387.3 387.5 397.5 402.8 15948.5 21578.0 21971.6 22050.7 22196.3 20643.7 21024.0 21613.8 21836.9 21843.9 5576.1 5802.3 5948.1 5966.0 6019.9 3882.1 5912.0 7389.6 7801.4 7839.8 7634.7 7818.2 7918.3 7958.8 7961.8 7010.6 7610.6 7753.7 7903.4 7946.5 7670.2 7690.5 7690.6 7708.5 7723.5 28089.0 28404.1 28832.0 29008.3 29666.3 2166.9 2291.0 2317.4 2330.5 2519.5 11760.9 13297.7 16629.1 16670.3 16945.8 1844.8 1904.8 1917.8 1957.1 1958.4 113530.0 147987.3 153197.0 154637.2 156580.0 21271.4 21802.7 21807.1 21904.9 22045.9 28161.2 35362.0 35471.3 35500.6 36163.1 9117.9 10928.9 11300.7 11325.8 11343.3 9254.0 9282.2 9307.1 9365.4 9401.2 9003.1 9775.5 9818.7 9953.6 10039.8 3668.7 3682.7 3741.5 3916.5 4068.6 847.6 883.4 937.4 959.9 1007.9 13813.9 20491.7 21136.8 21238.9 21629.9 902.3 935.5 982.2 988.0 1001.7 10067.8 10149.7 11162.9 11306.3 11336.3 603834.0 606278.0 614180.0 617352.0 618191.0 102042.0 129357.0 134423.0 134855.0 135827.3 988.6 1009.9 1022.5 1025.3 1028.6 18948.8 19198.2 19306.0 19310.9 19317.9 54788.0 55488.7 56030.9 56123.4 56149.7 64925.0 78279.0 79725.6 79890.6 79999.2 6446.9 7241.3 8025.8 8077.6 8216.5 9192.4 10217.3 11948.4 12104.4 12547.0 10540.4 10677.9 10758.6 10821.9 10856.6 10463.7 10659.0 10876.5 11087.7 11088.3 8976.3 10720.6 10933.8 11123.5 11406.9 7962.3 8044.1 8185.6 8221.0 8350.0 7943.1 9658.2 10625.3 11083.7 11093.6 05:57:32 INFO - PROCESS | 1999 | 05:57:32 INFO - PROCESS | 1999 | [#3] mootools.html Cycles:180 Average:5678.93 Median:4870.02 stddev:3211.71 (65.9%) stddev-sans-first:3205.70 05:57:32 INFO - PROCESS | 1999 | Values: 1544.4 1584.4 1781.0 1878.8 1906.2 8014.7 8677.2 8693.9 9207.2 9247.0 8757.0 8834.6 8995.8 9005.1 9024.6 2372.6 2402.3 2412.3 2412.9 2418.7 2371.4 2390.8 2416.8 2419.1 2421.3 2302.7 2308.3 2367.8 2420.9 2422.9 2362.5 2367.4 2372.1 2374.5 2389.8 2358.7 2363.5 2369.5 2369.5 2372.5 8768.2 8817.3 8827.2 8938.5 9056.1 4566.5 5284.6 5382.1 5472.2 5487.6 2888.4 3555.4 3595.2 3603.3 3611.2 862.9 901.2 1025.1 1038.5 1039.9 11373.0 11554.8 11668.4 11857.8 11911.3 3862.3 4504.6 4527.3 4624.2 4665.3 8352.0 8922.6 9278.6 9362.3 9377.7 5204.5 5211.8 5234.9 5278.8 5293.5 4387.5 4742.0 4857.2 4901.1 4907.6 3805.7 3846.4 3917.2 3927.9 3952.3 999.4 1203.8 1208.4 1213.8 1216.1 902.5 909.1 910.5 944.5 944.9 5764.6 5980.6 6026.0 6036.4 6078.0 442.6 448.1 449.6 460.1 467.1 3908.8 3996.6 4047.2 4089.0 4110.0 10222.8 10696.6 10894.0 10908.8 10937.6 10427.7 10644.5 10658.7 10777.5 10888.7 6879.9 8342.2 8353.2 8354.5 8356.8 5769.1 5863.5 5873.6 5951.0 6012.8 9583.1 9924.8 10003.7 10209.0 10212.4 10180.4 10211.2 10221.4 10223.4 10396.4 6962.4 7413.8 7637.7 7647.7 7797.5 7045.8 8453.2 8525.7 8542.6 8547.7 7406.1 7561.0 7584.3 7599.7 7605.8 6978.9 7019.0 7060.3 7083.2 7110.5 7007.0 7098.5 7113.1 7117.0 7121.5 4856.0 4864.7 4882.8 4958.7 5119.3 4875.3 4920.7 4968.9 5036.6 5203.1 05:57:32 INFO - PROCESS | 1999 | 05:57:32 INFO - PROCESS | 1999 | [#4] prototype.html Cycles:180 Average:4524.26 Median:4850.93 stddev:1436.93 (29.6%) stddev-sans-first:1404.96 05:57:32 INFO - PROCESS | 1999 | Values: 265.5 305.2 320.4 322.0 324.6 5292.5 5326.9 5471.7 5516.5 5537.2 4341.8 4716.1 5145.6 5244.7 5442.7 4139.3 4145.7 4185.0 4195.0 4205.8 3319.7 3350.5 4183.7 4217.9 4250.8 3727.4 4105.6 4129.7 4161.5 4167.8 3456.7 4152.2 4158.6 4164.9 4199.1 3022.8 3458.5 3604.7 3624.7 3632.8 4122.2 4181.5 4398.6 4571.0 5029.6 3847.7 3885.5 4502.5 4728.6 4854.3 5199.1 5414.0 5545.8 5659.3 5734.3 3543.5 3711.3 3952.6 3956.6 3956.8 5523.0 5983.1 5984.2 5993.3 6071.9 3352.6 3480.4 3579.4 4003.8 4052.1 3612.9 3792.8 3984.7 4079.3 4096.2 4672.1 4690.7 4697.6 4727.0 4728.8 5048.6 5772.8 5778.6 5821.4 5839.2 1327.7 1414.3 1418.6 1425.5 1430.4 754.6 826.4 864.2 869.6 871.3 3857.6 3968.0 4000.6 4228.0 4337.9 4375.0 4420.0 4639.6 4675.4 4982.9 4095.7 4319.5 4337.4 4553.3 4619.3 2567.8 2646.8 2733.6 2843.7 3030.9 4880.9 5215.6 5712.4 6274.7 6276.5 4987.1 5905.3 6079.7 6111.8 6133.3 5587.7 5648.3 5832.8 6082.2 6259.4 5958.4 5959.9 5972.0 5978.3 5991.5 4495.6 4978.6 5541.9 5855.2 5886.5 5300.7 6103.0 6193.3 6207.3 6219.0 3748.7 3768.9 3906.6 3940.9 3947.3 5083.7 5439.0 5625.0 5767.9 5774.6 5121.9 5755.3 5880.5 5899.5 5950.2 5379.3 5841.2 5860.9 5886.8 5894.5 5522.4 5655.2 5675.0 5682.4 5713.3 4847.5 5801.2 5826.0 5840.7 5843.3 5130.6 5365.3 5714.7 5744.8 5771.0 05:57:32 INFO - PROCESS | 1999 | 05:57:32 INFO - PROCESS | 1999 | [#5] yui.html Cycles:180 Average:18034.39 Median:30418.23 stddev:25830.92 (84.9%) stddev-sans-first:25870.36 05:57:32 INFO - PROCESS | 1999 | Values: 640.9 667.9 703.7 719.6 734.7 14680.6 14686.6 15120.5 15248.6 15323.8 13929.8 14021.5 14093.5 14110.4 14121.3 638.0 723.5 904.2 906.8 910.3 886.1 909.9 910.9 914.2 918.2 957.2 961.9 965.3 965.7 966.1 953.4 955.4 959.8 960.2 962.1 674.1 712.6 712.7 714.4 714.6 14040.3 14487.7 14536.6 14552.8 14587.5 12316.4 12403.9 12416.4 12527.7 12665.6 9817.6 9836.2 10160.4 10346.8 10368.7 3442.5 3447.2 3450.8 3472.0 3581.1 76155.6 76456.6 79754.2 80172.6 81055.8 9207.6 9384.7 9386.9 9669.8 9670.9 20192.6 20421.8 20431.2 21208.9 21538.7 6119.2 7191.6 7226.8 7349.2 7471.3 3854.1 3935.9 3943.3 3948.8 3949.8 3439.8 3574.8 3578.5 3579.6 3580.1 638.6 643.2 648.2 653.0 653.1 511.4 516.7 594.5 610.1 630.4 8080.5 8112.8 8119.1 8247.1 8248.7 506.7 540.9 547.8 604.8 609.6 3592.0 3703.9 3869.8 3970.9 4040.5 93936.0 94924.3 96608.6 97456.0 99964.5 80856.6 84843.6 84886.6 85624.0 85648.6 59293.0 75735.2 75859.0 76382.7 77137.0 7675.6 7952.5 8109.6 8197.2 8247.3 31054.0 37918.6 40442.0 40625.6 44341.8 58654.0 59451.4 59540.4 59892.7 60231.7 9311.0 10818.2 11007.8 11056.6 11420.8 11898.8 11970.2 12023.6 12041.4 12289.4 11294.4 11364.4 11499.4 11662.5 11760.2 11305.3 11306.2 11489.9 11549.5 11841.2 11333.8 11338.0 11509.9 11628.4 11972.0 9637.3 9900.0 9971.4 10053.8 10058.2 9637.7 9816.0 9833.0 9865.0 9871.4 05:57:32 INFO - PROCESS | 1999 | -------- Summary: end -------- 05:57:32 INFO - PROCESS | 1999 | 05:57:33 INFO - TEST-INFO | 1999: exit 0 05:57:33 INFO - TEST-OK | dromaeo_css | took 1112332ms 05:57:33 INFO - TEST-START | kraken 05:57:33 INFO - operating with platform_type : mac_ 05:57:33 INFO - Initialising browser for kraken test... 05:57:33 INFO - TEST-INFO | started process 2004 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/tmpqAazJA/profile http://localhost:51371/getInfo.html) 05:57:36 INFO - PROCESS | 2004 | __metrics Screen width/height:1600/1200 05:57:36 INFO - PROCESS | 2004 | colorDepth:24 05:57:36 INFO - PROCESS | 2004 | Browser inner width/height: 1024/689 05:57:36 INFO - PROCESS | 2004 | __metrics 05:57:36 ERROR - PROCESS | 2004 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 05:57:36 INFO - TEST-INFO | 2004: exit 0 05:57:36 INFO - Browser initialized. 05:57:36 INFO - Running cycle 1/1 for kraken test... 05:57:37 INFO - TEST-INFO | started process 2007 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/tmpqAazJA/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:57:49 INFO - PROCESS | 2007 | RSS: Main: 250245120 05:57:49 INFO - PROCESS | 2007 | 05:57:51 INFO - PROCESS | 2007 | Cycle 1(1): loaded http://localhost:51371/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51371/tests/kraken/driver.html?testName=audio-beat-detection) 05:57:52 INFO - PROCESS | 2007 | RSS: Main: 262045696 05:57:52 INFO - PROCESS | 2007 | 05:57:55 INFO - PROCESS | 2007 | Cycle 1(1): loaded http://localhost:51371/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51371/tests/kraken/driver.html?testName=audio-dft) 05:57:55 INFO - PROCESS | 2007 | RSS: Main: 267259904 05:57:55 INFO - PROCESS | 2007 | 05:57:59 INFO - PROCESS | 2007 | Cycle 1(1): loaded http://localhost:51371/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51371/tests/kraken/driver.html?testName=audio-fft) 05:57:59 INFO - PROCESS | 2007 | RSS: Main: 267354112 05:57:59 INFO - PROCESS | 2007 | 05:58:01 INFO - PROCESS | 2007 | Cycle 1(1): loaded http://localhost:51371/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51371/tests/kraken/driver.html?testName=audio-oscillator) 05:58:02 INFO - PROCESS | 2007 | RSS: Main: 268005376 05:58:02 INFO - PROCESS | 2007 | 05:58:04 INFO - PROCESS | 2007 | Cycle 1(1): loaded http://localhost:51371/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51371/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:58:05 INFO - PROCESS | 2007 | RSS: Main: 268664832 05:58:05 INFO - PROCESS | 2007 | 05:58:08 INFO - PROCESS | 2007 | Cycle 1(1): loaded http://localhost:51371/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51371/tests/kraken/driver.html?testName=imaging-darkroom) 05:58:08 INFO - PROCESS | 2007 | RSS: Main: 268931072 05:58:08 INFO - PROCESS | 2007 | 05:58:11 INFO - PROCESS | 2007 | Cycle 1(1): loaded http://localhost:51371/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51371/tests/kraken/driver.html?testName=imaging-desaturate) 05:58:12 INFO - PROCESS | 2007 | RSS: Main: 269058048 05:58:12 INFO - PROCESS | 2007 | 05:58:15 INFO - PROCESS | 2007 | Cycle 1(1): loaded http://localhost:51371/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51371/tests/kraken/driver.html?testName=json-parse-financial) 05:58:16 INFO - PROCESS | 2007 | RSS: Main: 269316096 05:58:16 INFO - PROCESS | 2007 | 05:58:17 INFO - PROCESS | 2007 | Cycle 1(1): loaded http://localhost:51371/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51371/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:58:18 INFO - PROCESS | 2007 | RSS: Main: 268705792 05:58:18 INFO - PROCESS | 2007 | 05:58:20 INFO - PROCESS | 2007 | Cycle 1(1): loaded http://localhost:51371/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51371/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:58:21 INFO - PROCESS | 2007 | RSS: Main: 268800000 05:58:21 INFO - PROCESS | 2007 | 05:58:23 INFO - PROCESS | 2007 | Cycle 1(1): loaded http://localhost:51371/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51371/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:58:24 INFO - PROCESS | 2007 | RSS: Main: 268824576 05:58:24 INFO - PROCESS | 2007 | 05:58:26 INFO - PROCESS | 2007 | Cycle 1(1): loaded http://localhost:51371/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51371/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:58:27 INFO - PROCESS | 2007 | RSS: Main: 268632064 05:58:27 INFO - PROCESS | 2007 | 05:58:30 INFO - PROCESS | 2007 | Cycle 1(1): loaded http://localhost:51371/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51371/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:58:31 INFO - PROCESS | 2007 | RSS: Main: 268705792 05:58:31 INFO - PROCESS | 2007 | 05:58:32 INFO - PROCESS | 2007 | Cycle 1(1): loaded http://localhost:51371/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51371/tests/kraken/driver.html?testName=ai-astar) 05:58:33 INFO - PROCESS | 2007 | RSS: Main: 270675968 05:58:33 INFO - PROCESS | 2007 | 05:58:33 INFO - PROCESS | 2007 | __start_tp_report 05:58:33 INFO - PROCESS | 2007 | _x_x_mozilla_page_load 05:58:33 INFO - PROCESS | 2007 | _x_x_mozilla_page_load_details 05:58:33 INFO - PROCESS | 2007 | |i|pagename|runs| 05:58:33 INFO - PROCESS | 2007 | |0;ai-astar;115;111;114;115;115;115;113;113;116;113 05:58:33 INFO - PROCESS | 2007 | |1;audio-beat-detection;152;120;155;201;118;140;137;121;164;121 05:58:33 INFO - PROCESS | 2007 | |2;audio-dft;200;196;198;202;261;263;226;198;193;198 05:58:33 INFO - PROCESS | 2007 | |3;audio-fft;68;82;75;144;59;57;59;60;131;84 05:58:33 INFO - PROCESS | 2007 | |4;audio-oscillator;79;101;171;101;81;74;114;72;73;116 05:58:33 INFO - PROCESS | 2007 | |5;imaging-gaussian-blur;91;86;88;86;92;87;91;102;131;129 05:58:33 INFO - PROCESS | 2007 | |6;imaging-darkroom;95;95;116;126;94;125;148;96;95;96 05:58:33 INFO - PROCESS | 2007 | |7;imaging-desaturate;80;151;142;91;91;97;93;99;144;150 05:58:33 INFO - PROCESS | 2007 | |8;json-parse-financial;55;78;50;48;74;77;77;93;93;76 05:58:33 INFO - PROCESS | 2007 | |9;json-stringify-tinderbox;69;71;67;84;120;91;69;78;104;105 05:58:33 INFO - PROCESS | 2007 | |10;stanford-crypto-aes;87;85;87;88;83;87;77;98;73;78 05:58:33 INFO - PROCESS | 2007 | |11;stanford-crypto-ccm;136;144;155;145;138;147;138;161;188;163 05:58:33 INFO - PROCESS | 2007 | |12;stanford-crypto-pbkdf2;169;162;165;198;232;163;170;199;224;226 05:58:33 INFO - PROCESS | 2007 | |13;stanford-crypto-sha256-iterative;68;66;67;67;67;66;66;65;69;67 05:58:33 INFO - PROCESS | 2007 | __end_tp_report 05:58:33 INFO - PROCESS | 2007 | __start_cc_report 05:58:33 INFO - PROCESS | 2007 | _x_x_mozilla_cycle_collect,1081 05:58:33 INFO - PROCESS | 2007 | __end_cc_report 05:58:33 INFO - PROCESS | 2007 | __startTimestamp1464181113180__endTimestamp 05:58:33 INFO - PROCESS | 2007 | 05:58:33 INFO - PROCESS | 2007 | ------- Summary: start ------- 05:58:33 INFO - PROCESS | 2007 | Number of tests: 14 05:58:33 INFO - PROCESS | 2007 | 05:58:33 INFO - PROCESS | 2007 | [#0] ai-astar Cycles:10 Average:114.00 Median:115.00 stddev:1.49 (1.3%) stddev-sans-first:1.54 05:58:33 INFO - PROCESS | 2007 | Values: 115.0 111.0 114.0 115.0 115.0 115.0 113.0 113.0 116.0 113.0 05:58:33 INFO - PROCESS | 2007 | 05:58:33 INFO - PROCESS | 2007 | [#1] audio-beat-detection Cycles:10 Average:142.90 Median:146.00 stddev:26.24 (18.0%) stddev-sans-first:27.62 05:58:33 INFO - PROCESS | 2007 | Values: 152.0 120.0 155.0 201.0 118.0 140.0 137.0 121.0 164.0 121.0 05:58:33 INFO - PROCESS | 2007 | 05:58:33 INFO - PROCESS | 2007 | [#2] audio-dft Cycles:10 Average:213.50 Median:201.00 stddev:27.13 (13.5%) stddev-sans-first:28.33 05:58:33 INFO - PROCESS | 2007 | Values: 200.0 196.0 198.0 202.0 261.0 263.0 226.0 198.0 193.0 198.0 05:58:33 INFO - PROCESS | 2007 | 05:58:33 INFO - PROCESS | 2007 | [#3] audio-fft Cycles:10 Average:81.90 Median:64.00 stddev:31.02 (48.5%) stddev-sans-first:32.49 05:58:33 INFO - PROCESS | 2007 | Values: 68.0 82.0 75.0 144.0 59.0 57.0 59.0 60.0 131.0 84.0 05:58:33 INFO - PROCESS | 2007 | 05:58:33 INFO - PROCESS | 2007 | [#4] audio-oscillator Cycles:10 Average:98.20 Median:72.50 stddev:30.65 (42.3%) stddev-sans-first:31.71 05:58:33 INFO - PROCESS | 2007 | Values: 79.0 101.0 171.0 101.0 81.0 74.0 114.0 72.0 73.0 116.0 05:58:33 INFO - PROCESS | 2007 | 05:58:33 INFO - PROCESS | 2007 | [#5] imaging-gaussian-blur Cycles:10 Average:98.30 Median:87.50 stddev:17.35 (19.8%) stddev-sans-first:18.20 05:58:33 INFO - PROCESS | 2007 | Values: 91.0 86.0 88.0 86.0 92.0 87.0 91.0 102.0 131.0 129.0 05:58:33 INFO - PROCESS | 2007 | 05:58:33 INFO - PROCESS | 2007 | [#6] imaging-darkroom Cycles:10 Average:108.60 Median:95.00 stddev:19.04 (20.0%) stddev-sans-first:19.55 05:58:33 INFO - PROCESS | 2007 | Values: 95.0 95.0 116.0 126.0 94.0 125.0 148.0 96.0 95.0 96.0 05:58:33 INFO - PROCESS | 2007 | 05:58:33 INFO - PROCESS | 2007 | [#7] imaging-desaturate Cycles:10 Average:113.80 Median:91.00 stddev:28.90 (31.8%) stddev-sans-first:27.95 05:58:33 INFO - PROCESS | 2007 | Values: 80.0 151.0 142.0 91.0 91.0 97.0 93.0 99.0 144.0 150.0 05:58:33 INFO - PROCESS | 2007 | 05:58:33 INFO - PROCESS | 2007 | [#8] json-parse-financial Cycles:10 Average:72.10 Median:77.00 stddev:16.11 (20.9%) stddev-sans-first:15.86 05:58:33 INFO - PROCESS | 2007 | Values: 55.0 78.0 50.0 48.0 74.0 77.0 77.0 93.0 93.0 76.0 05:58:33 INFO - PROCESS | 2007 | 05:58:33 INFO - PROCESS | 2007 | [#9] json-stringify-tinderbox Cycles:10 Average:85.80 Median:70.00 stddev:18.55 (26.5%) stddev-sans-first:18.65 05:58:33 INFO - PROCESS | 2007 | Values: 69.0 71.0 67.0 84.0 120.0 91.0 69.0 78.0 104.0 105.0 05:58:33 INFO - PROCESS | 2007 | 05:58:33 INFO - PROCESS | 2007 | [#10] stanford-crypto-aes Cycles:10 Average:84.30 Median:87.00 stddev:7.04 (8.1%) stddev-sans-first:7.40 05:58:33 INFO - PROCESS | 2007 | Values: 87.0 85.0 87.0 88.0 83.0 87.0 77.0 98.0 73.0 78.0 05:58:33 INFO - PROCESS | 2007 | 05:58:33 INFO - PROCESS | 2007 | [#11] stanford-crypto-ccm Cycles:10 Average:151.50 Median:151.00 stddev:15.95 (10.6%) stddev-sans-first:15.90 05:58:33 INFO - PROCESS | 2007 | Values: 136.0 144.0 155.0 145.0 138.0 147.0 138.0 161.0 188.0 163.0 05:58:33 INFO - PROCESS | 2007 | 05:58:33 INFO - PROCESS | 2007 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:190.80 Median:198.50 stddev:28.55 (14.4%) stddev-sans-first:29.17 05:58:33 INFO - PROCESS | 2007 | Values: 169.0 162.0 165.0 198.0 232.0 163.0 170.0 199.0 224.0 226.0 05:58:33 INFO - PROCESS | 2007 | 05:58:33 INFO - PROCESS | 2007 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.80 Median:67.00 stddev:1.14 (1.7%) stddev-sans-first:1.12 05:58:33 INFO - PROCESS | 2007 | Values: 68.0 66.0 67.0 67.0 67.0 66.0 66.0 65.0 69.0 67.0 05:58:33 INFO - PROCESS | 2007 | -------- Summary: end -------- 05:58:33 INFO - PROCESS | 2007 | 05:58:33 INFO - TEST-INFO | 2007: exit 0 05:58:33 INFO - TEST-OK | kraken | took 60881ms 05:58:33 INFO - SUITE-END | took 1173s 05:58:34 INFO - Completed test suite (00:19:33) 05:58:34 INFO - javascript benchmark 05:58:34 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7248.57355900939, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3107.937841243175, 3522.3131489359575, 3524.7004004659602, 3540.6990405815504, 3588.4079126944057, 4693.296005599162, 5784.68184249866, 5842.853928651786, 5863.120531920209, 5965.433283838029, 5772.076467765159, 5821.476067153955, 5821.708914554277, 5921.230240068796, 5999.43005414486, 4047.2107938951917, 4289.335153051282, 5308.840734777944, 5403.567714582824, 5497.47773961473, 505.15103662123823, 4667.7199368037855, 5298.6555873868265, 5427.538659213971, 5445.0, 5358.678479291255, 5361.195820626898, 5362.490563396471, 5394.217838413448, 5421.83734487962, 5306.071437498423, 5430.945690543083, 5461.617686761928, 5470.070088084995, 5499.175123731432, 5332.173513105436, 5336.959292937879, 5393.002294575516, 5401.864953376158, 5427.1316589345515, 5717.542596592262, 5848.97075514624, 5869.8239052828485, 5875.970620146872, 5894.528437724972, 6210.96894515529, 6219.564630475868, 6256.436920677161, 6298.307186209513, 6310.053491976194, 6237.469815065725, 6315.494760419156, 6316.463100636452, 6323.557350985433, 6342.809715708536, 6055.364186760371, 6058.575899687024, 6062.636241825505, 6067.302260240041, 6074.2103526541705, 6252.343503932113, 6317.526185536011, 6317.873642527215, 6439.67801609927, 6475.4819614430735, 6271.310155882849, 6292.811215663537, 6309.463695585835, 6330.968345158245, 6342.175517182829, 6260.780872669435, 6345.777897773648, 6348.841278968062, 6362.236531616236, 6367.140436041075, 6192.659403732838, 6266.154069200691, 6300.558960872787, 6310.873782524323, 6361.968190159112, 6203.193584834033, 6260.40526150015, 6283.717232724538, 6288.339724328971, 6325.0, 5111.642185047011, 5119.513646203604, 5123.103456895028, 5129.307543481582, 5145.562627176732, 4452.48796388413, 4457.331400289982, 4478.977605111953, 4552.931706024412, 4592.530807193112, 5904.527637788967, 5982.700864956735, 5985.25184351956, 5988.191594134823, 6002.879942401128, 5977.402259773988, 6321.399467050623, 6321.936780632135, 6336.493080553545, 6338.207724034496, 5836.2412886325355, 5882.882342353215, 5907.527397808165, 5931.347551769302, 5986.6707331097205, 5546.334439867242, 5575.581831362664, 5581.302337207849, 5590.357108932443, 5635.492805647511, 6554.475641948633, 6559.278479367265, 6570.178727659043, 6572.047053177358, 6599.934000660028, 6251.562390632612, 6264.874702506016, 6275.592086514362, 6308.905366419599, 6383.39357761012, 6560.44236239925, 6601.702923368556, 6605.0, 6605.933940660724, 6613.702383392662, 6333.936660633335, 6367.87264254703, 6377.394147555975, 6384.233891932998, 6391.0, 6261.906071409024, 6263.843403914939, 6297.779577714758, 6311.715972781144, 6346.270178929298, 6207.906881396873, 6314.179156709598, 6339.587926784744, 6343.492520598434, 6347.619142851444, 5393.217983392465, 6281.183446151971, 6299.716512756845, 6299.779507717208, 6341.55609107358, 4859.927101093415, 6001.399860013964, 6001.789937352171, 6009.54928380382, 6115.357887421935, 6111.908321375272, 6251.062340648939, 6267.091271765659, 6277.811665650038, 6284.811455656338, 6065.5754097212775, 6106.642687876592, 6170.907436388368, 6209.006558950727, 6210.534209934182], "value": 5782.96597948661, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [494.3449928844281, 495.21013982697605, 498.3222816968924, 507.8730317420645, 568.8919105369977, 40196.799016004916, 43135.137297254114, 43185.0, 43265.99999999996, 43275.0, 42361.57638423615, 44120.55879441205, 44839.77580112103, 44947.55052449483, 45034.0993180137, 9606.471644059575, 9697.903020969807, 9837.213022958145, 9857.162141218005, 9864.654737084167, 9526.42841429513, 9613.423194608311, 9645.903540964606, 9660.806783864318, 9692.709218723414, 9620.56707448163, 9629.614815407374, 9651.903480965206, 9676.903230967706, 9688.70933871985, 9544.42733435996, 9588.616455341778, 9646.083622055894, 9684.709458716214, 9696.612135514571, 9656.75858103553, 9662.9516852416, 9730.854037189449, 9755.219582433388, 9818.361806482628, 39988.40017399741, 40052.0, 40845.0, 41327.58672413268, 41387.37918931218, 2787.2753084198052, 3070.8925187618324, 3159.4628913084603, 3359.7648164628486, 3389.4915762635555, 23905.760942390527, 26931.865340673172, 27348.72651273482, 29133.41733165346, 29671.851640741657, 2669.8798554065115, 2680.1423544465583, 2705.580635001578, 2768.1557125076843, 2780.9165725028283, 424131.8793406044, 425169.0, 426304.86847565876, 428295.0, 428771.0, 34407.967760967214, 35175.82412087923, 35245.82377088149, 35358.93923182309, 35369.46945795764, 36101.0, 37415.4387684185, 37446.5021399141, 37487.81256093702, 37530.06174845651, 13780.690834370718, 14885.851141488663, 15396.230188490754, 15569.377224910877, 15579.376824926876, 12992.610221693176, 13015.284159371326, 13056.412461439259, 13117.475300987853, 13119.409626566827, 8156.0, 8183.14077021916, 8197.79505512367, 8200.58997050145, 8264.338852891755, 2836.8865245390366, 3338.115399419156, 3343.632200457948, 3353.614334351532, 3381.289929114864, 880.3793325705362, 914.29599208609, 1013.8225810483136, 1045.46158728255, 1060.5068643081004, 24115.757233578075, 28215.71784282172, 29900.252493687833, 30993.69006309908, 31006.0, 838.5471845203522, 982.7297493189287, 1051.6476980211562, 1060.6446840308583, 1065.0361422912276, 12784.0, 15630.531084067496, 15683.764743528856, 15720.0, 16090.034597924163, 683718.0, 689439.0, 698428.0, 704673.0, 707555.0, 62752.37247627465, 63155.0, 64023.0, 64491.67754161199, 64592.0, 1425.4013314407973, 1429.0925262458206, 1453.4258967707697, 1453.6365908522869, 1457.8469260727684, 23840.761592383853, 29481.820727170674, 29538.556921645762, 30210.84894575513, 30533.847330763205, 54996.725016374665, 55181.724091379285, 55276.0, 55461.7226913879, 55633.72183139058, 618768.0, 618878.0, 619722.0, 620085.0, 622576.0, 27035.72964270332, 27110.0, 27470.90116395322, 27853.303667408476, 27918.0, 46848.531514684415, 47836.5216347846, 48062.5193748058, 48381.0, 48724.26913596228, 34315.65684343124, 38960.0, 39445.01387465336, 40023.39964900471, 40325.0, 37666.0, 38139.046523837125, 38267.808660956514, 38808.80595597117, 39109.8044509787, 37080.62919370772, 38178.0455488615, 38595.03512412212, 39129.41305880357, 39336.6066339333, 32555.511667324536, 33881.49177762286, 34545.82727086348, 34782.47826282658, 34825.0, 20489.69265461049, 24028.75971240265, 24697.012119515017, 25379.873100634377, 25682.295311406877], "value": 18464.95414182527, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [381.6679488844704, 387.27772703907215, 387.5001248389577, 397.5170168245581, 402.7724335750301, 15948.521544353658, 21578.0, 21971.618836213755, 22050.669239961415, 22196.334109976706, 20643.690344644805, 21024.0, 21613.811240381772, 21836.8908155459, 21843.890780546113, 5576.1356989666465, 5802.274715660532, 5948.1375200595885, 5965.970170149165, 6019.939800602004, 3882.1265215326466, 5911.970440147815, 7389.5935723535185, 7801.3758899288205, 7839.764807055797, 7634.732784352549, 7818.179091195428, 7918.326942209919, 7958.840823183562, 7961.761147165595, 7010.614416207107, 7610.581418022007, 7753.651085701157, 7903.367730581568, 7946.483478573903, 7670.156282808886, 7690.500117492345, 7690.5770182639935, 7708.537487750753, 7723.497972631761, 28089.0, 28404.058579497218, 28832.0, 29008.27479313013, 29666.258343541584, 2166.880821554814, 2290.988545057264, 2317.381855795196, 2330.4523436992463, 2519.48350588129, 11760.882391176065, 13297.734045319135, 16629.085400302978, 16670.33318667252, 16945.83054169467, 1844.769403824522, 1904.838088762457, 1917.8465722742146, 1957.1388589020785, 1958.3831093205595, 113530.0, 147987.26006370006, 153197.0, 154637.22681386635, 156580.0, 21271.36185914425, 21802.672959905613, 21807.127714891543, 21904.89047554752, 22045.89770511468, 28161.155165345073, 35362.0, 35471.29057418889, 35500.64499355025, 36163.095922602144, 9117.863232051524, 10928.890711092787, 11300.717482063013, 11325.830112548318, 11343.262687925258, 9254.0, 9282.21101206405, 9307.11582399671, 9365.438073715599, 9401.153896149379, 9003.14470125337, 9775.51122443875, 9818.65634702782, 9953.601855925826, 10039.849402258971, 3668.724845636588, 3682.705383569308, 3741.494898188764, 3916.4712763777097, 4068.613481719232, 847.5931552854664, 883.3551507399505, 937.3953799799227, 959.8800149981253, 1007.9042490963493, 13813.930930345485, 20491.69262461064, 21136.78863211379, 21238.89380553087, 21629.891850540647, 902.3142411767104, 935.5369092299355, 982.189693502863, 987.9626392288212, 1001.6594357918198, 10067.798644027078, 10149.731283589552, 11162.944185279022, 11306.321620702784, 11336.26314289585, 603834.0, 606278.0, 614180.0, 617352.0, 618191.0, 102041.95916081636, 129357.0, 134423.0, 134855.0, 135827.32086339506, 988.6490295944836, 1009.9192064634811, 1022.4734261855002, 1025.3181634213313, 1028.6348346337093, 18948.810511895255, 19198.232070717015, 19306.0, 19310.903445482683, 19317.90341048342, 54788.0, 55488.72255638696, 56030.87938241294, 56123.43876561346, 56149.71925140348, 64925.026124607226, 78279.0, 79725.60137199509, 79890.6005469969, 79999.20000799917, 6446.871797435524, 7241.312075352833, 8025.839483210187, 8077.596120193849, 8216.507009579444, 9192.448453092837, 10217.284790064625, 11948.445943586014, 12104.394780260776, 12547.0, 10540.367577945348, 10677.878822723813, 10758.569657213624, 10821.9458902705, 10856.565737370416, 10463.68608941733, 10659.040686338267, 10876.45617719095, 11087.72280692989, 11088.279261847954, 8976.28189744832, 10720.624778132727, 10933.781324373627, 11123.549460764329, 11406.885931140914, 7962.331321287687, 8044.127786715613, 8185.590720463834, 8220.958895205726, 8350.03974542911, 7943.126256111938, 9658.227341812779, 10625.25623206368, 11083.667489975314, 11093.611723589636], "value": 10943.98323462582, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1544.4208421841813, 1584.3741722019802, 1780.9643807123857, 1878.755761750973, 1906.1708156951718, 8014.679412823494, 8677.219050285474, 8693.913060869389, 9207.217386522145, 9247.029061948491, 8757.0, 8834.646614135427, 8995.820083598324, 9005.054469280713, 9024.593893274801, 2372.632242002484, 2402.2673084709245, 2412.3245491262387, 2412.8793560322, 2418.6734790803193, 2371.3715865295712, 2390.8087353011715, 2416.794572461343, 2419.0928401849305, 2421.309926670899, 2302.666113413554, 2308.3305841306, 2367.822413319008, 2420.9152679656218, 2422.8546287222734, 2362.492064206195, 2367.360812580611, 2372.1341710275797, 2374.536965291769, 2389.8207634427313, 2358.6697862299293, 2363.491849252419, 2369.5024044950583, 2369.5142495788323, 2372.466195106105, 8768.210861022539, 8817.29461643067, 8827.249683776887, 8938.46369217849, 9056.094390560957, 4566.4520257568975, 5284.603654725911, 5382.138857782736, 5472.20653005312, 5487.6158668893195, 2888.436754832808, 3555.4489054196642, 3595.1731101846462, 3603.3153700796765, 3611.1513794258326, 862.8791969124328, 901.2069378946551, 1025.0825511167463, 1038.4859494550171, 1039.9220058495644, 11373.0, 11554.826677599844, 11668.35824029678, 11857.822132668018, 11911.285322880654, 3862.3240932836643, 4504.572065653758, 4527.275635898306, 4624.167649822997, 4665.346851440801, 8351.997760268685, 8922.598483068148, 9278.62885484573, 9362.34463587556, 9377.671781487616, 5204.479552044841, 5211.843644690665, 5234.9476505235225, 5278.788848446019, 5293.523582877559, 4387.5393083726385, 4741.976290118528, 4857.1742803723455, 4901.142300097468, 4907.607391408679, 3805.657490825839, 3846.4038074098557, 3917.216556688674, 3927.9018024549046, 3952.2885880541203, 999.3903718731714, 1203.8013727734826, 1208.3535308610028, 1213.7936550786387, 1216.0514798457218, 902.5171533229822, 909.1499448016126, 910.5083255042335, 944.4663764972769, 944.9055094490633, 5764.625299355528, 5980.641161530322, 6025.969870150621, 6036.366181550961, 6077.969610152009, 442.6105027575713, 448.0680185214745, 449.5751514818465, 460.07754452322877, 467.07052964600877, 3908.8241029153755, 3996.5603783583783, 4047.2310261050307, 4088.9591104089172, 4109.993051702352, 10222.795544089076, 10696.609440772805, 10893.965073318022, 10908.836367454494, 10937.617183398543, 10427.68716938493, 10644.467776611138, 10658.733531661615, 10777.515011824487, 10888.67333979966, 6879.862402752017, 8342.207490288412, 8353.164683531599, 8354.45696029756, 8356.832863342821, 5769.134629805562, 5863.501602363847, 5873.559483038704, 5951.0, 6012.819615411545, 9583.089606487372, 9924.751881203028, 10003.749906252402, 10209.0, 10212.387256764618, 10180.389176649425, 10211.183105351405, 10221.386716797017, 10223.386596804216, 10396.376217426978, 6962.373386395248, 7413.8146546336775, 7637.6563054661565, 7647.655855486405, 7797.454178207471, 7045.788626341218, 8453.154684531744, 8525.701600444203, 8542.572871356531, 8547.700830470903, 7406.07424071991, 7561.0, 7584.317411432998, 7599.696012159452, 7605.771826845204, 6978.930210698031, 7019.017337572846, 7060.3292687194635, 7083.150021997393, 7110.4667149962925, 7007.0, 7098.467614928798, 7113.146422429341, 7116.964415177891, 7121.465890058163, 4856.0, 4864.708117512961, 4882.780274887709, 4958.72727000004, 5119.283300337881, 4875.341828853059, 4920.704757714549, 4968.8757781055765, 5036.622253330942, 5203.11547036997], "value": 4480.730269858389, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [265.45978932871606, 305.1638510481282, 320.37207074134693, 321.9790713603614, 324.592636241517, 5292.491639882634, 5326.946730532693, 5471.701885208212, 5516.475934786199, 5537.197106419571, 4341.848035318764, 4716.080364328957, 5145.6398052136365, 5244.68531888086, 5442.727863606824, 4139.296319625656, 4145.730527515717, 4184.979075104636, 4194.97902510487, 4205.831766729327, 3319.68462996015, 3350.5476760637366, 4183.728057676241, 4217.85237516687, 4250.808713607879, 3727.378590313209, 4105.630493255607, 4129.669626429878, 4161.459010328653, 4167.791610419482, 3456.7061799747053, 4152.16956608678, 4158.625723684883, 4164.895877603054, 4199.118185181115, 3022.7732920031085, 3458.515807786912, 3604.6936010439144, 3624.710023198164, 3632.8365223565, 4122.216778812046, 4181.456410666624, 4398.582134697199, 4570.977145114253, 5029.647924645276, 3847.7306588538813, 3885.533735951704, 4502.527234640381, 4728.574428301469, 4854.344663470457, 5199.1161502544655, 5414.025475414423, 5545.805896793593, 5659.349174844863, 5734.311882574076, 3543.4684797280356, 3711.31340701971, 3952.636340462536, 3956.584558621361, 3956.8219430125714, 5522.972385138049, 5983.055506960255, 5984.192134061933, 5993.280806303228, 6071.878562428727, 3352.580927384077, 3480.443129099332, 3579.427291633326, 4003.799810009488, 4052.062254865258, 3612.8916132516065, 3792.8052663410936, 3984.6812255019527, 4079.265732168238, 4096.160287141129, 4672.088942656217, 4690.695104818176, 4697.600703940203, 4726.983698504838, 4728.810847566127, 5048.611631801284, 5772.769089236467, 5778.595498315161, 5821.388754180834, 5839.160664390788, 1327.6946302350514, 1414.2575148047358, 1418.5744276716944, 1425.5153247895764, 1430.4278288684402, 754.5925200391837, 826.4098660021415, 864.1703964194318, 869.6477926439676, 871.329076611006, 3857.5949525300002, 3968.047668559525, 4000.579939106352, 4227.964148783506, 4337.934930975975, 4374.993751437188, 4419.983403817076, 4639.628829693616, 4675.392199014106, 4982.878852258285, 4095.685937445334, 4319.503257125408, 4337.436133302651, 4553.317002449659, 4619.330197121399, 2567.8459292442512, 2646.801489888266, 2733.562629979194, 2843.7203258533327, 3030.9393812124076, 4880.877978050577, 5215.634905556651, 5712.428757124338, 6274.717637706314, 6276.497880169575, 4987.077390682735, 5905.261842269716, 6079.6960151992225, 6111.786087486917, 6133.26400831903, 5587.664740115606, 5648.345277719465, 5832.83343331327, 6082.175347395675, 6259.374062593704, 5958.404159584007, 5959.940400595939, 5971.970140149445, 5978.312494063064, 5991.460768530853, 4495.617872480876, 4978.626603004716, 5541.9168712470155, 5855.2095467113095, 5886.499647529837, 5300.70846103468, 6103.0, 6193.314977588328, 6207.306652541731, 6218.968905155626, 3748.7001039917286, 3768.924621507609, 3906.6326785624806, 3940.9211815764097, 3947.2697550952016, 5083.694978301166, 5438.993786149575, 5625.0, 5767.884642307046, 5774.624649397776, 5121.948780512296, 5755.309362876482, 5880.470757631833, 5899.528037756883, 5950.196723442453, 5379.327584051994, 5841.211436456024, 5860.912086318794, 5886.823395298148, 5894.469497745224, 5522.447755224445, 5655.151727240782, 5675.013745189316, 5682.374938756816, 5713.285839270091, 4847.521505940581, 5801.158831969256, 5826.0, 5840.729191652688, 5843.328017277898, 5130.6152038598, 5365.275687782099, 5714.657120572779, 5744.827655170351, 5771.0189267823735], "value": 4070.875126847819, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [640.9294977552469, 667.9064930909674, 703.7466512055662, 719.5934297122126, 734.6951015328639, 14680.632984175387, 14686.559403217894, 15120.546383608496, 15248.618784530392, 15323.846761532368, 13929.791053134186, 14021.509247176351, 14093.506727264548, 14110.365033573487, 14121.29393530322, 637.9968100159516, 723.4935545118412, 904.1817155474273, 906.755176102452, 910.2672348759246, 886.0873300500463, 909.8589718593629, 910.8770316007353, 914.1589737441536, 918.2470374293082, 957.2294303086013, 961.8797650293714, 965.2808657550135, 965.7247684409945, 966.1208300446596, 953.41365060488, 955.4171955107414, 959.750464879133, 960.1790469148847, 962.0619895601802, 674.0563211503885, 712.5831388637653, 712.7220384050224, 714.3606472207346, 714.6319645382632, 14040.297985100704, 14487.710245795026, 14536.636584085376, 14552.781708274384, 14587.489437869624, 12316.384180790925, 12403.875961240363, 12416.379181040911, 12527.74944501114, 12665.620031399072, 9817.607295708163, 9836.213102951746, 10160.441175735332, 10346.844797328045, 10368.688939331832, 3442.535257740223, 3447.224374515714, 3450.7756995795194, 3472.0, 3581.086822860154, 76155.6192219041, 76456.61771691106, 79754.20245797584, 80172.5991370051, 81055.7841632376, 9207.63169473227, 9384.67153649619, 9386.906130938603, 9669.806603868024, 9670.90329096714, 20192.596148076955, 20421.79578204199, 20431.182752690023, 21208.89395553043, 21538.676919846213, 6119.2350956130485, 7191.568505889663, 7226.819329516699, 7349.154847192534, 7471.327580517779, 3854.0750219947013, 3935.9212815743526, 3943.3099207638547, 3948.8420463181724, 3949.842006319715, 3439.7592168547963, 3574.8033858137533, 3578.5169002184894, 3579.6420357964516, 3580.1407662160896, 638.6487431912429, 643.1735220241967, 648.2124219073847, 653.0237295243546, 653.0856800479272, 511.43290416579555, 516.6693316277585, 594.4887396838715, 610.0665981049002, 630.3570358234575, 8080.474769139987, 8112.797180070545, 8119.147489513634, 8247.051589067214, 8248.711295104762, 506.6959824105507, 540.8701911541202, 547.819219657512, 604.7529025169983, 609.5763444406095, 3591.964080359163, 3703.925921481555, 3869.787161706077, 3970.8808735737975, 4040.454538637305, 93936.0, 94924.30454172633, 96608.55087173698, 97456.02543974611, 99964.50017749864, 80856.59571702103, 84843.5757821207, 84886.575567123, 85624.0, 85648.57175714082, 59293.0, 75735.24264757392, 75859.0, 76382.70851874453, 77137.0, 7675.577843218676, 7952.52284862887, 8109.59452027408, 8197.221263979913, 8247.257746802816, 31054.0, 37918.62081379151, 40441.98895027648, 40625.59374406218, 44341.77829110834, 58654.0, 59451.40548594459, 59540.427574345675, 59892.70053649704, 60231.69884150726, 9311.0, 10818.188635852186, 11007.779844402907, 11056.613018544313, 11420.771584568429, 11898.821517677068, 11970.22193557416, 12023.63929082129, 12041.397930103634, 12289.38553072325, 11294.378809165575, 11364.374959376983, 11499.367534785668, 11662.53349865996, 11760.235584686969, 11305.321680699184, 11306.152038597302, 11489.885101148882, 11549.538018479503, 11841.230320029515, 11333.829992550283, 11338.0, 11509.94245028803, 11628.360440175871, 11972.0, 9637.325387223107, 9900.009999000042, 9971.351862128939, 10053.798924021332, 10058.195344372287, 9637.662681806103, 9815.950920245354, 9833.030547538998, 9865.013498650078, 9871.439173943216], "value": 6803.904203814252, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1622.4999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 111.0, 114.0, 115.0, 115.0, 115.0, 113.0, 113.0, 116.0, 113.0], "value": 114.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 120.0, 155.0, 201.0, 118.0, 140.0, 137.0, 121.0, 164.0, 121.0], "value": 142.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [200.0, 196.0, 198.0, 202.0, 261.0, 263.0, 226.0, 198.0, 193.0, 198.0], "value": 213.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 82.0, 75.0, 144.0, 59.0, 57.0, 59.0, 60.0, 131.0, 84.0], "value": 81.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 101.0, 171.0, 101.0, 81.0, 74.0, 114.0, 72.0, 73.0, 116.0], "value": 98.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 86.0, 88.0, 86.0, 92.0, 87.0, 91.0, 102.0, 131.0, 129.0], "value": 98.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 116.0, 126.0, 94.0, 125.0, 148.0, 96.0, 95.0, 96.0], "value": 108.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 151.0, 142.0, 91.0, 91.0, 97.0, 93.0, 99.0, 144.0, 150.0], "value": 113.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 78.0, 50.0, 48.0, 74.0, 77.0, 77.0, 93.0, 93.0, 76.0], "value": 72.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 71.0, 67.0, 84.0, 120.0, 91.0, 69.0, 78.0, 104.0, 105.0], "value": 85.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 85.0, 87.0, 88.0, 83.0, 87.0, 77.0, 98.0, 73.0, 78.0], "value": 84.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 144.0, 155.0, 145.0, 138.0, 147.0, 138.0, 161.0, 188.0, 163.0], "value": 151.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 162.0, 165.0, 198.0, 232.0, 163.0, 170.0, 199.0, 224.0, 226.0], "value": 190.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 66.0, 67.0, 67.0, 67.0, 66.0, 66.0, 65.0, 69.0, 67.0], "value": 66.8, "unit": "score"}]}]} 05:58:34 INFO - Return code: 0 05:58:34 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 05:58:34 ERROR - # TBPL SUCCESS # 05:58:34 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:58:34 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:58:34 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:58:34 INFO - 2016-05-25 05:58:34.515 screenresolution[2012:16569] starting screenresolution argv=screenresolution get 05:58:34 INFO - 2016-05-25 05:58:34.518 screenresolution[2012:16569] Display 0: 1600x1200x32@60 05:58:34 INFO - 2016-05-25 05:58:34.524 screenresolution[2013:16572] starting screenresolution argv=screenresolution list 05:58:34 INFO - Available Modes on Display 0 05:58:34 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:58:34 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:58:34 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:58:34 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:58:34 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:58:34 INFO - Intel Iris: 05:58:34 INFO - Chipset Model: Intel Iris 05:58:34 INFO - Type: GPU 05:58:34 INFO - Bus: Built-In 05:58:34 INFO - VRAM (Dynamic, Max): 1536 MB 05:58:34 INFO - Vendor: Intel (0x8086) 05:58:34 INFO - Device ID: 0x0a2e 05:58:34 INFO - Revision ID: 0x0009 05:58:34 INFO - Displays: 05:58:34 INFO - Display: 05:58:34 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:58:34 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:58:34 INFO - Display Serial Number: 1600x1200 60 05:58:34 INFO - Main Display: Yes 05:58:34 INFO - Mirror: Off 05:58:34 INFO - Online: Yes 05:58:34 INFO - Rotation: Supported 05:58:34 INFO - Return code: 0 05:58:34 INFO - Running post-action listener: _resource_record_post_action 05:58:34 INFO - ##### 05:58:34 INFO - ##### Finished run-tests step (success) 05:58:34 INFO - ##### 05:58:34 INFO - Running post-run listener: _resource_record_post_run 05:58:34 INFO - Total resource usage - Wall time: 1209s; CPU: 54.0%; Read bytes: 750080; Write bytes: 697744384; Read time: 9; Write time: 1848 05:58:34 INFO - TinderboxPrint: CPU usage
54.4% 05:58:34 INFO - TinderboxPrint: I/O read bytes / time
750,080 / 9 05:58:34 INFO - TinderboxPrint: I/O write bytes / time
697,744,384 / 1,848 05:58:34 INFO - TinderboxPrint: CPU idle
2,206.5 (45.6%) 05:58:34 INFO - TinderboxPrint: CPU system
977.6 (20.2%) 05:58:34 INFO - TinderboxPrint: CPU user
1,653.6 (34.2%) 05:58:34 INFO - TinderboxPrint: Swap in / out
397,234,176 / 0 05:58:34 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 394498560; Write bytes: 389281280; Read time: 29534; Write time: 702 05:58:34 INFO - run-tests - Wall time: 1176s; CPU: 54.0%; Read bytes: 750080; Write bytes: 297371136; Read time: 9; Write time: 1112 05:58:35 INFO - Running post-run listener: _upload_blobber_files 05:58:35 INFO - Blob upload gear active. 05:58:35 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:58:35 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 05:58:35 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'] 05:58:35 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 05:58:35 INFO - (blobuploader) - INFO - Open directory for files ... 05:58:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:58:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:58:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:58:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:58:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:58:36 INFO - (blobuploader) - INFO - Done attempting. 05:58:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:58:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:58:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:58:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:58:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:58:37 INFO - (blobuploader) - INFO - Done attempting. 05:58:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:58:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:58:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:58:39 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:58:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:58:39 INFO - (blobuploader) - INFO - Done attempting. 05:58:39 INFO - (blobuploader) - INFO - Iteration through files over. 05:58:39 INFO - Return code: 0 05:58:39 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:58:39 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:58:39 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7b19a8e3f982858c45d4660c32687d9588e0d4d2c6b13426e07caf2e9da245238936a33c4e2e3bc25da07a91c3a3b87c8872c43eaf5a0e035b869b111cb2b46a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8629b41b713038e667231575aa990cb494fb13d8265d747f22525d964ba5b9eb3cc5ef59a75a9010379c700dc54dafbe93b8b55f40eda81e0cd7e5a8d87ac86b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ce6fe27e320c711e6917943ae1eb8a5e2f5bf5d1ab7da71261b9e1f0da7c95884b769d3fea7b39d799f195da2f8127ef7ac11434ae1200e0ac390c0546fa1f76"} 05:58:39 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:58:39 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:58:39 INFO - Contents: 05:58:39 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7b19a8e3f982858c45d4660c32687d9588e0d4d2c6b13426e07caf2e9da245238936a33c4e2e3bc25da07a91c3a3b87c8872c43eaf5a0e035b869b111cb2b46a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8629b41b713038e667231575aa990cb494fb13d8265d747f22525d964ba5b9eb3cc5ef59a75a9010379c700dc54dafbe93b8b55f40eda81e0cd7e5a8d87ac86b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ce6fe27e320c711e6917943ae1eb8a5e2f5bf5d1ab7da71261b9e1f0da7c95884b769d3fea7b39d799f195da2f8127ef7ac11434ae1200e0ac390c0546fa1f76"} 05:58:39 INFO - Running post-run listener: copy_logs_to_upload_dir 05:58:39 INFO - Copying logs to upload dir... 05:58:39 INFO - mkdir: /builds/slave/test/build/upload/logs 05:58:39 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1265.648153 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2016-05-25 05:58:40.271596) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-25 05:58:40.275158) ========= 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.RyaXNb7EQn/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.LN64wk4KyS/Listeners TMPDIR=/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/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/7b19a8e3f982858c45d4660c32687d9588e0d4d2c6b13426e07caf2e9da245238936a33c4e2e3bc25da07a91c3a3b87c8872c43eaf5a0e035b869b111cb2b46a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8629b41b713038e667231575aa990cb494fb13d8265d747f22525d964ba5b9eb3cc5ef59a75a9010379c700dc54dafbe93b8b55f40eda81e0cd7e5a8d87ac86b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ce6fe27e320c711e6917943ae1eb8a5e2f5bf5d1ab7da71261b9e1f0da7c95884b769d3fea7b39d799f195da2f8127ef7ac11434ae1200e0ac390c0546fa1f76"} build_url:https://queue.taskcluster.net/v1/task/E-BVgxdjTFGG_0n4iN9GSA/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011179 build_url: 'https://queue.taskcluster.net/v1/task/E-BVgxdjTFGG_0n4iN9GSA/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/7b19a8e3f982858c45d4660c32687d9588e0d4d2c6b13426e07caf2e9da245238936a33c4e2e3bc25da07a91c3a3b87c8872c43eaf5a0e035b869b111cb2b46a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8629b41b713038e667231575aa990cb494fb13d8265d747f22525d964ba5b9eb3cc5ef59a75a9010379c700dc54dafbe93b8b55f40eda81e0cd7e5a8d87ac86b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ce6fe27e320c711e6917943ae1eb8a5e2f5bf5d1ab7da71261b9e1f0da7c95884b769d3fea7b39d799f195da2f8127ef7ac11434ae1200e0ac390c0546fa1f76"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-25 05:58:40.305721) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-25 05:58:40.306055) ========= 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.RyaXNb7EQn/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.LN64wk4KyS/Listeners TMPDIR=/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/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.005326 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-25 05:58:40.354826) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-25 05:58:40.355163) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-25 05:58:40.355563) ========= ========= Total master_lag: 0.26 =========