builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0029 starttime: 1463395288.63 results: success (0) buildid: 20160516005330 builduid: 30d637ae4bc34eb8b56efb33dbcb1da8 revision: 0c29ad917ac38c9ef26c9ff0b5d9762e75d13948 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-16 03:41:28.634989) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-16 03:41:28.635544) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-16 03:41:28.639919) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-16 03:41:28.667440) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-16 03:41:28.667706) ========= 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.SDaouneQmS/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.w30csLZLh2/Listeners TMPDIR=/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-05-16 03:41:28-- 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% 165M=0s 2016-05-16 03:41:28 (165 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.156150 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-16 03:41:28.843734) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-16 03:41:28.844029) ========= 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.SDaouneQmS/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.w30csLZLh2/Listeners TMPDIR=/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/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.025819 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-16 03:41:28.894191) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-16 03:41:28.894526) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 0c29ad917ac38c9ef26c9ff0b5d9762e75d13948 --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 0c29ad917ac38c9ef26c9ff0b5d9762e75d13948 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.SDaouneQmS/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.w30csLZLh2/Listeners TMPDIR=/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-05-16 03:41:28,967 truncating revision to first 12 chars 2016-05-16 03:41:28,967 Setting DEBUG logging. 2016-05-16 03:41:28,967 attempt 1/10 2016-05-16 03:41:28,967 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/0c29ad917ac3?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-16 03:41:30,232 unpacking tar archive at: fx-team-0c29ad917ac3/testing/mozharness/ program finished with exit code 0 elapsedTime=1.509967 ========= master_lag: 0.12 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-16 03:41:30.523201) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-16 03:41:30.523765) ========= script_repo_revision: 0c29ad917ac38c9ef26c9ff0b5d9762e75d13948 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-16 03:41:30.524440) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-16 03:41:30.524914) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-16 03:41:30.550235) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 40 secs) (at 2016-05-16 03:41:30.550518) ========= /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.SDaouneQmS/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.w30csLZLh2/Listeners TMPDIR=/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/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 03:41:30 INFO - MultiFileLogger online at 20160516 03:41:30 in /builds/slave/test 03:41:30 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 03:41:30 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:41:30 INFO - {'append_to_log': False, 03:41:30 INFO - 'base_work_dir': '/builds/slave/test', 03:41:30 INFO - 'blob_upload_branch': 'Fx-Team', 03:41:30 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:41:30 INFO - 'branch': 'Fx-Team', 03:41:30 INFO - 'buildbot_json_path': 'buildprops.json', 03:41:30 INFO - 'config_files': ('talos/mac_config.py',), 03:41:30 INFO - 'default_actions': ('clobber', 03:41:30 INFO - 'read-buildbot-config', 03:41:30 INFO - 'download-and-extract', 03:41:30 INFO - 'populate-webroot', 03:41:30 INFO - 'create-virtualenv', 03:41:30 INFO - 'install', 03:41:30 INFO - 'run-tests'), 03:41:30 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:41:30 INFO - 'download_minidump_stackwalk': True, 03:41:30 INFO - 'download_symbols': 'ondemand', 03:41:30 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:41:30 INFO - 'tooltool.py': '/tools/tooltool.py', 03:41:30 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:41:30 INFO - '/tools/misc-python/virtualenv.py')}, 03:41:30 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:41:30 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:41:30 INFO - 'installer_path': 'installer.exe', 03:41:30 INFO - 'log_level': 'info', 03:41:30 INFO - 'log_name': 'talos', 03:41:30 INFO - 'log_to_console': True, 03:41:30 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 03:41:30 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 03:41:30 INFO - 'opt_config_files': (), 03:41:30 INFO - 'pip_index': False, 03:41:30 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:41:30 INFO - 'cmd': ('bash', 03:41:30 INFO - '-c', 03:41:30 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:41:30 INFO - 'enabled': True, 03:41:30 INFO - 'halt_on_failure': False, 03:41:30 INFO - 'name': 'check_screen_resolution'},), 03:41:30 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:41:30 INFO - 'cmd': ('bash', 03:41:30 INFO - '-c', 03:41:30 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:41:30 INFO - 'enabled': True, 03:41:30 INFO - 'halt_on_failure': False, 03:41:30 INFO - 'name': 'check_screen_resolution'},), 03:41:30 INFO - 'run_cmd_checks_enabled': True, 03:41:30 INFO - 'sps_profile': False, 03:41:30 INFO - 'sps_profile_interval': 0, 03:41:30 INFO - 'suite': 'dromaeojs-e10s', 03:41:30 INFO - 'system_bits': '32', 03:41:30 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:41:30 INFO - 'title': 't-yosemite-r7-0029', 03:41:30 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:41:30 INFO - 'use_talos_json': True, 03:41:30 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:41:30 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:41:30 INFO - 'work_dir': 'build'} 03:41:30 INFO - ##### 03:41:30 INFO - ##### Running clobber step. 03:41:30 INFO - ##### 03:41:30 INFO - Running pre-action listener: _resource_record_pre_action 03:41:30 INFO - Running main action method: clobber 03:41:30 INFO - rmtree: /builds/slave/test/build 03:41:30 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:41:32 INFO - Running post-action listener: _resource_record_post_action 03:41:32 INFO - ##### 03:41:32 INFO - ##### Finished clobber step (success) 03:41:32 INFO - ##### 03:41:32 INFO - ##### 03:41:32 INFO - ##### Running read-buildbot-config step. 03:41:32 INFO - ##### 03:41:32 INFO - Running pre-action listener: _resource_record_pre_action 03:41:32 INFO - Running main action method: read_buildbot_config 03:41:32 INFO - Using buildbot properties: 03:41:32 INFO - { 03:41:32 INFO - "project": "", 03:41:32 INFO - "product": "firefox", 03:41:32 INFO - "script_repo_revision": "production", 03:41:32 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 03:41:32 INFO - "repository": "", 03:41:32 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 03:41:32 INFO - "buildid": "20160516005330", 03:41:32 INFO - "pgo_build": "False", 03:41:32 INFO - "basedir": "/builds/slave/test", 03:41:32 INFO - "buildnumber": 668, 03:41:32 INFO - "slavename": "t-yosemite-r7-0029", 03:41:32 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 03:41:32 INFO - "platform": "yosemite_r7", 03:41:32 INFO - "scheduler": "tests-fx-team-macosx64-talos-7-3600", 03:41:32 INFO - "branch": "fx-team", 03:41:32 INFO - "repo_path": "integration/fx-team", 03:41:32 INFO - "revision": "0c29ad917ac38c9ef26c9ff0b5d9762e75d13948", 03:41:32 INFO - "stage_platform": "macosx64", 03:41:32 INFO - "builduid": "30d637ae4bc34eb8b56efb33dbcb1da8", 03:41:32 INFO - "slavebuilddir": "test" 03:41:32 INFO - } 03:41:32 INFO - Found installer url https://queue.taskcluster.net/v1/task/RIdxSdjrQnq14tOfB86CoA/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg. 03:41:32 INFO - Running post-action listener: _resource_record_post_action 03:41:32 INFO - ##### 03:41:32 INFO - ##### Finished read-buildbot-config step (success) 03:41:32 INFO - ##### 03:41:32 INFO - ##### 03:41:32 INFO - ##### Running download-and-extract step. 03:41:32 INFO - ##### 03:41:32 INFO - Running pre-action listener: _resource_record_pre_action 03:41:32 INFO - Running main action method: download_and_extract 03:41:32 INFO - mkdir: /builds/slave/test/build/tests 03:41:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:41:32 INFO - https://queue.taskcluster.net/v1/task/RIdxSdjrQnq14tOfB86CoA/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 03:41:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RIdxSdjrQnq14tOfB86CoA/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json 03:41:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RIdxSdjrQnq14tOfB86CoA/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json 03:41:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RIdxSdjrQnq14tOfB86CoA/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 03:41:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RIdxSdjrQnq14tOfB86CoA/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 03:42:02 INFO - Downloaded 1199 bytes. 03:42:02 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.mac.test_packages.json 03:42:02 INFO - Using the following test package requirements: 03:42:02 INFO - {u'common': [u'firefox-49.0a1.en-US.mac.common.tests.zip'], 03:42:02 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 03:42:02 INFO - u'firefox-49.0a1.en-US.mac.cppunittest.tests.zip'], 03:42:02 INFO - u'gtest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 03:42:02 INFO - u'firefox-49.0a1.en-US.mac.gtest.tests.zip'], 03:42:02 INFO - u'jittest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 03:42:02 INFO - u'jsshell-mac.zip'], 03:42:02 INFO - u'mochitest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 03:42:02 INFO - u'firefox-49.0a1.en-US.mac.mochitest.tests.zip'], 03:42:02 INFO - u'mozbase': [u'firefox-49.0a1.en-US.mac.common.tests.zip'], 03:42:02 INFO - u'reftest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 03:42:02 INFO - u'firefox-49.0a1.en-US.mac.reftest.tests.zip'], 03:42:02 INFO - u'talos': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 03:42:02 INFO - u'firefox-49.0a1.en-US.mac.talos.tests.zip'], 03:42:02 INFO - u'web-platform': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 03:42:02 INFO - u'firefox-49.0a1.en-US.mac.web-platform.tests.zip'], 03:42:02 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 03:42:02 INFO - u'firefox-49.0a1.en-US.mac.xpcshell.tests.zip']} 03:42:02 INFO - Downloading packages: [u'firefox-49.0a1.en-US.mac.common.tests.zip'] for test suite category: common 03:42: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')]} 03:42:02 INFO - https://queue.taskcluster.net/v1/task/RIdxSdjrQnq14tOfB86CoA/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 03:42:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RIdxSdjrQnq14tOfB86CoA/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 03:42:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RIdxSdjrQnq14tOfB86CoA/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 03:42:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RIdxSdjrQnq14tOfB86CoA/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 03:42:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RIdxSdjrQnq14tOfB86CoA/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 03:42:03 INFO - Downloaded 18267733 bytes. 03:42:03 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'] 03:42:03 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 03:42:06 INFO - Return code: 0 03:42:06 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 03:42:06 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')]} 03:42:06 INFO - https://queue.taskcluster.net/v1/task/RIdxSdjrQnq14tOfB86CoA/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 03:42:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RIdxSdjrQnq14tOfB86CoA/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 03:42:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RIdxSdjrQnq14tOfB86CoA/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 03:42:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RIdxSdjrQnq14tOfB86CoA/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 03:42:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RIdxSdjrQnq14tOfB86CoA/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 03:42:08 INFO - Downloaded 18267733 bytes. 03:42:08 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'] 03:42:08 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 03:42:12 INFO - Return code: 0 03:42:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:42:12 INFO - https://queue.taskcluster.net/v1/task/RIdxSdjrQnq14tOfB86CoA/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 03:42:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RIdxSdjrQnq14tOfB86CoA/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip 03:42:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RIdxSdjrQnq14tOfB86CoA/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip 03:42:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RIdxSdjrQnq14tOfB86CoA/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 03:42:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RIdxSdjrQnq14tOfB86CoA/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 03:42:12 INFO - Downloaded 10840194 bytes. 03:42:12 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'] 03:42:12 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 03:42:13 INFO - Return code: 0 03:42:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:42:13 INFO - https://queue.taskcluster.net/v1/task/RIdxSdjrQnq14tOfB86CoA/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 03:42:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RIdxSdjrQnq14tOfB86CoA/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 03:42:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RIdxSdjrQnq14tOfB86CoA/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 03:42:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RIdxSdjrQnq14tOfB86CoA/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-49.0a1.en-US.mac.dmg 03:42:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RIdxSdjrQnq14tOfB86CoA/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 03:42:19 INFO - Downloaded 110055402 bytes. 03:42:19 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/RIdxSdjrQnq14tOfB86CoA/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 03:42:19 INFO - mkdir: /builds/slave/test/properties 03:42:19 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:42:19 INFO - Writing to file /builds/slave/test/properties/build_url 03:42:19 INFO - Contents: 03:42:19 INFO - build_url:https://queue.taskcluster.net/v1/task/RIdxSdjrQnq14tOfB86CoA/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 03:42:20 INFO - Running post-action listener: _resource_record_post_action 03:42:20 INFO - Running post-action listener: set_extra_try_arguments 03:42:20 INFO - ##### 03:42:20 INFO - ##### Finished download-and-extract step (success) 03:42:20 INFO - ##### 03:42:20 INFO - ##### 03:42:20 INFO - ##### Running populate-webroot step. 03:42:20 INFO - ##### 03:42:20 INFO - Running pre-action listener: _resource_record_pre_action 03:42:20 INFO - Running main action method: populate_webroot 03:42:20 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:42:20 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:42:20 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:42:20 INFO - '--tppagecycles', 03:42:20 INFO - '7'], 03:42:20 INFO - 'tests': ['tsvgm']}}, 03:42:20 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:42:20 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:42:20 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:42:20 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:42:20 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:42:20 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:42:20 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:42:20 INFO - 'talos_options': ['--disable-e10s'], 03:42:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:42:20 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:42:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:42:20 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:42:20 INFO - 'talos_options': ['--disable-e10s'], 03:42:20 INFO - 'tests': ['damp', 'tps']}, 03:42:20 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:42:20 INFO - 'tests': ['damp', 'tps']}, 03:42:20 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:42:20 INFO - 'tests': ['dromaeo_dom']}, 03:42:20 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:42:20 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:42:20 INFO - 'tests': ['a11yr', 03:42:20 INFO - 'ts_paint', 03:42:20 INFO - 'tpaint', 03:42:20 INFO - 'sessionrestore', 03:42:20 INFO - 'sessionrestore_no_auto_restore', 03:42:20 INFO - 'tabpaint']}, 03:42:20 INFO - 'other-e10s': {'tests': ['a11yr', 03:42:20 INFO - 'ts_paint', 03:42:20 INFO - 'tpaint', 03:42:20 INFO - 'sessionrestore', 03:42:20 INFO - 'sessionrestore_no_auto_restore', 03:42:20 INFO - 'tabpaint']}, 03:42:20 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:42:20 INFO - 'ts_paint', 03:42:20 INFO - 'tpaint', 03:42:20 INFO - 'sessionrestore', 03:42:20 INFO - 'sessionrestore_no_auto_restore', 03:42:20 INFO - 'tabpaint']}, 03:42:20 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:42:20 INFO - 'ts_paint', 03:42:20 INFO - 'tpaint', 03:42:20 INFO - 'sessionrestore', 03:42:20 INFO - 'sessionrestore_no_auto_restore', 03:42:20 INFO - 'tabpaint']}, 03:42:20 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:42:20 INFO - 'tests': ['a11yr', 03:42:20 INFO - 'ts_paint', 03:42:20 INFO - 'tpaint', 03:42:20 INFO - 'sessionrestore', 03:42:20 INFO - 'sessionrestore_no_auto_restore', 03:42:20 INFO - 'tabpaint']}, 03:42:20 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:42:20 INFO - 'tests': ['a11yr', 03:42:20 INFO - 'ts_paint', 03:42:20 INFO - 'tpaint', 03:42:20 INFO - 'sessionrestore', 03:42:20 INFO - 'sessionrestore_no_auto_restore', 03:42:20 INFO - 'tabpaint']}, 03:42:20 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:42:20 INFO - 'tests': ['tsvgx', 03:42:20 INFO - 'tsvgr_opacity', 03:42:20 INFO - 'tart', 03:42:20 INFO - 'tscrollx', 03:42:20 INFO - 'cart']}, 03:42:20 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:42:20 INFO - 'tsvgr_opacity', 03:42:20 INFO - 'tart', 03:42:20 INFO - 'tscrollx', 03:42:20 INFO - 'cart']}, 03:42:20 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:42:20 INFO - 'talos_options': ['--disable-e10s'], 03:42:20 INFO - 'tests': ['tp5o']}, 03:42:20 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:42:20 INFO - 'tests': ['tp5o']}, 03:42:20 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:42:20 INFO - 'talos_options': ['--disable-e10s', 03:42:20 INFO - '--xperf_path', 03:42:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:42:20 INFO - 'tests': ['tp5n']}, 03:42:20 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:42:20 INFO - 'talos_options': ['--xperf_path', 03:42:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:42:20 INFO - 'tests': ['tp5n']}}, 03:42:20 INFO - 'talos.zip': {'path': '', 03:42:20 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:42:20 INFO - Running post-action listener: _resource_record_post_action 03:42:20 INFO - ##### 03:42:20 INFO - ##### Finished populate-webroot step (success) 03:42:20 INFO - ##### 03:42:20 INFO - ##### 03:42:20 INFO - ##### Running create-virtualenv step. 03:42:20 INFO - ##### 03:42:20 INFO - Running pre-action listener: _resource_record_pre_action 03:42:20 INFO - Running main action method: create_virtualenv 03:42:20 INFO - Creating virtualenv /builds/slave/test/build/venv 03:42:20 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 03:42:20 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:42:20 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:42:20 INFO - Using real prefix '/tools/python27' 03:42:20 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:42:21 INFO - Installing distribute.............................................................................................................................................................................................done. 03:42:23 INFO - Installing pip.................done. 03:42:23 INFO - Return code: 0 03:42:23 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:42:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:42:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:42:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:42:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:42:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:42:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:42:23 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 0x101919a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10191f570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa3e04b8370>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1017bdd30>, '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 0x1015e1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1017b4b20>, '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.SDaouneQmS/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.w30csLZLh2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/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 03:42:23 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 03:42:23 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 03:42:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SDaouneQmS/Render', 03:42:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:42:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:42:23 INFO - 'HOME': '/Users/cltbld', 03:42:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:42:23 INFO - 'LOGNAME': 'cltbld', 03:42:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:42:23 INFO - 'MOZ_NO_REMOTE': '1', 03:42:23 INFO - 'NO_EM_RESTART': '1', 03:42:23 INFO - 'PAGER': '/bin/cat', 03:42:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:42:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:42:23 INFO - 'PWD': '/builds/slave/test', 03:42:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:42:23 INFO - 'SHELL': '/bin/bash', 03:42:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.w30csLZLh2/Listeners', 03:42:23 INFO - 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/', 03:42:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:42:23 INFO - 'USER': 'cltbld', 03:42:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:42:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:42:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:42:23 INFO - 'XPC_FLAGS': '0x0', 03:42:23 INFO - 'XPC_SERVICE_NAME': '0', 03:42:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:42:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:42:24 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 03:42:24 INFO - Cleaning up... 03:42:24 INFO - Return code: 0 03:42:24 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:42:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:42:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:42:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:42:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:42:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:42:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:42:24 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 0x101919a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10191f570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa3e04b8370>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1017bdd30>, '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 0x1015e1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1017b4b20>, '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.SDaouneQmS/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.w30csLZLh2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/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 03:42:24 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 03:42:24 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 03:42:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SDaouneQmS/Render', 03:42:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:42:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:42:24 INFO - 'HOME': '/Users/cltbld', 03:42:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:42:24 INFO - 'LOGNAME': 'cltbld', 03:42:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:42:24 INFO - 'MOZ_NO_REMOTE': '1', 03:42:24 INFO - 'NO_EM_RESTART': '1', 03:42:24 INFO - 'PAGER': '/bin/cat', 03:42:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:42:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:42:24 INFO - 'PWD': '/builds/slave/test', 03:42:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:42:24 INFO - 'SHELL': '/bin/bash', 03:42:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.w30csLZLh2/Listeners', 03:42:24 INFO - 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/', 03:42:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:42:24 INFO - 'USER': 'cltbld', 03:42:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:42:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:42:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:42:24 INFO - 'XPC_FLAGS': '0x0', 03:42:24 INFO - 'XPC_SERVICE_NAME': '0', 03:42:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:42:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:42:24 INFO - Downloading/unpacking psutil>=3.1.1 03:42:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:42:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:42:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:42:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:42:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:42:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:42:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:42:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:42:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:42:27 INFO - Installing collected packages: psutil 03:42:27 INFO - Running setup.py install for psutil 03:42:27 INFO - building 'psutil._psutil_osx' extension 03:42:27 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 03:42:28 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 03:42:28 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 03:42:28 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 03:42:28 INFO - building 'psutil._psutil_posix' extension 03:42:28 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 03:42:28 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 03:42:28 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 03:42:28 INFO - ^ 03:42:28 INFO - 1 warning generated. 03:42:28 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 03:42:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:42:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:42:29 INFO - Successfully installed psutil 03:42:29 INFO - Cleaning up... 03:42:29 INFO - Return code: 0 03:42:29 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:42:29 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')]} 03:42:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:42:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:42:29 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')]} 03:42:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:42:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:42:29 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 0x101919a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10191f570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa3e04b8370>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1017bdd30>, '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 0x1015e1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1017b4b20>, '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.SDaouneQmS/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.w30csLZLh2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/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 03:42:29 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 03:42:29 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 03:42:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SDaouneQmS/Render', 03:42:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:42:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:42:29 INFO - 'HOME': '/Users/cltbld', 03:42:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:42:29 INFO - 'LOGNAME': 'cltbld', 03:42:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:42:29 INFO - 'MOZ_NO_REMOTE': '1', 03:42:29 INFO - 'NO_EM_RESTART': '1', 03:42:29 INFO - 'PAGER': '/bin/cat', 03:42:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:42:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:42:29 INFO - 'PWD': '/builds/slave/test', 03:42:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:42:29 INFO - 'SHELL': '/bin/bash', 03:42:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.w30csLZLh2/Listeners', 03:42:29 INFO - 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/', 03:42:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:42:29 INFO - 'USER': 'cltbld', 03:42:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:42:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:42:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:42:29 INFO - 'XPC_FLAGS': '0x0', 03:42:29 INFO - 'XPC_SERVICE_NAME': '0', 03:42:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:42:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:42:29 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:42:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:42:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:42:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:42:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:42:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:42:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:42:31 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:42:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:42:31 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:42:31 INFO - Installing collected packages: mozsystemmonitor 03:42:31 INFO - Running setup.py install for mozsystemmonitor 03:42:31 INFO - Successfully installed mozsystemmonitor 03:42:31 INFO - Cleaning up... 03:42:32 INFO - Return code: 0 03:42:32 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:42:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:42:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:42:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:42:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:42:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:42:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:42:32 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 0x101919a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10191f570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa3e04b8370>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1017bdd30>, '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 0x1015e1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1017b4b20>, '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.SDaouneQmS/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.w30csLZLh2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/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 03:42:32 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 03:42:32 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 03:42:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SDaouneQmS/Render', 03:42:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:42:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:42:32 INFO - 'HOME': '/Users/cltbld', 03:42:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:42:32 INFO - 'LOGNAME': 'cltbld', 03:42:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:42:32 INFO - 'MOZ_NO_REMOTE': '1', 03:42:32 INFO - 'NO_EM_RESTART': '1', 03:42:32 INFO - 'PAGER': '/bin/cat', 03:42:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:42:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:42:32 INFO - 'PWD': '/builds/slave/test', 03:42:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:42:32 INFO - 'SHELL': '/bin/bash', 03:42:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.w30csLZLh2/Listeners', 03:42:32 INFO - 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/', 03:42:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:42:32 INFO - 'USER': 'cltbld', 03:42:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:42:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:42:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:42:32 INFO - 'XPC_FLAGS': '0x0', 03:42:32 INFO - 'XPC_SERVICE_NAME': '0', 03:42:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:42:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:42:32 INFO - Downloading/unpacking blobuploader==1.2.4 03:42:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:42:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:42:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:42:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:42:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:42:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:42:34 INFO - Downloading blobuploader-1.2.4.tar.gz 03:42:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:42:34 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:42:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:42:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:42:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:42:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:42:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:42:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:42:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:42:35 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:42:35 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 03:42:35 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 03:42:35 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 03:42:35 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 03:42:35 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 03:42:35 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 03:42:35 INFO - Downloading docopt-0.6.1.tar.gz 03:42:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:42:35 INFO - Installing collected packages: blobuploader, requests, docopt 03:42:35 INFO - Running setup.py install for blobuploader 03:42:35 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:42:36 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:42:36 INFO - Running setup.py install for requests 03:42:36 INFO - Running setup.py install for docopt 03:42:36 INFO - Successfully installed blobuploader requests docopt 03:42:36 INFO - Cleaning up... 03:42:36 INFO - Return code: 0 03:42:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:42: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')]} 03:42:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:42:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:42:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:42:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:42:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:42:37 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 0x101919a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10191f570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa3e04b8370>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1017bdd30>, '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 0x1015e1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1017b4b20>, '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.SDaouneQmS/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.w30csLZLh2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/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 03:42:37 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 03:42:37 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 03:42:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SDaouneQmS/Render', 03:42:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:42:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:42:37 INFO - 'HOME': '/Users/cltbld', 03:42:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:42:37 INFO - 'LOGNAME': 'cltbld', 03:42:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:42:37 INFO - 'MOZ_NO_REMOTE': '1', 03:42:37 INFO - 'NO_EM_RESTART': '1', 03:42:37 INFO - 'PAGER': '/bin/cat', 03:42:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:42:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:42:37 INFO - 'PWD': '/builds/slave/test', 03:42:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:42:37 INFO - 'SHELL': '/bin/bash', 03:42:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.w30csLZLh2/Listeners', 03:42:37 INFO - 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/', 03:42:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:42:37 INFO - 'USER': 'cltbld', 03:42:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:42:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:42:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:42:37 INFO - 'XPC_FLAGS': '0x0', 03:42:37 INFO - 'XPC_SERVICE_NAME': '0', 03:42:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:42:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:42:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:42:37 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-_0OC8B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:42:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:42:37 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-2GubbB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:42:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:42:37 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-KWcamD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:42:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:42:37 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-onZvSX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:42:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:42:37 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-SSNwlP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:42:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:42:38 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-73OhKG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:42:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:42:38 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-UQ0YeC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:42:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:42:38 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-e1nIBV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:42:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:42:38 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-OvdY43-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:42:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:42:38 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-d8C9NL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:42:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:42:38 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-OdjkiN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:42:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:42:38 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-a5xKdA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:42:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:42:38 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-uVikbM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:42:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:42:38 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-1SGEol-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:42:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:42:39 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-2ZJMqd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:42:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:42:39 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-icfKy9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:42:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:42:39 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-xcUAS9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:42:39 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:42:39 INFO - Running setup.py install for manifestparser 03:42:39 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:42:39 INFO - Running setup.py install for mozcrash 03:42:39 INFO - Running setup.py install for mozdebug 03:42:39 INFO - Running setup.py install for mozdevice 03:42:39 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:42:39 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:42:39 INFO - Running setup.py install for mozfile 03:42:40 INFO - Running setup.py install for mozhttpd 03:42:40 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:42:40 INFO - Running setup.py install for mozinfo 03:42:40 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:42:40 INFO - Running setup.py install for mozInstall 03:42:40 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:42:40 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:42:40 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:42:40 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:42:40 INFO - Running setup.py install for mozleak 03:42:40 INFO - Running setup.py install for mozlog 03:42:40 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:42:40 INFO - Running setup.py install for moznetwork 03:42:40 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:42:40 INFO - Running setup.py install for mozprocess 03:42:41 INFO - Running setup.py install for mozprofile 03:42:41 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:42:41 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:42:41 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:42:41 INFO - Running setup.py install for mozrunner 03:42:41 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:42:41 INFO - Running setup.py install for mozscreenshot 03:42:41 INFO - Running setup.py install for moztest 03:42:41 INFO - Running setup.py install for mozversion 03:42:41 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:42:41 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:42:41 INFO - Cleaning up... 03:42:41 INFO - Return code: 0 03:42:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:42:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:42:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:42:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:42:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:42:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:42:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:42:41 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 0x101919a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10191f570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa3e04b8370>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1017bdd30>, '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 0x1015e1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1017b4b20>, '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.SDaouneQmS/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.w30csLZLh2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/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 03:42:41 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 03:42:41 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 03:42:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SDaouneQmS/Render', 03:42:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:42:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:42:41 INFO - 'HOME': '/Users/cltbld', 03:42:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:42:41 INFO - 'LOGNAME': 'cltbld', 03:42:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:42:41 INFO - 'MOZ_NO_REMOTE': '1', 03:42:41 INFO - 'NO_EM_RESTART': '1', 03:42:41 INFO - 'PAGER': '/bin/cat', 03:42:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:42:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:42:41 INFO - 'PWD': '/builds/slave/test', 03:42:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:42:41 INFO - 'SHELL': '/bin/bash', 03:42:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.w30csLZLh2/Listeners', 03:42:41 INFO - 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/', 03:42:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:42:41 INFO - 'USER': 'cltbld', 03:42:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:42:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:42:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:42:41 INFO - 'XPC_FLAGS': '0x0', 03:42:41 INFO - 'XPC_SERVICE_NAME': '0', 03:42:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:42:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:42:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:42:42 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-nkXPyi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:42:42 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)) 03:42:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:42:42 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-ax8k6y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:42:42 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)) 03:42:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:42:42 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-r7RKS_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:42:42 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)) 03:42:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:42:42 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-tEIjij-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:42:42 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)) 03:42:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:42:42 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-AXdHRZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:42:42 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)) 03:42:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:42:42 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-ueH2oo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:42:42 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)) 03:42:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:42:42 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-iLkaOR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:42:42 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)) 03:42:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:42:42 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-QctZnM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:42:43 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)) 03:42:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:42:43 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-pf3aEy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:42:43 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)) 03:42:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:42:43 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-FugjKh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:42:43 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)) 03:42:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:42:43 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-YJsIJB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:42:43 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)) 03:42:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:42:43 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-5PWl70-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:42:43 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)) 03:42:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:42:43 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-LakbJG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:42:43 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)) 03:42:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:42:43 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-CraZA8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:42:43 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)) 03:42:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:42:43 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-1NYfLv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:42:43 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)) 03:42:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:42:43 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-ckAk2m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:42:43 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)) 03:42:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:42:43 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-hndMJ1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:42:43 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)) 03:42:43 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)) 03:42:43 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)) 03:42:43 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)) 03:42:43 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)) 03:42:43 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)) 03:42:43 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:42:43 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 03:42:43 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 03:42:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:42:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:42:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:42:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:42:46 INFO - Downloading blessings-1.6.tar.gz 03:42:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:42:46 INFO - Installing collected packages: blessings 03:42:46 INFO - Running setup.py install for blessings 03:42:46 INFO - Successfully installed blessings 03:42:46 INFO - Cleaning up... 03:42:46 INFO - Return code: 0 03:42:46 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:42:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:42:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:42:47 INFO - Reading from file tmpfile_stdout 03:42:47 INFO - Current package versions: 03:42:47 INFO - blessings == 1.6 03:42:47 INFO - blobuploader == 1.2.4 03:42:47 INFO - docopt == 0.6.1 03:42:47 INFO - manifestparser == 1.1 03:42:47 INFO - mozInstall == 1.12 03:42:47 INFO - mozcrash == 0.17 03:42:47 INFO - mozdebug == 0.1 03:42:47 INFO - mozdevice == 0.48 03:42:47 INFO - mozfile == 1.2 03:42:47 INFO - mozhttpd == 0.7 03:42:47 INFO - mozinfo == 0.9 03:42:47 INFO - mozleak == 0.1 03:42:47 INFO - mozlog == 3.2 03:42:47 INFO - moznetwork == 0.27 03:42:47 INFO - mozprocess == 0.22 03:42:47 INFO - mozprofile == 0.28 03:42:47 INFO - mozrunner == 6.11 03:42:47 INFO - mozscreenshot == 0.1 03:42:47 INFO - mozsystemmonitor == 0.3 03:42:47 INFO - moztest == 0.7 03:42:47 INFO - mozversion == 1.4 03:42:47 INFO - psutil == 3.1.1 03:42:47 INFO - requests == 1.2.3 03:42:47 INFO - wsgiref == 0.1.2 03:42:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:42: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')]} 03:42:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:42:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:42: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')]} 03:42:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:42:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:42:47 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 0x101919a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10191f570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa3e04b8370>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1017bdd30>, '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 0x1015e1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1017b4b20>, '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.SDaouneQmS/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.w30csLZLh2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/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 03:42:47 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 03:42:47 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 03:42:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SDaouneQmS/Render', 03:42:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:42:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:42:47 INFO - 'HOME': '/Users/cltbld', 03:42:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:42:47 INFO - 'LOGNAME': 'cltbld', 03:42:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:42:47 INFO - 'MOZ_NO_REMOTE': '1', 03:42:47 INFO - 'NO_EM_RESTART': '1', 03:42:47 INFO - 'PAGER': '/bin/cat', 03:42:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:42:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:42:47 INFO - 'PWD': '/builds/slave/test', 03:42:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:42:47 INFO - 'SHELL': '/bin/bash', 03:42:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.w30csLZLh2/Listeners', 03:42:47 INFO - 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/', 03:42:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:42:47 INFO - 'USER': 'cltbld', 03:42:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:42:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:42:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:42:47 INFO - 'XPC_FLAGS': '0x0', 03:42:47 INFO - 'XPC_SERVICE_NAME': '0', 03:42:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:42:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:42:47 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)) 03:42:47 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)) 03:42:47 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)) 03:42:47 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)) 03:42:47 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)) 03:42:47 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)) 03:42:47 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)) 03:42:47 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)) 03:42:47 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)) 03:42:47 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)) 03:42:47 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)) 03:42:47 INFO - Cleaning up... 03:42:47 INFO - Return code: 0 03:42:47 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:42: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')]} 03:42:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:42:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:42: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')]} 03:42:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:42:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:42:47 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 0x101919a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10191f570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa3e04b8370>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1017bdd30>, '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 0x1015e1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1017b4b20>, '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.SDaouneQmS/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.w30csLZLh2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/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 03:42:47 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 03:42:47 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 03:42:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SDaouneQmS/Render', 03:42:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:42:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:42:47 INFO - 'HOME': '/Users/cltbld', 03:42:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:42:47 INFO - 'LOGNAME': 'cltbld', 03:42:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:42:47 INFO - 'MOZ_NO_REMOTE': '1', 03:42:47 INFO - 'NO_EM_RESTART': '1', 03:42:47 INFO - 'PAGER': '/bin/cat', 03:42:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:42:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:42:47 INFO - 'PWD': '/builds/slave/test', 03:42:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:42:47 INFO - 'SHELL': '/bin/bash', 03:42:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.w30csLZLh2/Listeners', 03:42:47 INFO - 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/', 03:42:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:42:47 INFO - 'USER': 'cltbld', 03:42:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:42:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:42:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:42:47 INFO - 'XPC_FLAGS': '0x0', 03:42:47 INFO - 'XPC_SERVICE_NAME': '0', 03:42:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:42:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:42:47 INFO - Downloading/unpacking jsonschema 03:42:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:42:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:42:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:42:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:42:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:42:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:42:49 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:42:49 INFO - Downloading/unpacking functools32 (from jsonschema) 03:42:49 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 03:42:49 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 03:42:49 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 03:42:49 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 03:42:49 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 03:42:49 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 03:42:50 INFO - Downloading functools32-3.2.3-2.tar.gz 03:42:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:42:50 INFO - warning: no files found matching '*.txt' 03:42:50 INFO - no previously-included directories found matching 'build' 03:42:50 INFO - no previously-included directories found matching 'dist' 03:42:50 INFO - no previously-included directories found matching '.git*' 03:42:50 INFO - Installing collected packages: jsonschema, functools32 03:42:50 INFO - Running setup.py install for functools32 03:42:50 INFO - warning: no files found matching '*.txt' 03:42:50 INFO - no previously-included directories found matching 'build' 03:42:50 INFO - no previously-included directories found matching 'dist' 03:42:50 INFO - no previously-included directories found matching '.git*' 03:42:50 INFO - Successfully installed jsonschema functools32 03:42:50 INFO - Cleaning up... 03:42:50 INFO - Return code: 0 03:42:50 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 03:42:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:42:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:42:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:42:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:42:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:42:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:42:50 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 0x101919a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10191f570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa3e04b8370>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1017bdd30>, '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 0x1015e1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1017b4b20>, '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.SDaouneQmS/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.w30csLZLh2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/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 03:42:50 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 03:42:50 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 03:42:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SDaouneQmS/Render', 03:42:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:42:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:42:50 INFO - 'HOME': '/Users/cltbld', 03:42:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:42:50 INFO - 'LOGNAME': 'cltbld', 03:42:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:42:50 INFO - 'MOZ_NO_REMOTE': '1', 03:42:50 INFO - 'NO_EM_RESTART': '1', 03:42:50 INFO - 'PAGER': '/bin/cat', 03:42:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:42:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:42:50 INFO - 'PWD': '/builds/slave/test', 03:42:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:42:50 INFO - 'SHELL': '/bin/bash', 03:42:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.w30csLZLh2/Listeners', 03:42:50 INFO - 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/', 03:42:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:42:50 INFO - 'USER': 'cltbld', 03:42:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:42:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:42:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:42:50 INFO - 'XPC_FLAGS': '0x0', 03:42:50 INFO - 'XPC_SERVICE_NAME': '0', 03:42:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:42:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:42:51 INFO - Downloading/unpacking flake8 03:42:51 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 03:42:51 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 03:42:51 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 03:42:51 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 03:42:51 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 03:42:51 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 03:42:53 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 03:42:53 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 03:42:53 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 03:42:53 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 03:42:53 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 03:42:53 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 03:42:53 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 03:42:53 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 03:42:53 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 03:42:53 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 03:42:53 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 03:42:53 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 03:42:53 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 03:42:53 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 03:42:53 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 03:42:53 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 03:42:54 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 03:42:54 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 03:42:54 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 03:42:54 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 03:42:54 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 03:42:54 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 03:42:54 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 03:42:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 03:42:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:42:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:42:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:42:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:42:54 INFO - no previously-included directories found matching 'docs/_build' 03:42:54 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 03:42:54 INFO - Running setup.py install for pep8 03:42:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:42:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:42:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:42:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:42:54 INFO - no previously-included directories found matching 'docs/_build' 03:42:55 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 03:42:55 INFO - Successfully installed flake8 mccabe pyflakes pep8 03:42:55 INFO - Cleaning up... 03:42:55 INFO - Return code: 0 03:42:55 INFO - Running post-action listener: _resource_record_post_action 03:42:55 INFO - Running post-action listener: _start_resource_monitoring 03:42:55 INFO - Starting resource monitoring. 03:42:55 INFO - ##### 03:42:55 INFO - ##### Finished create-virtualenv step (success) 03:42:55 INFO - ##### 03:42:55 INFO - ##### 03:42:55 INFO - ##### Running install step. 03:42:55 INFO - ##### 03:42:55 INFO - Running pre-action listener: _resource_record_pre_action 03:42:55 INFO - Running main action method: install 03:42:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:42:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:42:55 INFO - Reading from file tmpfile_stdout 03:42:55 INFO - Detecting whether we're running mozinstall >=1.0... 03:42:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:42:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:42:55 INFO - Reading from file tmpfile_stdout 03:42:55 INFO - Output received: 03:42:55 INFO - Usage: mozinstall [options] installer 03:42:55 INFO - Options: 03:42:55 INFO - -h, --help show this help message and exit 03:42:55 INFO - -d DEST, --destination=DEST 03:42:55 INFO - Directory to install application into. [default: 03:42:55 INFO - "/builds/slave/test"] 03:42:55 INFO - --app=APP Application being installed. [default: firefox] 03:42:55 INFO - mkdir: /builds/slave/test/build/application 03:42:55 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'] 03:42:55 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 03:43:29 INFO - Reading from file tmpfile_stdout 03:43:29 INFO - Output received: 03:43:29 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 03:43:29 INFO - Running post-action listener: _resource_record_post_action 03:43:29 INFO - ##### 03:43:29 INFO - ##### Finished install step (success) 03:43:29 INFO - ##### 03:43:29 INFO - ##### 03:43:29 INFO - ##### Running run-tests step. 03:43:29 INFO - ##### 03:43:29 INFO - Running pre-action listener: _resource_record_pre_action 03:43:29 INFO - Running main action method: run_tests 03:43:29 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:43:29 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:43:29 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:43:29 INFO - 2016-05-16 03:43:29.193 screenresolution[1669:8618] starting screenresolution argv=screenresolution get 03:43:29 INFO - 2016-05-16 03:43:29.196 screenresolution[1669:8618] Display 0: 1600x1200x32@60 03:43:29 INFO - 2016-05-16 03:43:29.202 screenresolution[1670:8620] starting screenresolution argv=screenresolution list 03:43:29 INFO - Available Modes on Display 0 03:43:29 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:43:29 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:43:29 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:43:29 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:43:29 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:43:29 INFO - Intel Iris: 03:43:29 INFO - Chipset Model: Intel Iris 03:43:29 INFO - Type: GPU 03:43:29 INFO - Bus: Built-In 03:43:29 INFO - VRAM (Dynamic, Max): 1536 MB 03:43:29 INFO - Vendor: Intel (0x8086) 03:43:29 INFO - Device ID: 0x0a2e 03:43:29 INFO - Revision ID: 0x0009 03:43:29 INFO - Displays: 03:43:29 INFO - Display: 03:43:29 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:43:29 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:43:29 INFO - Display Serial Number: 1600x1200 60 03:43:29 INFO - Main Display: Yes 03:43:29 INFO - Mirror: Off 03:43:29 INFO - Online: Yes 03:43:29 INFO - Rotation: Supported 03:43:29 INFO - Return code: 0 03:43:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:43:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:43:29 INFO - Python 2.7.3 03:43:29 INFO - Return code: 0 03:43:29 INFO - grabbing minidump binary from tooltool 03:43:29 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')]} 03:43:29 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 0x1017bdd30>, '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 0x1015e1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1017b4b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:43:29 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 03:43:29 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 03:43:29 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 03:43:29 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:43:29 INFO - Return code: 0 03:43:29 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 03:43:29 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:43:29 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:43:29 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 03:43:29 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:43:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 03:43:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 03:43:30 INFO - Return code: 0 03:43:30 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/RIdxSdjrQnq14tOfB86CoA/artifacts/public/build/firefox-49.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0029', '--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 03:43:30 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/RIdxSdjrQnq14tOfB86CoA/artifacts/public/build/firefox-49.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0029 --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 03:43:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SDaouneQmS/Render', 03:43:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:43:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:43:30 INFO - 'HOME': '/Users/cltbld', 03:43:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:43:30 INFO - 'LOGNAME': 'cltbld', 03:43:30 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:43:30 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 03:43:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:43:30 INFO - 'MOZ_NO_REMOTE': '1', 03:43:30 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:43:30 INFO - 'NO_EM_RESTART': '1', 03:43:30 INFO - 'PAGER': '/bin/cat', 03:43:30 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:43:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:43:30 INFO - 'PWD': '/builds/slave/test', 03:43:30 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:43:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:43:30 INFO - 'SHELL': '/bin/bash', 03:43:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.w30csLZLh2/Listeners', 03:43:30 INFO - 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/', 03:43:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:43:30 INFO - 'USER': 'cltbld', 03:43:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:43:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:43:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:43:30 INFO - 'XPC_FLAGS': '0x0', 03:43:30 INFO - 'XPC_SERVICE_NAME': '0', 03:43:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:43:30 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/RIdxSdjrQnq14tOfB86CoA/artifacts/public/build/firefox-49.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0029', '--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 03:43:30 INFO - mozversion application_buildid: 20160516005330 03:43:30 INFO - mozversion application_changeset: 0c29ad917ac38c9ef26c9ff0b5d9762e75d13948 03:43:30 INFO - mozversion application_display_name: Nightly 03:43:30 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:43:30 INFO - mozversion application_name: Firefox 03:43:30 INFO - mozversion application_remotingname: firefox 03:43:30 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 03:43:30 INFO - mozversion application_vendor: Mozilla 03:43:30 INFO - mozversion application_version: 49.0a1 03:43:30 INFO - mozversion platform_buildid: 20160516005330 03:43:30 INFO - mozversion platform_changeset: 0c29ad917ac38c9ef26c9ff0b5d9762e75d13948 03:43:30 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 03:43:30 INFO - mozversion platform_version: 49.0a1 03:43:30 INFO - using testdate: 1463395410 03:43:30 INFO - actual date: 1463395410 03:43:30 INFO - starting webserver on 'localhost:49275' 03:43:30 INFO - SUITE-START | Running 2 tests 03:43:30 INFO - TEST-START | dromaeo_css 03:43:30 INFO - operating with platform_type : mac_ 03:43:30 INFO - Initialising browser for dromaeo_css test... 03:43:30 INFO - TEST-INFO | started process 1688 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/tmpyZLy5z/profile http://localhost:49275/getInfo.html) 03:43:34 INFO - PROCESS | 1688 | __metrics Screen width/height:1600/1200 03:43:34 INFO - PROCESS | 1688 | colorDepth:24 03:43:34 INFO - PROCESS | 1688 | Browser inner width/height: 1024/689 03:43:34 INFO - PROCESS | 1688 | __metrics 03:43:34 ERROR - PROCESS | 1688 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2946: TypeError: this.tabs is undefined 03:43:34 INFO - TEST-INFO | 1688: exit 0 03:43:34 INFO - Browser initialized. 03:43:34 INFO - Running cycle 1/1 for dromaeo_css test... 03:43:34 INFO - TEST-INFO | started process 1692 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/tmpyZLy5z/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:43:46 INFO - PROCESS | 1692 | RSS: Main: 249810944 03:43:46 INFO - PROCESS | 1692 | 03:44:36 INFO - PROCESS | 1692 | 1463395476372 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] 03:46:47 INFO - PROCESS | 1692 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49275/tests/dromaeo/cssquery-ext.html) 03:46:48 INFO - PROCESS | 1692 | RSS: Main: 260812800 03:46:48 INFO - PROCESS | 1692 | 03:49:50 INFO - PROCESS | 1692 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-ext.html (next: http://localhost:49275/tests/dromaeo/cssquery-jquery.html) 03:49:51 INFO - PROCESS | 1692 | RSS: Main: 273444864 03:49:51 INFO - PROCESS | 1692 | 03:52:53 INFO - PROCESS | 1692 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49275/tests/dromaeo/cssquery-mootools.html) 03:52:53 INFO - PROCESS | 1692 | RSS: Main: 275034112 03:52:53 INFO - PROCESS | 1692 | 03:55:55 INFO - PROCESS | 1692 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49275/tests/dromaeo/cssquery-prototype.html) 03:55:56 INFO - PROCESS | 1692 | RSS: Main: 276938752 03:55:56 INFO - PROCESS | 1692 | 03:58:59 INFO - PROCESS | 1692 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49275/tests/dromaeo/cssquery-yui.html) 03:58:59 INFO - PROCESS | 1692 | RSS: Main: 279834624 03:58:59 INFO - PROCESS | 1692 | 04:02:02 INFO - PROCESS | 1692 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-yui.html (next: http://localhost:49275/tests/dromaeo/cssquery-dojo.html) 04:02:02 INFO - PROCESS | 1692 | RSS: Main: 280895488 04:02:02 INFO - PROCESS | 1692 | 04:02:02 INFO - PROCESS | 1692 | __start_tp_report 04:02:02 INFO - PROCESS | 1692 | _x_x_mozilla_page_load 04:02:02 INFO - PROCESS | 1692 | _x_x_mozilla_page_load_details 04:02:02 INFO - PROCESS | 1692 | |i|pagename|runs| 04:02:02 INFO - PROCESS | 1692 | |0;dojo.html;3446.9655303446975;3455.464403017533;3478.652134786522;3498.5102085708;3505.7545971781988;5735.971320143399;5835.445632664895;5860.443257890504;5866.413358664131;5929.4367035131645;5695.7152142392815;5777.7111144442715;5805.564582656307;5849.678267695275;5893.764249430018;5187.974060129694;5220.451852555484;5301.787928482856;5312.893742125155;5341.679499230039;173.61130432169736;5282.973585132069;5284.603654725892;5307.893842123155;5312.1766126250495;5199.324087868591;5206.635535512534;5219;5226.7125308108225;5314.468553144693;3980.840766369342;5184.662996905189;5262.710550919698;5272.710000949946;5281.788728450896;4902.828401005983;5210.426853046162;5256.290400795881;5294.52349288562;5299.6025298102795;5644.520215781664;5783.363829978741;5797.913031304533;5820.912686309709;5882.264716910387;6209.037599172136;6210;6211.81364559064;6261.655608941506;6267.592606480564;6181.443670069671;6309.779157729503;6311.589746666452;6325.9051114233325;6326.051092336186;6014.909776353358;6022;6022.6687532185715;6055.757769689163;6056.606320589148;6210.968945155245;6256.906146407808;6270.467010304084;6431.163948686641;6439.130717353098;6216.658083805434;6251.6561589113035;6281.403266689657;6288.465480434214;6321.399467050623;6255.749770009149;6259.78090766821;6302.086197501337;6321.241451025906;6324.494040476751;6156.538259630545;6198.380161983856;6225.470834978987;6265;6296.905546416808;6169.81490555284;6179.3202747697715;6231.906521402183;6259.749610015549;6296.496280297565;5005.824796132118;5008.874778130576;5015.623828212899;5016.297718319438;5039.571636410946;3970.7220494565104;4344.630706389929;4477;4522.570355816192;4538.455385353713;5880.147378630075;5902.026165682701;5981.222441082631;5981.700914954322;6011.849703757353;6309.621422714652;6316;6320.873582528324;6325.304216536178;6337;6005.819825405245;6038.215032045806;6053.909191362133;6054.757809687651;6060.212172417646;5002.949380630036;5188.169892817131;5377.704226267515;5437.45625437461;5558.583106267046;4838.588719958772;5403.4059952314165;6290.119383286344;6345;6540.672966351759;5525.336959564878;6198.318184999556;6327.303996560467;6357.396047375492;6359.07793369968;6363.363663633785;6386.648734319657;6399.776007839703;6441.098246245436;6565.671716414256;5201.7399130044105;6263.342349053284;6280.277768056732;6297.307296197323;6300.716467759054;6179.969100154471;6287.905681414874;6305.274893387319;6308.08532762756;6316.178896743394;4839.612830973584;6023.134628065941;6139.2161661365335;6201.6899155041165;6214.627122372672;6157.415045570664;6202.4417802398;6239.906401403891;6259.467945224525;6277.780277690442;5235.895282094413;5930.11048342752;6153.230846144232;6172.567920245539;6174.598651087665;6118.479929206067;6167.506599472121;6167.876642467036;6238.095476156022;6243.094751260951;6125.663088530174;6153.907691384543;6196.349383314868;6218.782342617987;6224.937750622617 04:02:02 INFO - PROCESS | 1692 | |1;ext.html;525.1545012529826;529.2828217764928;534.8154886564135;574.8649067469146;590.6975119860707;30885.536716949235;38077.42883856741;38928.22143557127;39271.82184534468;39423.60576394235;40210.7989460053;40841;40939;41029.384559231636;41108.794456027754;9347.532623368821;9501.23990080792;9558.474283914382;9591.280653950947;9602.039796020412;9447.716568502956;9497.857532136988;9513.857292140623;9515;9590.136887680108;9544.427334359925;9577.138057574817;9617.37487063342;9631.566579503904;9635.518224088803;9543.093406126442;9552.379095358814;9601.759956001086;9603.615855365777;9618.75953101171;9476.857847132229;9509.33434659574;9549.09283618055;9605.90394096057;9608.855867161998;31516.684833151605;37703.4344484833;38010;38046.80976595127;38334.80832595819;2967.421352836198;3001.5947847040807;3144.716975472196;3295.9452975047993;3435.3644575753565;29108.417831643248;29428.822847086092;29621.407571848442;30156.54765178524;30401;2195.70453432474;2756.2833663247497;2765.4469106178844;2783.2067860659613;2834.957475637867;545457;548979;555381;557408;559988;71496;71580.64209678919;71645;71654.64172679103;71716.28283717201;37818.62181378206;37975;38854;40041.199176016315;40067.59932400638;17146;17341.566460838327;17613.91193044052;17619.383321583682;17650;13265.734685306239;13296.73406531864;13374.933125334312;13385.397657105454;13390.799138012937;21987.780122198892;22079.44801379946;22112.77887221107;22168.224112155996;22213.888930555244;7904.525728456311;9222.262219022463;9222.44665320083;9239.861402078974;9372.437653740797;838.3419016072354;897.9012308646044;993.8111758765812;1050.8949105089582;1153.938376693444;29500.557491637643;29756;30013.549796753065;30280.697193028227;30296.697033029828;965.3242730088966;1054.6974486509155;1080.2978064258295;1151.6717735445359;1164.976700466003;15196;15280.388784448498;15310.693786124215;15393.230338483256;15479.380824766884;602209;703641;709357;710182;711565;57563.71218143882;58426;59177.704111479165;59676;59739.10391344134;1279.3795009420423;1467.185711929889;1470.0150898897764;1476.2102275282673;1493.529538195465;23843.64234536518;29288.853555732087;29294;29727.256818578844;29930.85034574813;50535.73660658366;50831.74584127056;51022.74488627533;51180.72048198676;51203.975920482124;558975;570992;574986;575564;576967.1151644215;26404;27408.314792130357;27761.44477110406;27767.444651107267;27847.88608455639;44074.33888491739;44442;44481.77759111184;44910.32634510419;45225;29811.254718632208;37552.81223593974;37690.811545942095;38333.616663833;38410.0397490065;29494.557581636724;37039.81480092582;37193.44209836909;37574;37823;36280.09299767527;37152.07119822026;37382.2523549522;37741.4338784924;37866.62133378631;31398.372032559677;32916.177095571846;32920;32933.50599740958;33289.16777080592;24358.147464838647;24755.876220619502;24758.25725228246;25223;25281.241562753148 04:02:02 INFO - PROCESS | 1692 | |2;jquery.html;352.29892513897335;387.9282332768438;390.13584909425623;396.5320921312851;403.4029636138517;19063.904680476597;21536.89231553844;21752;22065.33803985879;22105.778942210574;20868.852213128273;21738.565228695457;21811.563768724616;21894.45263868404;22389.77610223897;5446.264754258164;5461.126219804832;5941.138534912435;5982.222311099573;6006.369331220225;5587.329520457531;5892.558058145656;5898.911516327237;5904.1734157218025;5938.910916336258;5787.565932555054;5789.305283366002;5792.7972520961775;5795.420457954192;5797.333306669724;5620.747066382022;5760.222369980062;5786.305643322808;5818.06910894257;5895.410458954113;5125.256837758541;5146.202338637517;5157.071727089123;5164.896702065976;5166.354205724285;25488.235352939257;26330.868345658342;26599.601005984925;26608;26837.597436038475;2117.3224568138203;2119.406566161462;2141.7536983246814;2440.8535487870786;2582.7546383093763;14863.777043344358;15242.618934526614;15278.847211527853;15398.76901846462;15406.3837446502;1384.5777038003405;1727.231382034995;1733.5319463744845;1757.2180379731026;1790.4807605794304;97019.02980970171;120755;121047;121095;121832;7824.413169012347;8883.889513810773;9416.293777966543;10043.19654427644;10721.30311529748;12264.38678066093;12453.688657783629;12481.126321157431;12568.057395695176;12583.622491325092;7458;7602;8293.792655183668;8296.336293096538;8452.74641760748;8692.95653521741;8700.30397568193;8706.956465217634;8717.564121793885;8839.248663863515;3324.73402127834;3613.837377317974;3741.9812900935867;4021.3967904814513;4106.753594784323;1708.5557754983793;1891.7919028906808;2020.7474065741783;2035.8574899756875;2045.8261047811102;839.5340585974842;992.1566668332005;1000.2797985450464;1032.0092710997376;1035.6064695415844;19693;20311.898440507703;20372.777633342048;20549.89725051365;20747.273845415337;907.2515174980667;950.1686024728363;970.2868391732071;1026.7330494071596;1053.210092430677;10400.543923850668;10743;10753.193510486588;10805.843426145586;10838.132949364031;620731;630914;632413;639549;646375;127579.36210318889;135855;138235;144275.27862360832;150161.49838501692;968.2447690801187;998.4708104704373;1018.7504061504978;1020.4999550220487;1049.606397600915;18001.099945002436;18151.455456335803;18162.45512634623;18307.908460457613;18316.175772090555;33829.66170338265;53985.19022214592;56314;57813.132803007145;57882.710586446796;81832;84937.15062849292;85921;86981.56509217413;87569.1243087561;7692.0384951881015;7980.162082981204;8017.358611311198;8028.197180282159;8077.555734434663;11516.884831151916;12003.579874704343;12403.813942791046;12475.812862807246;12576.434060467118;10273.691789246335;10713.732156695833;10727.624533141303;10753.354798712102;10902.781944361226;10289;10523.810940242052;10696.946515267375;10816.242862999829;11035.565376501003;10772.461376930965;10961.342319460859;10993.120550356112;11065.280756750786;11174.385408802595;6847.931520684929;7834.764957051298;7973.481723687942;8017.959910200411;8038.196180381915;8183.140770219041;10779.461026948464;11114.22200445961;11341.695704994032;11374.545018199511 04:02:02 INFO - PROCESS | 1692 | |3;mootools.html;1599.7520384340428;1641.7044931912258;1907.4563749331444;1972.8495939426032;2006.2476571285767;8185.8362832743305;8775.956120219398;8799.91200087999;9324.906750932489;9325.253979681625;8871.556422178897;8958.686445974392;9092.545372731354;9114.589843457044;9143.542822858846;2397.0411835265904;2403.6995375578053;2423.248792874215;2434.817388695846;2437.122635851101;2398.9880050599722;2401.819863510235;2420.298113547069;2426.3934016495878;2446.804255659543;2087.6242276390244;2420.745821688724;2429.538387706339;2435.7320694723567;2436.049940523197;2035.5827055453597;2392.665026896227;2394.413368724665;2407.398150462393;2427.5751743444825;2339.754325795784;2401.915932942356;2402.5435167318155;2403.5072810073893;2405.7714517120844;7706.961465192639;7888.684452621888;9165.266778657691;9170.587323570455;9194.770130746718;5419.83740487786;5599.524040456566;5599.972000140014;5608.130739735348;5612.635178713412;3516.683498485123;3582.8925132246072;3585.229175727231;3660.9267814643827;3684.7236457265813;1034.534459493231;1042.030911252535;1042.9947850260776;1053.5891002509027;1058.772363941756;10085.840128385184;12007.93996030023;12187.268763874195;12242.265464072096;12266.509339626404;4849.660523763303;4875.293082503017;4972.5027497249985;4976.701397916137;5027.924581131286;10196.694099177037;10231.028052335016;10250.692479225636;10261.28171028021;10268.794624107626;5463.289772329572;5543.944560554423;5547.722613869371;5552.7778888844805;5560.499555039985;4525.886852828706;4848.10310092634;4984.177610694195;5029.899402012013;5036.244563315532;3443.8794642187404;4049.271131196413;4155.833766649361;4189.518205406417;4259;1191.0233608440994;1355.9186448813102;1362.9522966696118;1364.938577764003;1376.291210026837;822.0751654388813;850.0012485329713;892.683097500378;902.6389444222364;934.3646320501988;5552.7223638817895;5728.169415434739;5868.647881127146;5967.880642387128;6032.3967603239325;935.5135329628555;955.4267439536361;961.9615215391306;971.0920289529313;1014.06705830636;3810.333191691443;3886.417037444406;3928.52857657083;3959.604039596075;3991.042149884007;10465.9476702616;11064.723381915517;11083.944580277048;11088.501017454233;11121.332720036824;10571.735706607396;10896.019358257794;11025.779484410266;11026.44867756609;11187.32876027441;8286.212809783061;8436.029856566573;8440.704575339956;8480.279176270085;8515.659373624985;5656.660600363992;5728.8567785804025;5753;5820.01329089575;5837.211976383134;8351.373646976379;9939.055789700256;10119.443430611387;10163.288569800043;10190.235732319958;8960.462372257425;10018.549165287724;10214.744631384276;10353.689389318333;10353.896461035594;5769.249997500298;6726.3609957054005;6779.966100169468;7638.961805190938;7789.532628042336;7916.762497125095;8516.829663406574;8560.743177704679;8584.613692383733;8595.65617375298;7480.2145774695055;7563.773086807405;7605.505642133244;7657.004589403342;7715.189905059888;7466.930522864943;7489.550626962399;7578.204288549843;7654.578998154932;7695.615219239127;5942.702864856654;7202.675879585327;7231.819204519929;7237.240089790706;7239.746608868664;3831.463595096633;4341;4732.6687131900435;4834.564889159992;4916.459189489225;4862.756862156807;4893.951060489349;4946.109700253989;4967.776450059829;4992.2761199626575 04:02:02 INFO - PROCESS | 1692 | |4;prototype.html;304.16810024582776;314.2175981805305;320.5752378099019;321.40700407747704;325.43049663089596;4444.79998400072;5338.652987555816;5539.977908063553;5590.692511911843;5599.664020158793;5279.736013199344;5369.9463005369935;5430.67415955043;5484.683675917771;5519.917201241985;4138.399932009849;4139.56534563871;4151.522574903895;4161.479815023122;4168.24933527919;3369.275605744777;3837.5417341410225;4131.648809851151;4133.607307305816;4170.291050521419;4055.878323650295;4059.8985025374454;4068.9796551017203;4082.8979275518054;4119.773412462313;3762.3415902217002;3766.5498782968616;4074.8370065197355;4121;4141.585841415835;3559.94660080099;3562.71498280137;3571.62497937718;3576.660217279354;3584.982075089608;3995.7802320872343;4490.685652004361;5188.821490896334;5277.815276465343;5289.1801770725215;4560.110778398213;4682.321063445781;4711.515872500186;4722.858314250578;4748.264019077049;5047.242913562958;5267.789288428458;5730.484256416942;5733.397993210736;5738.4177120296035;3614.584322802859;3651.8539258429632;3882.2041481496226;3922.313595120871;3948.795617336711;4898.926516102261;4971.850844474636;6076.361981991871;6079.513638908877;6106.236720409949;3215.1962009497624;3320.335932813447;3605.134767655744;3975.6620687241907;3976.980115099464;3110.6889311069162;3155.2961400843747;3228.7255583275214;4020.2562525932794;4050.5341885683524;3644.85420583179;3999.5400528939545;4665.4168228971375;4695.600873925686;4732.219183834629;5149.665271757323;5416.972915135478;5530.557555395559;5615.932972735167;5628.324601047819;1231.408923716621;1243.564752336675;1309.1752196116386;1334.432866031952;1369.6028151836056;690.602903330587;711.5161690050712;818.5211651184005;841.2765022081005;853.1681610429781;3893.6885049196;4147.54835807471;4511.751853648016;4552.702479793309;4623.468301145412;4270.316749320094;4572.428446444194;5055.197562315741;5144.427786106947;5155.664881782747;4133.7677654067065;4172.874813755592;4517.593416592523;4519.389882365838;4532.161550113239;2153.567877361537;2370.826440911725;2378.9184463594356;2530.607755797854;2593.844369337846;4793.760311984387;4941.629377796679;5298.81454149103;5302.719830472934;5307.28351672527;4764.928526072112;5121.8463446096675;5167.560757335668;5194.11700010999;5240.659357141773;4937.876553086202;5735.598508104559;6184.226971628546;6188.381161883865;6199.876002480015;5270.076422105981;5361.552380857224;5550.75021624036;5954.761809527744;5998.850028749316;5587.314854894072;5771.826845194651;5861.772526439926;5905.991962732692;5909.020478139872;4992.550670439678;5459.727013649381;5933.406659334032;6130.233720784902;6257;3365.7980521168806;3942.684585233117;3982.203559288096;3994.9213712298097;4001.639852413297;5016.046951079284;5658.943410565842;5676.318841738853;5845.707714614167;5875;5581.553475721851;5744.827655170351;5750.194972703741;5810.186573879576;5812.7674893003805;4930.433000204879;5415.967058447282;5536.667799932017;5865.3254875689845;5909.320428150818;4882.754897501114;5017.695399196162;5052.469490703424;5476.424975377528;5747.798827041033;5157.252198431282;5802.970985145216;5823.242978412779;5836.766529338779;5872.794452194153;5177.695925313199;5701.40135285789;5762.798302059407;5784.380373495428;5801.361850196559 04:02:02 INFO - PROCESS | 1692 | |5;yui.html;655.3872129558862;715.5456285258865;752.289086812962;755.1881727143323;764.2395816162917;12174.330411827346;15082;15361.30874110665;15537.456189033386;15579.298931548079;11292.548298068068;11518.712032199199;14495.782563261559;14507.854921450782;14733.042352247096;736.6243215959872;889.3241136736078;896.3143195455482;903.4263242840777;904.1952662130676;874.97812554686;901.076396693388;904.683360823713;905.950172740499;908.4640062363204;940.614348117272;962.1148543340144;969.9515024248794;970.0590427285522;973.8636590877247;935.2424536125726;938.3384713776771;945.8533927241289;964.3635200767495;965.1410244882061;700.5936556797045;717.078554058033;717.4081382859162;717.6447658409121;717.6483523073708;14785.26073696311;14879;14889.47886823956;14892.62768430787;14908.478203262943;12506.74986500274;12567.748645027139;12570.874291257152;12606.621801345882;12870.935645321808;10008.799824003552;10033.949830250875;10045.397276163381;10248.180145588409;10387.013233742782;3503.3693935091674;3519.8240087995496;3542.1498840278405;3590.982045089784;3595.442706380515;81365.77951330735;81677.59161204156;83396;83664.90837729044;84695.57652211761;9346.813063738688;9391.389559678599;9452.291078169164;9588.952055239679;9672.274579406572;21811.25430877979;22053;22082.779172208073;22196.556068878534;22217.777822221895;7375.4099672026105;7415.406767458699;7477.775666730006;7628.80927976805;7645.388368930472;3985.2826491231276;3985.880423587297;3991.7405368650943;3996.789006835795;4009.218202450494;3534.2578058607464;3543;3614.801185934799;3631.5823680276576;3631.927361452756;615.6613862375675;628.6856571714143;631.722042301386;636.974521019154;641.6791604197902;434.36148861174024;477.77544554059534;479.84405068352925;481.48993834942877;564.5004171308422;5897.49871260939;7912.723054693058;7975.60121993898;8084.231997960184;8243.464174828618;514.1234195696329;516.5712458659303;545.021686073499;599.1761328173761;603.1947350287415;3734.682551983112;3880.4567360569545;3894.1043559981363;3894.9873033011054;3930.6462418382484;91310.0868991315;94167;95557.08885822244;95574.52212738892;96181;75366.24633753592;84425;84583.73124403138;84912;87991.56004219937;65108.070136843955;73912.63043684639;74813.62593187108;75113.62443187748;75151.62424187844;6606.900896486461;7102.893456598258;7564.205758395289;7578.772636820904;7630.694772209049;46645.80187783116;47067.29399058948;47149.05701886012;47332;47577.52422475731;61464;61519.38480615136;65249.04252872422;66158.33841661522;67428.6628566854;10394.58421663125;10395;10485.895141048491;10595.205359598214;10853.565857365616;8864.822703546022;9426.811463770824;10670;11045.502952367002;11256.662300131009;8692.739217823475;10367.222458315808;10373.896261037293;10613.946930265609;10703.518341674488;8773.341999349946;10492.160627149657;10614.885437029001;10726.410047447465;10816.08063314627;10148.340357876714;10177.491125443847;10368.675108184152;10384.480775961021;10515.78968420612;8672.566371681516;8772.56137193125;8829.337799664921;9053.818923621358;9084.818303634023;8640.82718345617;8941.284697224337;9052.954735226282;9155.542222888696;9374.390664606779 04:02:02 INFO - PROCESS | 1692 | __end_tp_report 04:02:02 INFO - PROCESS | 1692 | __start_cc_report 04:02:02 INFO - PROCESS | 1692 | _x_x_mozilla_cycle_collect,415 04:02:02 INFO - PROCESS | 1692 | __end_cc_report 04:02:02 INFO - PROCESS | 1692 | __startTimestamp1463396522366__endTimestamp 04:02:02 INFO - PROCESS | 1692 | 04:02:02 INFO - PROCESS | 1692 | ------- Summary: start ------- 04:02:02 INFO - PROCESS | 1692 | Number of tests: 6 04:02:02 INFO - PROCESS | 1692 | 04:02:02 INFO - PROCESS | 1692 | [#0] dojo.html Cycles:165 Average:5758.44 Median:6060.21 stddev:804.02 (13.3%) stddev-sans-first:785.78 04:02:02 INFO - PROCESS | 1692 | Values: 3447.0 3455.5 3478.7 3498.5 3505.8 5736.0 5835.4 5860.4 5866.4 5929.4 5695.7 5777.7 5805.6 5849.7 5893.8 5188.0 5220.5 5301.8 5312.9 5341.7 173.6 5283.0 5284.6 5307.9 5312.2 5199.3 5206.6 5219.0 5226.7 5314.5 3980.8 5184.7 5262.7 5272.7 5281.8 4902.8 5210.4 5256.3 5294.5 5299.6 5644.5 5783.4 5797.9 5820.9 5882.3 6209.0 6210.0 6211.8 6261.7 6267.6 6181.4 6309.8 6311.6 6325.9 6326.1 6014.9 6022.0 6022.7 6055.8 6056.6 6211.0 6256.9 6270.5 6431.2 6439.1 6216.7 6251.7 6281.4 6288.5 6321.4 6255.7 6259.8 6302.1 6321.2 6324.5 6156.5 6198.4 6225.5 6265.0 6296.9 6169.8 6179.3 6231.9 6259.7 6296.5 5005.8 5008.9 5015.6 5016.3 5039.6 3970.7 4344.6 4477.0 4522.6 4538.5 5880.1 5902.0 5981.2 5981.7 6011.8 6309.6 6316.0 6320.9 6325.3 6337.0 6005.8 6038.2 6053.9 6054.8 6060.2 5002.9 5188.2 5377.7 5437.5 5558.6 4838.6 5403.4 6290.1 6345.0 6540.7 5525.3 6198.3 6327.3 6357.4 6359.1 6363.4 6386.6 6399.8 6441.1 6565.7 5201.7 6263.3 6280.3 6297.3 6300.7 6180.0 6287.9 6305.3 6308.1 6316.2 4839.6 6023.1 6139.2 6201.7 6214.6 6157.4 6202.4 6239.9 6259.5 6277.8 5235.9 5930.1 6153.2 6172.6 6174.6 6118.5 6167.5 6167.9 6238.1 6243.1 6125.7 6153.9 6196.3 6218.8 6224.9 04:02:02 INFO - PROCESS | 1692 | 04:02:02 INFO - PROCESS | 1692 | [#1] ext.html Cycles:180 Average:72493.99 Median:38062.12 stddev:162733.88 (427.5%) stddev-sans-first:163100.68 04:02:02 INFO - PROCESS | 1692 | Values: 525.2 529.3 534.8 574.9 590.7 30885.5 38077.4 38928.2 39271.8 39423.6 40210.8 40841.0 40939.0 41029.4 41108.8 9347.5 9501.2 9558.5 9591.3 9602.0 9447.7 9497.9 9513.9 9515.0 9590.1 9544.4 9577.1 9617.4 9631.6 9635.5 9543.1 9552.4 9601.8 9603.6 9618.8 9476.9 9509.3 9549.1 9605.9 9608.9 31516.7 37703.4 38010.0 38046.8 38334.8 2967.4 3001.6 3144.7 3295.9 3435.4 29108.4 29428.8 29621.4 30156.5 30401.0 2195.7 2756.3 2765.4 2783.2 2835.0 545457.0 548979.0 555381.0 557408.0 559988.0 71496.0 71580.6 71645.0 71654.6 71716.3 37818.6 37975.0 38854.0 40041.2 40067.6 17146.0 17341.6 17613.9 17619.4 17650.0 13265.7 13296.7 13374.9 13385.4 13390.8 21987.8 22079.4 22112.8 22168.2 22213.9 7904.5 9222.3 9222.4 9239.9 9372.4 838.3 897.9 993.8 1050.9 1153.9 29500.6 29756.0 30013.5 30280.7 30296.7 965.3 1054.7 1080.3 1151.7 1165.0 15196.0 15280.4 15310.7 15393.2 15479.4 602209.0 703641.0 709357.0 710182.0 711565.0 57563.7 58426.0 59177.7 59676.0 59739.1 1279.4 1467.2 1470.0 1476.2 1493.5 23843.6 29288.9 29294.0 29727.3 29930.9 50535.7 50831.7 51022.7 51180.7 51204.0 558975.0 570992.0 574986.0 575564.0 576967.1 26404.0 27408.3 27761.4 27767.4 27847.9 44074.3 44442.0 44481.8 44910.3 45225.0 29811.3 37552.8 37690.8 38333.6 38410.0 29494.6 37039.8 37193.4 37574.0 37823.0 36280.1 37152.1 37382.3 37741.4 37866.6 31398.4 32916.2 32920.0 32933.5 33289.2 24358.1 24755.9 24758.3 25223.0 25281.2 04:02:02 INFO - PROCESS | 1692 | 04:02:02 INFO - PROCESS | 1692 | [#2] jquery.html Cycles:180 Average:36433.76 Median:12415.31 stddev:105891.46 (852.9%) stddev-sans-first:106153.86 04:02:02 INFO - PROCESS | 1692 | Values: 352.3 387.9 390.1 396.5 403.4 19063.9 21536.9 21752.0 22065.3 22105.8 20868.9 21738.6 21811.6 21894.5 22389.8 5446.3 5461.1 5941.1 5982.2 6006.4 5587.3 5892.6 5898.9 5904.2 5938.9 5787.6 5789.3 5792.8 5795.4 5797.3 5620.7 5760.2 5786.3 5818.1 5895.4 5125.3 5146.2 5157.1 5164.9 5166.4 25488.2 26330.9 26599.6 26608.0 26837.6 2117.3 2119.4 2141.8 2440.9 2582.8 14863.8 15242.6 15278.8 15398.8 15406.4 1384.6 1727.2 1733.5 1757.2 1790.5 97019.0 120755.0 121047.0 121095.0 121832.0 7824.4 8883.9 9416.3 10043.2 10721.3 12264.4 12453.7 12481.1 12568.1 12583.6 7458.0 7602.0 8293.8 8296.3 8452.7 8693.0 8700.3 8707.0 8717.6 8839.2 3324.7 3613.8 3742.0 4021.4 4106.8 1708.6 1891.8 2020.7 2035.9 2045.8 839.5 992.2 1000.3 1032.0 1035.6 19693.0 20311.9 20372.8 20549.9 20747.3 907.3 950.2 970.3 1026.7 1053.2 10400.5 10743.0 10753.2 10805.8 10838.1 620731.0 630914.0 632413.0 639549.0 646375.0 127579.4 135855.0 138235.0 144275.3 150161.5 968.2 998.5 1018.8 1020.5 1049.6 18001.1 18151.5 18162.5 18307.9 18316.2 33829.7 53985.2 56314.0 57813.1 57882.7 81832.0 84937.2 85921.0 86981.6 87569.1 7692.0 7980.2 8017.4 8028.2 8077.6 11516.9 12003.6 12403.8 12475.8 12576.4 10273.7 10713.7 10727.6 10753.4 10902.8 10289.0 10523.8 10696.9 10816.2 11035.6 10772.5 10961.3 10993.1 11065.3 11174.4 6847.9 7834.8 7973.5 8018.0 8038.2 8183.1 10779.5 11114.2 11341.7 11374.5 04:02:02 INFO - PROCESS | 1692 | 04:02:02 INFO - PROCESS | 1692 | [#3] mootools.html Cycles:180 Average:5767.65 Median:4869.02 stddev:3239.56 (66.5%) stddev-sans-first:3233.50 04:02:02 INFO - PROCESS | 1692 | Values: 1599.8 1641.7 1907.5 1972.8 2006.2 8185.8 8776.0 8799.9 9324.9 9325.3 8871.6 8958.7 9092.5 9114.6 9143.5 2397.0 2403.7 2423.2 2434.8 2437.1 2399.0 2401.8 2420.3 2426.4 2446.8 2087.6 2420.7 2429.5 2435.7 2436.0 2035.6 2392.7 2394.4 2407.4 2427.6 2339.8 2401.9 2402.5 2403.5 2405.8 7707.0 7888.7 9165.3 9170.6 9194.8 5419.8 5599.5 5600.0 5608.1 5612.6 3516.7 3582.9 3585.2 3660.9 3684.7 1034.5 1042.0 1043.0 1053.6 1058.8 10085.8 12007.9 12187.3 12242.3 12266.5 4849.7 4875.3 4972.5 4976.7 5027.9 10196.7 10231.0 10250.7 10261.3 10268.8 5463.3 5543.9 5547.7 5552.8 5560.5 4525.9 4848.1 4984.2 5029.9 5036.2 3443.9 4049.3 4155.8 4189.5 4259.0 1191.0 1355.9 1363.0 1364.9 1376.3 822.1 850.0 892.7 902.6 934.4 5552.7 5728.2 5868.6 5967.9 6032.4 935.5 955.4 962.0 971.1 1014.1 3810.3 3886.4 3928.5 3959.6 3991.0 10465.9 11064.7 11083.9 11088.5 11121.3 10571.7 10896.0 11025.8 11026.4 11187.3 8286.2 8436.0 8440.7 8480.3 8515.7 5656.7 5728.9 5753.0 5820.0 5837.2 8351.4 9939.1 10119.4 10163.3 10190.2 8960.5 10018.5 10214.7 10353.7 10353.9 5769.2 6726.4 6780.0 7639.0 7789.5 7916.8 8516.8 8560.7 8584.6 8595.7 7480.2 7563.8 7605.5 7657.0 7715.2 7466.9 7489.6 7578.2 7654.6 7695.6 5942.7 7202.7 7231.8 7237.2 7239.7 3831.5 4341.0 4732.7 4834.6 4916.5 4862.8 4894.0 4946.1 4967.8 4992.3 04:02:02 INFO - PROCESS | 1692 | 04:02:02 INFO - PROCESS | 1692 | [#4] prototype.html Cycles:180 Average:4466.35 Median:4939.75 stddev:1423.93 (28.8%) stddev-sans-first:1393.23 04:02:02 INFO - PROCESS | 1692 | Values: 304.2 314.2 320.6 321.4 325.4 4444.8 5338.7 5540.0 5590.7 5599.7 5279.7 5369.9 5430.7 5484.7 5519.9 4138.4 4139.6 4151.5 4161.5 4168.2 3369.3 3837.5 4131.6 4133.6 4170.3 4055.9 4059.9 4069.0 4082.9 4119.8 3762.3 3766.5 4074.8 4121.0 4141.6 3559.9 3562.7 3571.6 3576.7 3585.0 3995.8 4490.7 5188.8 5277.8 5289.2 4560.1 4682.3 4711.5 4722.9 4748.3 5047.2 5267.8 5730.5 5733.4 5738.4 3614.6 3651.9 3882.2 3922.3 3948.8 4898.9 4971.9 6076.4 6079.5 6106.2 3215.2 3320.3 3605.1 3975.7 3977.0 3110.7 3155.3 3228.7 4020.3 4050.5 3644.9 3999.5 4665.4 4695.6 4732.2 5149.7 5417.0 5530.6 5615.9 5628.3 1231.4 1243.6 1309.2 1334.4 1369.6 690.6 711.5 818.5 841.3 853.2 3893.7 4147.5 4511.8 4552.7 4623.5 4270.3 4572.4 5055.2 5144.4 5155.7 4133.8 4172.9 4517.6 4519.4 4532.2 2153.6 2370.8 2378.9 2530.6 2593.8 4793.8 4941.6 5298.8 5302.7 5307.3 4764.9 5121.8 5167.6 5194.1 5240.7 4937.9 5735.6 6184.2 6188.4 6199.9 5270.1 5361.6 5550.8 5954.8 5998.9 5587.3 5771.8 5861.8 5906.0 5909.0 4992.6 5459.7 5933.4 6130.2 6257.0 3365.8 3942.7 3982.2 3994.9 4001.6 5016.0 5658.9 5676.3 5845.7 5875.0 5581.6 5744.8 5750.2 5810.2 5812.8 4930.4 5416.0 5536.7 5865.3 5909.3 4882.8 5017.7 5052.5 5476.4 5747.8 5157.3 5803.0 5823.2 5836.8 5872.8 5177.7 5701.4 5762.8 5784.4 5801.4 04:02:02 INFO - PROCESS | 1692 | 04:02:02 INFO - PROCESS | 1692 | [#5] yui.html Cycles:180 Average:18229.53 Median:630.20 stddev:26384.60 (4186.7%) stddev-sans-first:26425.62 04:02:02 INFO - PROCESS | 1692 | Values: 655.4 715.5 752.3 755.2 764.2 12174.3 15082.0 15361.3 15537.5 15579.3 11292.5 11518.7 14495.8 14507.9 14733.0 736.6 889.3 896.3 903.4 904.2 875.0 901.1 904.7 906.0 908.5 940.6 962.1 970.0 970.1 973.9 935.2 938.3 945.9 964.4 965.1 700.6 717.1 717.4 717.6 717.6 14785.3 14879.0 14889.5 14892.6 14908.5 12506.7 12567.7 12570.9 12606.6 12870.9 10008.8 10033.9 10045.4 10248.2 10387.0 3503.4 3519.8 3542.1 3591.0 3595.4 81365.8 81677.6 83396.0 83664.9 84695.6 9346.8 9391.4 9452.3 9589.0 9672.3 21811.3 22053.0 22082.8 22196.6 22217.8 7375.4 7415.4 7477.8 7628.8 7645.4 3985.3 3985.9 3991.7 3996.8 4009.2 3534.3 3543.0 3614.8 3631.6 3631.9 615.7 628.7 631.7 637.0 641.7 434.4 477.8 479.8 481.5 564.5 5897.5 7912.7 7975.6 8084.2 8243.5 514.1 516.6 545.0 599.2 603.2 3734.7 3880.5 3894.1 3895.0 3930.6 91310.1 94167.0 95557.1 95574.5 96181.0 75366.2 84425.0 84583.7 84912.0 87991.6 65108.1 73912.6 74813.6 75113.6 75151.6 6606.9 7102.9 7564.2 7578.8 7630.7 46645.8 47067.3 47149.1 47332.0 47577.5 61464.0 61519.4 65249.0 66158.3 67428.7 10394.6 10395.0 10485.9 10595.2 10853.6 8864.8 9426.8 10670.0 11045.5 11256.7 8692.7 10367.2 10373.9 10613.9 10703.5 8773.3 10492.2 10614.9 10726.4 10816.1 10148.3 10177.5 10368.7 10384.5 10515.8 8672.6 8772.6 8829.3 9053.8 9084.8 8640.8 8941.3 9053.0 9155.5 9374.4 04:02:02 INFO - PROCESS | 1692 | -------- Summary: end -------- 04:02:02 INFO - PROCESS | 1692 | 04:02:02 INFO - TEST-INFO | 1692: exit 0 04:02:02 INFO - TEST-OK | dromaeo_css | took 1112031ms 04:02:02 INFO - TEST-START | kraken 04:02:02 INFO - operating with platform_type : mac_ 04:02:02 INFO - Initialising browser for kraken test... 04:02:02 INFO - TEST-INFO | started process 1704 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/tmpQXAOf_/profile http://localhost:49275/getInfo.html) 04:02:05 INFO - PROCESS | 1704 | __metrics Screen width/height:1600/1200 04:02:05 INFO - PROCESS | 1704 | colorDepth:24 04:02:05 INFO - PROCESS | 1704 | Browser inner width/height: 1024/689 04:02:05 INFO - PROCESS | 1704 | __metrics 04:02:05 ERROR - PROCESS | 1704 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2946: TypeError: this.tabs is undefined 04:02:06 INFO - TEST-INFO | 1704: exit 0 04:02:06 INFO - Browser initialized. 04:02:06 INFO - Running cycle 1/1 for kraken test... 04:02:06 INFO - TEST-INFO | started process 1707 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/tmpQXAOf_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:02:18 INFO - PROCESS | 1707 | RSS: Main: 250298368 04:02:18 INFO - PROCESS | 1707 | 04:02:21 INFO - PROCESS | 1707 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-beat-detection) 04:02:22 INFO - PROCESS | 1707 | RSS: Main: 262184960 04:02:22 INFO - PROCESS | 1707 | 04:02:24 INFO - PROCESS | 1707 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-dft) 04:02:25 INFO - PROCESS | 1707 | RSS: Main: 267411456 04:02:25 INFO - PROCESS | 1707 | 04:02:29 INFO - PROCESS | 1707 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-fft) 04:02:29 INFO - PROCESS | 1707 | RSS: Main: 267251712 04:02:29 INFO - PROCESS | 1707 | 04:02:31 INFO - PROCESS | 1707 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-oscillator) 04:02:32 INFO - PROCESS | 1707 | RSS: Main: 267915264 04:02:32 INFO - PROCESS | 1707 | 04:02:34 INFO - PROCESS | 1707 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:02:35 INFO - PROCESS | 1707 | RSS: Main: 268390400 04:02:35 INFO - PROCESS | 1707 | 04:02:38 INFO - PROCESS | 1707 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-darkroom) 04:02:39 INFO - PROCESS | 1707 | RSS: Main: 268890112 04:02:39 INFO - PROCESS | 1707 | 04:02:42 INFO - PROCESS | 1707 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-desaturate) 04:02:43 INFO - PROCESS | 1707 | RSS: Main: 267972608 04:02:43 INFO - PROCESS | 1707 | 04:02:46 INFO - PROCESS | 1707 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49275/tests/kraken/driver.html?testName=json-parse-financial) 04:02:47 INFO - PROCESS | 1707 | RSS: Main: 267808768 04:02:47 INFO - PROCESS | 1707 | 04:02:48 INFO - PROCESS | 1707 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49275/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:02:49 INFO - PROCESS | 1707 | RSS: Main: 267567104 04:02:49 INFO - PROCESS | 1707 | 04:02:51 INFO - PROCESS | 1707 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:02:52 INFO - PROCESS | 1707 | RSS: Main: 267677696 04:02:52 INFO - PROCESS | 1707 | 04:02:54 INFO - PROCESS | 1707 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:02:55 INFO - PROCESS | 1707 | RSS: Main: 268533760 04:02:55 INFO - PROCESS | 1707 | 04:02:57 INFO - PROCESS | 1707 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:02:58 INFO - PROCESS | 1707 | RSS: Main: 268132352 04:02:58 INFO - PROCESS | 1707 | 04:03:01 INFO - PROCESS | 1707 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:03:02 INFO - PROCESS | 1707 | RSS: Main: 268795904 04:03:02 INFO - PROCESS | 1707 | 04:03:03 INFO - PROCESS | 1707 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49275/tests/kraken/driver.html?testName=ai-astar) 04:03:04 INFO - PROCESS | 1707 | RSS: Main: 270979072 04:03:04 INFO - PROCESS | 1707 | 04:03:04 INFO - PROCESS | 1707 | __start_tp_report 04:03:04 INFO - PROCESS | 1707 | _x_x_mozilla_page_load 04:03:04 INFO - PROCESS | 1707 | _x_x_mozilla_page_load_details 04:03:04 INFO - PROCESS | 1707 | |i|pagename|runs| 04:03:04 INFO - PROCESS | 1707 | |0;ai-astar;116;115;126;171;124;118;102;170;98;158 04:03:04 INFO - PROCESS | 1707 | |1;audio-beat-detection;155;125;143;198;122;149;141;128;165;120 04:03:04 INFO - PROCESS | 1707 | |2;audio-dft;196;202;247;235;272;234;196;195;200;194 04:03:04 INFO - PROCESS | 1707 | |3;audio-fft;69;82;74;173;58;59;58;61;153;82 04:03:04 INFO - PROCESS | 1707 | |4;audio-oscillator;79;82;155;77;83;82;120;80;82;124 04:03:04 INFO - PROCESS | 1707 | |5;imaging-gaussian-blur;137;131;85;132;135;88;135;130;84;130 04:03:04 INFO - PROCESS | 1707 | |6;imaging-darkroom;96;127;151;150;130;149;98;147;96;97 04:03:04 INFO - PROCESS | 1707 | |7;imaging-desaturate;91;93;91;91;91;100;149;91;120;153 04:03:04 INFO - PROCESS | 1707 | |8;json-parse-financial;60;62;60;61;62;60;58;60;60;60 04:03:04 INFO - PROCESS | 1707 | |9;json-stringify-tinderbox;66;68;67;75;77;78;73;65;69;66 04:03:04 INFO - PROCESS | 1707 | |10;stanford-crypto-aes;87;87;87;83;87;85;88;87;150;85 04:03:04 INFO - PROCESS | 1707 | |11;stanford-crypto-ccm;137;141;148;153;148;135;136;134;150;140 04:03:04 INFO - PROCESS | 1707 | |12;stanford-crypto-pbkdf2;170;164;167;165;169;162;146;202;211;208 04:03:04 INFO - PROCESS | 1707 | |13;stanford-crypto-sha256-iterative;66;67;66;64;68;63;64;68;68;65 04:03:04 INFO - PROCESS | 1707 | __end_tp_report 04:03:04 INFO - PROCESS | 1707 | __start_cc_report 04:03:04 INFO - PROCESS | 1707 | _x_x_mozilla_cycle_collect,1086 04:03:04 INFO - PROCESS | 1707 | __end_cc_report 04:03:04 INFO - PROCESS | 1707 | __startTimestamp1463396584089__endTimestamp 04:03:04 INFO - PROCESS | 1707 | 04:03:04 INFO - PROCESS | 1707 | ------- Summary: start ------- 04:03:04 INFO - PROCESS | 1707 | Number of tests: 14 04:03:04 INFO - PROCESS | 1707 | 04:03:04 INFO - PROCESS | 1707 | [#0] ai-astar Cycles:10 Average:129.80 Median:142.00 stddev:26.85 (18.9%) stddev-sans-first:28.01 04:03:04 INFO - PROCESS | 1707 | Values: 116.0 115.0 126.0 171.0 124.0 118.0 102.0 170.0 98.0 158.0 04:03:04 INFO - PROCESS | 1707 | 04:03:04 INFO - PROCESS | 1707 | [#1] audio-beat-detection Cycles:10 Average:144.60 Median:146.00 stddev:24.01 (16.4%) stddev-sans-first:25.17 04:03:04 INFO - PROCESS | 1707 | Values: 155.0 125.0 143.0 198.0 122.0 149.0 141.0 128.0 165.0 120.0 04:03:04 INFO - PROCESS | 1707 | 04:03:04 INFO - PROCESS | 1707 | [#2] audio-dft Cycles:10 Average:217.10 Median:218.00 stddev:27.78 (12.7%) stddev-sans-first:28.40 04:03:04 INFO - PROCESS | 1707 | Values: 196.0 202.0 247.0 235.0 272.0 234.0 196.0 195.0 200.0 194.0 04:03:04 INFO - PROCESS | 1707 | 04:03:04 INFO - PROCESS | 1707 | [#3] audio-fft Cycles:10 Average:86.90 Median:65.00 stddev:41.42 (63.7%) stddev-sans-first:43.42 04:03:04 INFO - PROCESS | 1707 | Values: 69.0 82.0 74.0 173.0 58.0 59.0 58.0 61.0 153.0 82.0 04:03:04 INFO - PROCESS | 1707 | 04:03:04 INFO - PROCESS | 1707 | [#4] audio-oscillator Cycles:10 Average:96.40 Median:81.00 stddev:26.88 (33.2%) stddev-sans-first:27.76 04:03:04 INFO - PROCESS | 1707 | Values: 79.0 82.0 155.0 77.0 83.0 82.0 120.0 80.0 82.0 124.0 04:03:04 INFO - PROCESS | 1707 | 04:03:04 INFO - PROCESS | 1707 | [#5] imaging-gaussian-blur Cycles:10 Average:118.70 Median:136.00 stddev:22.93 (16.9%) stddev-sans-first:23.35 04:03:04 INFO - PROCESS | 1707 | Values: 137.0 131.0 85.0 132.0 135.0 88.0 135.0 130.0 84.0 130.0 04:03:04 INFO - PROCESS | 1707 | 04:03:04 INFO - PROCESS | 1707 | [#6] imaging-darkroom Cycles:10 Average:124.10 Median:123.50 stddev:24.89 (20.2%) stddev-sans-first:24.24 04:03:04 INFO - PROCESS | 1707 | Values: 96.0 127.0 151.0 150.0 130.0 149.0 98.0 147.0 96.0 97.0 04:03:04 INFO - PROCESS | 1707 | 04:03:04 INFO - PROCESS | 1707 | [#7] imaging-desaturate Cycles:10 Average:107.00 Median:91.00 stddev:24.89 (27.3%) stddev-sans-first:25.71 04:03:04 INFO - PROCESS | 1707 | Values: 91.0 93.0 91.0 91.0 91.0 100.0 149.0 91.0 120.0 153.0 04:03:04 INFO - PROCESS | 1707 | 04:03:04 INFO - PROCESS | 1707 | [#8] json-parse-financial Cycles:10 Average:60.30 Median:60.00 stddev:1.16 (1.9%) stddev-sans-first:1.22 04:03:04 INFO - PROCESS | 1707 | Values: 60.0 62.0 60.0 61.0 62.0 60.0 58.0 60.0 60.0 60.0 04:03:04 INFO - PROCESS | 1707 | 04:03:04 INFO - PROCESS | 1707 | [#9] json-stringify-tinderbox Cycles:10 Average:70.40 Median:71.00 stddev:4.90 (6.9%) stddev-sans-first:4.94 04:03:04 INFO - PROCESS | 1707 | Values: 66.0 68.0 67.0 75.0 77.0 78.0 73.0 65.0 69.0 66.0 04:03:04 INFO - PROCESS | 1707 | 04:03:04 INFO - PROCESS | 1707 | [#10] stanford-crypto-aes Cycles:10 Average:92.60 Median:87.00 stddev:20.22 (23.2%) stddev-sans-first:21.35 04:03:04 INFO - PROCESS | 1707 | Values: 87.0 87.0 87.0 83.0 87.0 85.0 88.0 87.0 150.0 85.0 04:03:04 INFO - PROCESS | 1707 | 04:03:04 INFO - PROCESS | 1707 | [#11] stanford-crypto-ccm Cycles:10 Average:142.20 Median:144.50 stddev:6.96 (4.8%) stddev-sans-first:7.12 04:03:04 INFO - PROCESS | 1707 | Values: 137.0 141.0 148.0 153.0 148.0 135.0 136.0 134.0 150.0 140.0 04:03:04 INFO - PROCESS | 1707 | 04:03:04 INFO - PROCESS | 1707 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:176.40 Median:169.50 stddev:22.24 (13.1%) stddev-sans-first:23.47 04:03:04 INFO - PROCESS | 1707 | Values: 170.0 164.0 167.0 165.0 169.0 162.0 146.0 202.0 211.0 208.0 04:03:04 INFO - PROCESS | 1707 | 04:03:04 INFO - PROCESS | 1707 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.90 Median:66.50 stddev:1.85 (2.8%) stddev-sans-first:1.96 04:03:04 INFO - PROCESS | 1707 | Values: 66.0 67.0 66.0 64.0 68.0 63.0 64.0 68.0 68.0 65.0 04:03:04 INFO - PROCESS | 1707 | -------- Summary: end -------- 04:03:04 INFO - PROCESS | 1707 | 04:03:04 INFO - TEST-INFO | 1707: exit 0 04:03:04 INFO - TEST-OK | kraken | took 61928ms 04:03:04 INFO - SUITE-END | took 1173s 04:03:05 INFO - Completed test suite (00:19:34) 04:03:05 INFO - javascript benchmark 04:03:05 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7158.841719633137, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3446.9655303446975, 3455.464403017533, 3478.652134786522, 3498.5102085708, 3505.7545971781988, 5735.971320143399, 5835.445632664895, 5860.443257890504, 5866.413358664131, 5929.4367035131645, 5695.7152142392815, 5777.7111144442715, 5805.564582656307, 5849.678267695275, 5893.764249430018, 5187.974060129694, 5220.451852555484, 5301.787928482856, 5312.893742125155, 5341.679499230039, 173.61130432169736, 5282.973585132069, 5284.603654725892, 5307.893842123155, 5312.1766126250495, 5199.324087868591, 5206.635535512534, 5219.0, 5226.7125308108225, 5314.468553144693, 3980.840766369342, 5184.662996905189, 5262.710550919698, 5272.710000949946, 5281.788728450896, 4902.828401005983, 5210.426853046162, 5256.290400795881, 5294.52349288562, 5299.6025298102795, 5644.520215781664, 5783.363829978741, 5797.913031304533, 5820.912686309709, 5882.264716910387, 6209.037599172136, 6210.0, 6211.81364559064, 6261.655608941506, 6267.592606480564, 6181.443670069671, 6309.779157729503, 6311.589746666452, 6325.9051114233325, 6326.051092336186, 6014.909776353358, 6022.0, 6022.6687532185715, 6055.757769689163, 6056.606320589148, 6210.968945155245, 6256.906146407808, 6270.467010304084, 6431.163948686641, 6439.130717353098, 6216.658083805434, 6251.6561589113035, 6281.403266689657, 6288.465480434214, 6321.399467050623, 6255.749770009149, 6259.78090766821, 6302.086197501337, 6321.241451025906, 6324.494040476751, 6156.538259630545, 6198.380161983856, 6225.470834978987, 6265.0, 6296.905546416808, 6169.81490555284, 6179.3202747697715, 6231.906521402183, 6259.749610015549, 6296.496280297565, 5005.824796132118, 5008.874778130576, 5015.623828212899, 5016.297718319438, 5039.571636410946, 3970.7220494565104, 4344.630706389929, 4477.0, 4522.570355816192, 4538.455385353713, 5880.147378630075, 5902.026165682701, 5981.222441082631, 5981.700914954322, 6011.849703757353, 6309.621422714652, 6316.0, 6320.873582528324, 6325.304216536178, 6337.0, 6005.819825405245, 6038.215032045806, 6053.909191362133, 6054.757809687651, 6060.212172417646, 5002.949380630036, 5188.169892817131, 5377.704226267515, 5437.45625437461, 5558.583106267046, 4838.588719958772, 5403.4059952314165, 6290.119383286344, 6345.0, 6540.672966351759, 5525.336959564878, 6198.318184999556, 6327.303996560467, 6357.396047375492, 6359.07793369968, 6363.363663633785, 6386.648734319657, 6399.776007839703, 6441.098246245436, 6565.671716414256, 5201.7399130044105, 6263.342349053284, 6280.277768056732, 6297.307296197323, 6300.716467759054, 6179.969100154471, 6287.905681414874, 6305.274893387319, 6308.08532762756, 6316.178896743394, 4839.612830973584, 6023.134628065941, 6139.2161661365335, 6201.6899155041165, 6214.627122372672, 6157.415045570664, 6202.4417802398, 6239.906401403891, 6259.467945224525, 6277.780277690442, 5235.895282094413, 5930.11048342752, 6153.230846144232, 6172.567920245539, 6174.598651087665, 6118.479929206067, 6167.506599472121, 6167.876642467036, 6238.095476156022, 6243.094751260951, 6125.663088530174, 6153.907691384543, 6196.349383314868, 6218.782342617987, 6224.937750622617], "value": 5710.633107299378, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [525.1545012529826, 529.2828217764928, 534.8154886564135, 574.8649067469146, 590.6975119860707, 30885.536716949235, 38077.42883856741, 38928.22143557127, 39271.82184534468, 39423.60576394235, 40210.7989460053, 40841.0, 40939.0, 41029.384559231636, 41108.794456027754, 9347.532623368821, 9501.23990080792, 9558.474283914382, 9591.280653950947, 9602.039796020412, 9447.716568502956, 9497.857532136988, 9513.857292140623, 9515.0, 9590.136887680108, 9544.427334359925, 9577.138057574817, 9617.37487063342, 9631.566579503904, 9635.518224088803, 9543.093406126442, 9552.379095358814, 9601.759956001086, 9603.615855365777, 9618.75953101171, 9476.857847132229, 9509.33434659574, 9549.09283618055, 9605.90394096057, 9608.855867161998, 31516.684833151605, 37703.4344484833, 38010.0, 38046.80976595127, 38334.80832595819, 2967.421352836198, 3001.5947847040807, 3144.716975472196, 3295.9452975047993, 3435.3644575753565, 29108.417831643248, 29428.822847086092, 29621.407571848442, 30156.54765178524, 30401.0, 2195.70453432474, 2756.2833663247497, 2765.4469106178844, 2783.2067860659613, 2834.957475637867, 545457.0, 548979.0, 555381.0, 557408.0, 559988.0, 71496.0, 71580.64209678919, 71645.0, 71654.64172679103, 71716.28283717201, 37818.62181378206, 37975.0, 38854.0, 40041.199176016315, 40067.59932400638, 17146.0, 17341.566460838327, 17613.91193044052, 17619.383321583682, 17650.0, 13265.734685306239, 13296.73406531864, 13374.933125334312, 13385.397657105454, 13390.799138012937, 21987.780122198892, 22079.44801379946, 22112.77887221107, 22168.224112155996, 22213.888930555244, 7904.525728456311, 9222.262219022463, 9222.44665320083, 9239.861402078974, 9372.437653740797, 838.3419016072354, 897.9012308646044, 993.8111758765812, 1050.8949105089582, 1153.938376693444, 29500.557491637643, 29756.0, 30013.549796753065, 30280.697193028227, 30296.697033029828, 965.3242730088966, 1054.6974486509155, 1080.2978064258295, 1151.6717735445359, 1164.976700466003, 15196.0, 15280.388784448498, 15310.693786124215, 15393.230338483256, 15479.380824766884, 602209.0, 703641.0, 709357.0, 710182.0, 711565.0, 57563.71218143882, 58426.0, 59177.704111479165, 59676.0, 59739.10391344134, 1279.3795009420423, 1467.185711929889, 1470.0150898897764, 1476.2102275282673, 1493.529538195465, 23843.64234536518, 29288.853555732087, 29294.0, 29727.256818578844, 29930.85034574813, 50535.73660658366, 50831.74584127056, 51022.74488627533, 51180.72048198676, 51203.975920482124, 558975.0, 570992.0, 574986.0, 575564.0, 576967.1151644215, 26404.0, 27408.314792130357, 27761.44477110406, 27767.444651107267, 27847.88608455639, 44074.33888491739, 44442.0, 44481.77759111184, 44910.32634510419, 45225.0, 29811.254718632208, 37552.81223593974, 37690.811545942095, 38333.616663833, 38410.0397490065, 29494.557581636724, 37039.81480092582, 37193.44209836909, 37574.0, 37823.0, 36280.09299767527, 37152.07119822026, 37382.2523549522, 37741.4338784924, 37866.62133378631, 31398.372032559677, 32916.177095571846, 32920.0, 32933.50599740958, 33289.16777080592, 24358.147464838647, 24755.876220619502, 24758.25725228246, 25223.0, 25281.241562753148], "value": 19832.366086583275, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [352.29892513897335, 387.9282332768438, 390.13584909425623, 396.5320921312851, 403.4029636138517, 19063.904680476597, 21536.89231553844, 21752.0, 22065.33803985879, 22105.778942210574, 20868.852213128273, 21738.565228695457, 21811.563768724616, 21894.45263868404, 22389.77610223897, 5446.264754258164, 5461.126219804832, 5941.138534912435, 5982.222311099573, 6006.369331220225, 5587.329520457531, 5892.558058145656, 5898.911516327237, 5904.1734157218025, 5938.910916336258, 5787.565932555054, 5789.305283366002, 5792.7972520961775, 5795.420457954192, 5797.333306669724, 5620.747066382022, 5760.222369980062, 5786.305643322808, 5818.06910894257, 5895.410458954113, 5125.256837758541, 5146.202338637517, 5157.071727089123, 5164.896702065976, 5166.354205724285, 25488.235352939257, 26330.868345658342, 26599.601005984925, 26608.0, 26837.597436038475, 2117.3224568138203, 2119.406566161462, 2141.7536983246814, 2440.8535487870786, 2582.7546383093763, 14863.777043344358, 15242.618934526614, 15278.847211527853, 15398.76901846462, 15406.3837446502, 1384.5777038003405, 1727.231382034995, 1733.5319463744845, 1757.2180379731026, 1790.4807605794304, 97019.02980970171, 120755.0, 121047.0, 121095.0, 121832.0, 7824.413169012347, 8883.889513810773, 9416.293777966543, 10043.19654427644, 10721.30311529748, 12264.38678066093, 12453.688657783629, 12481.126321157431, 12568.057395695176, 12583.622491325092, 7458.0, 7602.0, 8293.792655183668, 8296.336293096538, 8452.74641760748, 8692.95653521741, 8700.30397568193, 8706.956465217634, 8717.564121793885, 8839.248663863515, 3324.73402127834, 3613.837377317974, 3741.9812900935867, 4021.3967904814513, 4106.753594784323, 1708.5557754983793, 1891.7919028906808, 2020.7474065741783, 2035.8574899756875, 2045.8261047811102, 839.5340585974842, 992.1566668332005, 1000.2797985450464, 1032.0092710997376, 1035.6064695415844, 19693.0, 20311.898440507703, 20372.777633342048, 20549.89725051365, 20747.273845415337, 907.2515174980667, 950.1686024728363, 970.2868391732071, 1026.7330494071596, 1053.210092430677, 10400.543923850668, 10743.0, 10753.193510486588, 10805.843426145586, 10838.132949364031, 620731.0, 630914.0, 632413.0, 639549.0, 646375.0, 127579.36210318889, 135855.0, 138235.0, 144275.27862360832, 150161.49838501692, 968.2447690801187, 998.4708104704373, 1018.7504061504978, 1020.4999550220487, 1049.606397600915, 18001.099945002436, 18151.455456335803, 18162.45512634623, 18307.908460457613, 18316.175772090555, 33829.66170338265, 53985.19022214592, 56314.0, 57813.132803007145, 57882.710586446796, 81832.0, 84937.15062849292, 85921.0, 86981.56509217413, 87569.1243087561, 7692.0384951881015, 7980.162082981204, 8017.358611311198, 8028.197180282159, 8077.555734434663, 11516.884831151916, 12003.579874704343, 12403.813942791046, 12475.812862807246, 12576.434060467118, 10273.691789246335, 10713.732156695833, 10727.624533141303, 10753.354798712102, 10902.781944361226, 10289.0, 10523.810940242052, 10696.946515267375, 10816.242862999829, 11035.565376501003, 10772.461376930965, 10961.342319460859, 10993.120550356112, 11065.280756750786, 11174.385408802595, 6847.931520684929, 7834.764957051298, 7973.481723687942, 8017.959910200411, 8038.196180381915, 8183.140770219041, 10779.461026948464, 11114.22200445961, 11341.695704994032, 11374.545018199511], "value": 9516.237393622268, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1599.7520384340428, 1641.7044931912258, 1907.4563749331444, 1972.8495939426032, 2006.2476571285767, 8185.8362832743305, 8775.956120219398, 8799.91200087999, 9324.906750932489, 9325.253979681625, 8871.556422178897, 8958.686445974392, 9092.545372731354, 9114.589843457044, 9143.542822858846, 2397.0411835265904, 2403.6995375578053, 2423.248792874215, 2434.817388695846, 2437.122635851101, 2398.9880050599722, 2401.819863510235, 2420.298113547069, 2426.3934016495878, 2446.804255659543, 2087.6242276390244, 2420.745821688724, 2429.538387706339, 2435.7320694723567, 2436.049940523197, 2035.5827055453597, 2392.665026896227, 2394.413368724665, 2407.398150462393, 2427.5751743444825, 2339.754325795784, 2401.915932942356, 2402.5435167318155, 2403.5072810073893, 2405.7714517120844, 7706.961465192639, 7888.684452621888, 9165.266778657691, 9170.587323570455, 9194.770130746718, 5419.83740487786, 5599.524040456566, 5599.972000140014, 5608.130739735348, 5612.635178713412, 3516.683498485123, 3582.8925132246072, 3585.229175727231, 3660.9267814643827, 3684.7236457265813, 1034.534459493231, 1042.030911252535, 1042.9947850260776, 1053.5891002509027, 1058.772363941756, 10085.840128385184, 12007.93996030023, 12187.268763874195, 12242.265464072096, 12266.509339626404, 4849.660523763303, 4875.293082503017, 4972.5027497249985, 4976.701397916137, 5027.924581131286, 10196.694099177037, 10231.028052335016, 10250.692479225636, 10261.28171028021, 10268.794624107626, 5463.289772329572, 5543.944560554423, 5547.722613869371, 5552.7778888844805, 5560.499555039985, 4525.886852828706, 4848.10310092634, 4984.177610694195, 5029.899402012013, 5036.244563315532, 3443.8794642187404, 4049.271131196413, 4155.833766649361, 4189.518205406417, 4259.0, 1191.0233608440994, 1355.9186448813102, 1362.9522966696118, 1364.938577764003, 1376.291210026837, 822.0751654388813, 850.0012485329713, 892.683097500378, 902.6389444222364, 934.3646320501988, 5552.7223638817895, 5728.169415434739, 5868.647881127146, 5967.880642387128, 6032.3967603239325, 935.5135329628555, 955.4267439536361, 961.9615215391306, 971.0920289529313, 1014.06705830636, 3810.333191691443, 3886.417037444406, 3928.52857657083, 3959.604039596075, 3991.042149884007, 10465.9476702616, 11064.723381915517, 11083.944580277048, 11088.501017454233, 11121.332720036824, 10571.735706607396, 10896.019358257794, 11025.779484410266, 11026.44867756609, 11187.32876027441, 8286.212809783061, 8436.029856566573, 8440.704575339956, 8480.279176270085, 8515.659373624985, 5656.660600363992, 5728.8567785804025, 5753.0, 5820.01329089575, 5837.211976383134, 8351.373646976379, 9939.055789700256, 10119.443430611387, 10163.288569800043, 10190.235732319958, 8960.462372257425, 10018.549165287724, 10214.744631384276, 10353.689389318333, 10353.896461035594, 5769.249997500298, 6726.3609957054005, 6779.966100169468, 7638.961805190938, 7789.532628042336, 7916.762497125095, 8516.829663406574, 8560.743177704679, 8584.613692383733, 8595.65617375298, 7480.2145774695055, 7563.773086807405, 7605.505642133244, 7657.004589403342, 7715.189905059888, 7466.930522864943, 7489.550626962399, 7578.204288549843, 7654.578998154932, 7695.615219239127, 5942.702864856654, 7202.675879585327, 7231.819204519929, 7237.240089790706, 7239.746608868664, 3831.463595096633, 4341.0, 4732.6687131900435, 4834.564889159992, 4916.459189489225, 4862.756862156807, 4893.951060489349, 4946.109700253989, 4967.776450059829, 4992.2761199626575], "value": 4644.408281701785, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [304.16810024582776, 314.2175981805305, 320.5752378099019, 321.40700407747704, 325.43049663089596, 4444.79998400072, 5338.652987555816, 5539.977908063553, 5590.692511911843, 5599.664020158793, 5279.736013199344, 5369.9463005369935, 5430.67415955043, 5484.683675917771, 5519.917201241985, 4138.399932009849, 4139.56534563871, 4151.522574903895, 4161.479815023122, 4168.24933527919, 3369.275605744777, 3837.5417341410225, 4131.648809851151, 4133.607307305816, 4170.291050521419, 4055.878323650295, 4059.8985025374454, 4068.9796551017203, 4082.8979275518054, 4119.773412462313, 3762.3415902217002, 3766.5498782968616, 4074.8370065197355, 4121.0, 4141.585841415835, 3559.94660080099, 3562.71498280137, 3571.62497937718, 3576.660217279354, 3584.982075089608, 3995.7802320872343, 4490.685652004361, 5188.821490896334, 5277.815276465343, 5289.1801770725215, 4560.110778398213, 4682.321063445781, 4711.515872500186, 4722.858314250578, 4748.264019077049, 5047.242913562958, 5267.789288428458, 5730.484256416942, 5733.397993210736, 5738.4177120296035, 3614.584322802859, 3651.8539258429632, 3882.2041481496226, 3922.313595120871, 3948.795617336711, 4898.926516102261, 4971.850844474636, 6076.361981991871, 6079.513638908877, 6106.236720409949, 3215.1962009497624, 3320.335932813447, 3605.134767655744, 3975.6620687241907, 3976.980115099464, 3110.6889311069162, 3155.2961400843747, 3228.7255583275214, 4020.2562525932794, 4050.5341885683524, 3644.85420583179, 3999.5400528939545, 4665.4168228971375, 4695.600873925686, 4732.219183834629, 5149.665271757323, 5416.972915135478, 5530.557555395559, 5615.932972735167, 5628.324601047819, 1231.408923716621, 1243.564752336675, 1309.1752196116386, 1334.432866031952, 1369.6028151836056, 690.602903330587, 711.5161690050712, 818.5211651184005, 841.2765022081005, 853.1681610429781, 3893.6885049196, 4147.54835807471, 4511.751853648016, 4552.702479793309, 4623.468301145412, 4270.316749320094, 4572.428446444194, 5055.197562315741, 5144.427786106947, 5155.664881782747, 4133.7677654067065, 4172.874813755592, 4517.593416592523, 4519.389882365838, 4532.161550113239, 2153.567877361537, 2370.826440911725, 2378.9184463594356, 2530.607755797854, 2593.844369337846, 4793.760311984387, 4941.629377796679, 5298.81454149103, 5302.719830472934, 5307.28351672527, 4764.928526072112, 5121.8463446096675, 5167.560757335668, 5194.11700010999, 5240.659357141773, 4937.876553086202, 5735.598508104559, 6184.226971628546, 6188.381161883865, 6199.876002480015, 5270.076422105981, 5361.552380857224, 5550.75021624036, 5954.761809527744, 5998.850028749316, 5587.314854894072, 5771.826845194651, 5861.772526439926, 5905.991962732692, 5909.020478139872, 4992.550670439678, 5459.727013649381, 5933.406659334032, 6130.233720784902, 6257.0, 3365.7980521168806, 3942.684585233117, 3982.203559288096, 3994.9213712298097, 4001.639852413297, 5016.046951079284, 5658.943410565842, 5676.318841738853, 5845.707714614167, 5875.0, 5581.553475721851, 5744.827655170351, 5750.194972703741, 5810.186573879576, 5812.7674893003805, 4930.433000204879, 5415.967058447282, 5536.667799932017, 5865.3254875689845, 5909.320428150818, 4882.754897501114, 5017.695399196162, 5052.469490703424, 5476.424975377528, 5747.798827041033, 5157.252198431282, 5802.970985145216, 5823.242978412779, 5836.766529338779, 5872.794452194153, 5177.695925313199, 5701.40135285789, 5762.798302059407, 5784.380373495428, 5801.361850196559], "value": 4011.2716918462133, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [655.3872129558862, 715.5456285258865, 752.289086812962, 755.1881727143323, 764.2395816162917, 12174.330411827346, 15082.0, 15361.30874110665, 15537.456189033386, 15579.298931548079, 11292.548298068068, 11518.712032199199, 14495.782563261559, 14507.854921450782, 14733.042352247096, 736.6243215959872, 889.3241136736078, 896.3143195455482, 903.4263242840777, 904.1952662130676, 874.97812554686, 901.076396693388, 904.683360823713, 905.950172740499, 908.4640062363204, 940.614348117272, 962.1148543340144, 969.9515024248794, 970.0590427285522, 973.8636590877247, 935.2424536125726, 938.3384713776771, 945.8533927241289, 964.3635200767495, 965.1410244882061, 700.5936556797045, 717.078554058033, 717.4081382859162, 717.6447658409121, 717.6483523073708, 14785.26073696311, 14879.0, 14889.47886823956, 14892.62768430787, 14908.478203262943, 12506.74986500274, 12567.748645027139, 12570.874291257152, 12606.621801345882, 12870.935645321808, 10008.799824003552, 10033.949830250875, 10045.397276163381, 10248.180145588409, 10387.013233742782, 3503.3693935091674, 3519.8240087995496, 3542.1498840278405, 3590.982045089784, 3595.442706380515, 81365.77951330735, 81677.59161204156, 83396.0, 83664.90837729044, 84695.57652211761, 9346.813063738688, 9391.389559678599, 9452.291078169164, 9588.952055239679, 9672.274579406572, 21811.25430877979, 22053.0, 22082.779172208073, 22196.556068878534, 22217.777822221895, 7375.4099672026105, 7415.406767458699, 7477.775666730006, 7628.80927976805, 7645.388368930472, 3985.2826491231276, 3985.880423587297, 3991.7405368650943, 3996.789006835795, 4009.218202450494, 3534.2578058607464, 3543.0, 3614.801185934799, 3631.5823680276576, 3631.927361452756, 615.6613862375675, 628.6856571714143, 631.722042301386, 636.974521019154, 641.6791604197902, 434.36148861174024, 477.77544554059534, 479.84405068352925, 481.48993834942877, 564.5004171308422, 5897.49871260939, 7912.723054693058, 7975.60121993898, 8084.231997960184, 8243.464174828618, 514.1234195696329, 516.5712458659303, 545.021686073499, 599.1761328173761, 603.1947350287415, 3734.682551983112, 3880.4567360569545, 3894.1043559981363, 3894.9873033011054, 3930.6462418382484, 91310.0868991315, 94167.0, 95557.08885822244, 95574.52212738892, 96181.0, 75366.24633753592, 84425.0, 84583.73124403138, 84912.0, 87991.56004219937, 65108.070136843955, 73912.63043684639, 74813.62593187108, 75113.62443187748, 75151.62424187844, 6606.900896486461, 7102.893456598258, 7564.205758395289, 7578.772636820904, 7630.694772209049, 46645.80187783116, 47067.29399058948, 47149.05701886012, 47332.0, 47577.52422475731, 61464.0, 61519.38480615136, 65249.04252872422, 66158.33841661522, 67428.6628566854, 10394.58421663125, 10395.0, 10485.895141048491, 10595.205359598214, 10853.565857365616, 8864.822703546022, 9426.811463770824, 10670.0, 11045.502952367002, 11256.662300131009, 8692.739217823475, 10367.222458315808, 10373.896261037293, 10613.946930265609, 10703.518341674488, 8773.341999349946, 10492.160627149657, 10614.885437029001, 10726.410047447465, 10816.08063314627, 10148.340357876714, 10177.491125443847, 10368.675108184152, 10384.480775961021, 10515.78968420612, 8672.566371681516, 8772.56137193125, 8829.337799664921, 9053.818923621358, 9084.818303634023, 8640.82718345617, 8941.284697224337, 9052.954735226282, 9155.542222888696, 9374.390664606779], "value": 6703.072052693826, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1632.4, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 115.0, 126.0, 171.0, 124.0, 118.0, 102.0, 170.0, 98.0, 158.0], "value": 129.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 125.0, 143.0, 198.0, 122.0, 149.0, 141.0, 128.0, 165.0, 120.0], "value": 144.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [196.0, 202.0, 247.0, 235.0, 272.0, 234.0, 196.0, 195.0, 200.0, 194.0], "value": 217.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 82.0, 74.0, 173.0, 58.0, 59.0, 58.0, 61.0, 153.0, 82.0], "value": 86.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 82.0, 155.0, 77.0, 83.0, 82.0, 120.0, 80.0, 82.0, 124.0], "value": 96.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 131.0, 85.0, 132.0, 135.0, 88.0, 135.0, 130.0, 84.0, 130.0], "value": 118.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 127.0, 151.0, 150.0, 130.0, 149.0, 98.0, 147.0, 96.0, 97.0], "value": 124.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 93.0, 91.0, 91.0, 91.0, 100.0, 149.0, 91.0, 120.0, 153.0], "value": 107.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 62.0, 60.0, 61.0, 62.0, 60.0, 58.0, 60.0, 60.0, 60.0], "value": 60.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 68.0, 67.0, 75.0, 77.0, 78.0, 73.0, 65.0, 69.0, 66.0], "value": 70.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 87.0, 87.0, 83.0, 87.0, 85.0, 88.0, 87.0, 150.0, 85.0], "value": 92.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 141.0, 148.0, 153.0, 148.0, 135.0, 136.0, 134.0, 150.0, 140.0], "value": 142.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 164.0, 167.0, 165.0, 169.0, 162.0, 146.0, 202.0, 211.0, 208.0], "value": 176.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 66.0, 64.0, 68.0, 63.0, 64.0, 68.0, 68.0, 65.0], "value": 65.9, "unit": "score"}]}]} 04:03:05 INFO - Return code: 0 04:03:05 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 04:03:05 ERROR - # TBPL SUCCESS # 04:03:05 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:03:05 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:03:05 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:03:05 INFO - 2016-05-16 04:03:05.429 screenresolution[1712:11222] starting screenresolution argv=screenresolution get 04:03:05 INFO - 2016-05-16 04:03:05.431 screenresolution[1712:11222] Display 0: 1600x1200x32@60 04:03:05 INFO - 2016-05-16 04:03:05.437 screenresolution[1713:11225] starting screenresolution argv=screenresolution list 04:03:05 INFO - Available Modes on Display 0 04:03:05 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:03:05 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:03:05 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:03:05 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:03:05 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:03:05 INFO - Intel Iris: 04:03:05 INFO - Chipset Model: Intel Iris 04:03:05 INFO - Type: GPU 04:03:05 INFO - Bus: Built-In 04:03:05 INFO - VRAM (Dynamic, Max): 1536 MB 04:03:05 INFO - Vendor: Intel (0x8086) 04:03:05 INFO - Device ID: 0x0a2e 04:03:05 INFO - Revision ID: 0x0009 04:03:05 INFO - Displays: 04:03:05 INFO - Display: 04:03:05 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:03:05 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:03:05 INFO - Display Serial Number: 1600x1200 60 04:03:05 INFO - Main Display: Yes 04:03:05 INFO - Mirror: Off 04:03:05 INFO - Online: Yes 04:03:05 INFO - Rotation: Supported 04:03:05 INFO - Return code: 0 04:03:05 INFO - Running post-action listener: _resource_record_post_action 04:03:05 INFO - ##### 04:03:05 INFO - ##### Finished run-tests step (success) 04:03:05 INFO - ##### 04:03:05 INFO - Running post-run listener: _resource_record_post_run 04:03:05 INFO - Total resource usage - Wall time: 1210s; CPU: 54.0%; Read bytes: 32828928; Write bytes: 697715712; Read time: 329; Write time: 2014 04:03:05 INFO - TinderboxPrint: CPU usage
54.4% 04:03:05 INFO - TinderboxPrint: I/O read bytes / time
32,828,928 / 329 04:03:05 INFO - TinderboxPrint: I/O write bytes / time
697,715,712 / 2,014 04:03:05 INFO - TinderboxPrint: CPU idle
2,207.3 (45.6%) 04:03:05 INFO - TinderboxPrint: CPU system
973.9 (20.1%) 04:03:05 INFO - TinderboxPrint: CPU user
1,660.4 (34.3%) 04:03:05 INFO - TinderboxPrint: Swap in / out
424,235,008 / 0 04:03:05 INFO - install - Wall time: 34s; CPU: 55.0%; Read bytes: 237568; Write bytes: 396834304; Read time: 4; Write time: 727 04:03:05 INFO - run-tests - Wall time: 1176s; CPU: 54.0%; Read bytes: 31047168; Write bytes: 300033536; Read time: 311; Write time: 1286 04:03:06 INFO - Running post-run listener: _upload_blobber_files 04:03:06 INFO - Blob upload gear active. 04:03:06 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:03:06 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 04:03:06 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'] 04:03:06 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 04:03:06 INFO - (blobuploader) - INFO - Open directory for files ... 04:03:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:03:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:03:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:03:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:03:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:03:07 INFO - (blobuploader) - INFO - Done attempting. 04:03:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:03:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:03:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:03:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:03:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:03:08 INFO - (blobuploader) - INFO - Done attempting. 04:03:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:03:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:03:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:03:11 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:03:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:03:11 INFO - (blobuploader) - INFO - Done attempting. 04:03:11 INFO - (blobuploader) - INFO - Iteration through files over. 04:03:11 INFO - Return code: 0 04:03:11 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:03:11 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:03:11 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/83bdd7400d015581e9b68876d104b87aa48d302a2f0aab3e798060a6f7741f40ea1ed37e4475bb268f019fca1bf1647563a88f3596dad215bdc57840a8e1fe57", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ead0a422b44ed006c683c0f06dc0fb9680879d6643fc28275506d23a8a9605b7ec23504ba13ffe2c2a0a669d4b54c95081f8efa024f84a332cebefed54d1574e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9789b7e82b60257726e6ef90226b25b898958fbc6feefd432d7a774d64fb8c424bb451836a6eb9e796d97344b98e6e3cdea3491085fe997163c5f9edd2a2890c"} 04:03:11 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:03:11 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:03:11 INFO - Contents: 04:03:11 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/83bdd7400d015581e9b68876d104b87aa48d302a2f0aab3e798060a6f7741f40ea1ed37e4475bb268f019fca1bf1647563a88f3596dad215bdc57840a8e1fe57", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ead0a422b44ed006c683c0f06dc0fb9680879d6643fc28275506d23a8a9605b7ec23504ba13ffe2c2a0a669d4b54c95081f8efa024f84a332cebefed54d1574e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9789b7e82b60257726e6ef90226b25b898958fbc6feefd432d7a774d64fb8c424bb451836a6eb9e796d97344b98e6e3cdea3491085fe997163c5f9edd2a2890c"} 04:03:11 INFO - Running post-run listener: copy_logs_to_upload_dir 04:03:11 INFO - Copying logs to upload dir... 04:03:11 INFO - mkdir: /builds/slave/test/build/upload/logs 04:03:11 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1300.581349 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 40 secs) (at 2016-05-16 04:03:11.166354) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-16 04:03:11.169795) ========= 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.SDaouneQmS/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.w30csLZLh2/Listeners TMPDIR=/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/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/83bdd7400d015581e9b68876d104b87aa48d302a2f0aab3e798060a6f7741f40ea1ed37e4475bb268f019fca1bf1647563a88f3596dad215bdc57840a8e1fe57", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ead0a422b44ed006c683c0f06dc0fb9680879d6643fc28275506d23a8a9605b7ec23504ba13ffe2c2a0a669d4b54c95081f8efa024f84a332cebefed54d1574e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9789b7e82b60257726e6ef90226b25b898958fbc6feefd432d7a774d64fb8c424bb451836a6eb9e796d97344b98e6e3cdea3491085fe997163c5f9edd2a2890c"} build_url:https://queue.taskcluster.net/v1/task/RIdxSdjrQnq14tOfB86CoA/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011120 build_url: 'https://queue.taskcluster.net/v1/task/RIdxSdjrQnq14tOfB86CoA/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/83bdd7400d015581e9b68876d104b87aa48d302a2f0aab3e798060a6f7741f40ea1ed37e4475bb268f019fca1bf1647563a88f3596dad215bdc57840a8e1fe57", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ead0a422b44ed006c683c0f06dc0fb9680879d6643fc28275506d23a8a9605b7ec23504ba13ffe2c2a0a669d4b54c95081f8efa024f84a332cebefed54d1574e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9789b7e82b60257726e6ef90226b25b898958fbc6feefd432d7a774d64fb8c424bb451836a6eb9e796d97344b98e6e3cdea3491085fe997163c5f9edd2a2890c"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-16 04:03:11.196634) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-16 04:03:11.196915) ========= 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.SDaouneQmS/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.w30csLZLh2/Listeners TMPDIR=/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/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.005172 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-16 04:03:11.244872) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-16 04:03:11.245153) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-16 04:03:11.245450) ========= ========= Total master_lag: 0.26 =========