builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0371 starttime: 1463391730.78 results: success (0) buildid: 20160516005330 builduid: 30d637ae4bc34eb8b56efb33dbcb1da8 revision: 0c29ad917ac38c9ef26c9ff0b5d9762e75d13948 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-16 02:42:10.783853) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-16 02:42:10.784208) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-16 02:42:10.784478) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-16 02:42:11.176040) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-16 02:42:11.179855) ========= 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.hLOcPl8xEw/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.nD2QFHjdc8/Listeners TMPDIR=/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/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 02:42:11-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 16.1M=0.001s 2016-05-16 02:42:11 (16.1 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.627727 ========= master_lag: 0.07 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-16 02:42:11.873691) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-16 02:42:11.873973) ========= 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.hLOcPl8xEw/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.nD2QFHjdc8/Listeners TMPDIR=/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/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.026428 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-16 02:42:11.963520) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-16 02:42:11.963860) ========= 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.hLOcPl8xEw/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.nD2QFHjdc8/Listeners TMPDIR=/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/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 02:42:12,015 truncating revision to first 12 chars 2016-05-16 02:42:12,016 Setting DEBUG logging. 2016-05-16 02:42:12,016 attempt 1/10 2016-05-16 02:42:12,016 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 02:42:13,686 unpacking tar archive at: fx-team-0c29ad917ac3/testing/mozharness/ program finished with exit code 0 elapsedTime=1.921651 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-16 02:42:13.914797) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-16 02:42:13.915107) ========= script_repo_revision: 0c29ad917ac38c9ef26c9ff0b5d9762e75d13948 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-16 02:42:13.915496) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-16 02:42:13.915781) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-16 02:42:13.929004) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 57 secs) (at 2016-05-16 02:42:13.929369) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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.hLOcPl8xEw/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.nD2QFHjdc8/Listeners TMPDIR=/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/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 02:42:14 INFO - MultiFileLogger online at 20160516 02:42:14 in /builds/slave/test 02:42:14 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 02:42:14 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:42:14 INFO - {'append_to_log': False, 02:42:14 INFO - 'base_work_dir': '/builds/slave/test', 02:42:14 INFO - 'blob_upload_branch': 'Fx-Team', 02:42:14 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:42:14 INFO - 'branch': 'Fx-Team', 02:42:14 INFO - 'buildbot_json_path': 'buildprops.json', 02:42:14 INFO - 'config_files': ('talos/mac_config.py',), 02:42:14 INFO - 'default_actions': ('clobber', 02:42:14 INFO - 'read-buildbot-config', 02:42:14 INFO - 'download-and-extract', 02:42:14 INFO - 'populate-webroot', 02:42:14 INFO - 'create-virtualenv', 02:42:14 INFO - 'install', 02:42:14 INFO - 'run-tests'), 02:42:14 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:42:14 INFO - 'download_minidump_stackwalk': True, 02:42:14 INFO - 'download_symbols': 'ondemand', 02:42:14 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:42:14 INFO - 'tooltool.py': '/tools/tooltool.py', 02:42:14 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:42:14 INFO - '/tools/misc-python/virtualenv.py')}, 02:42:14 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:42:14 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:42:14 INFO - 'installer_path': 'installer.exe', 02:42:14 INFO - 'log_level': 'info', 02:42:14 INFO - 'log_name': 'talos', 02:42:14 INFO - 'log_to_console': True, 02:42:14 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 02:42:14 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 02:42:14 INFO - 'opt_config_files': (), 02:42:14 INFO - 'pip_index': False, 02:42:14 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:42:14 INFO - 'cmd': ('bash', 02:42:14 INFO - '-c', 02:42:14 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:42:14 INFO - 'enabled': True, 02:42:14 INFO - 'halt_on_failure': False, 02:42:14 INFO - 'name': 'check_screen_resolution'},), 02:42:14 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:42:14 INFO - 'cmd': ('bash', 02:42:14 INFO - '-c', 02:42:14 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:42:14 INFO - 'enabled': True, 02:42:14 INFO - 'halt_on_failure': False, 02:42:14 INFO - 'name': 'check_screen_resolution'},), 02:42:14 INFO - 'run_cmd_checks_enabled': True, 02:42:14 INFO - 'sps_profile': False, 02:42:14 INFO - 'sps_profile_interval': 0, 02:42:14 INFO - 'suite': 'dromaeojs', 02:42:14 INFO - 'system_bits': '32', 02:42:14 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:42:14 INFO - 'title': 't-yosemite-r7-0371', 02:42:14 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:42:14 INFO - 'use_talos_json': True, 02:42:14 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:42:14 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:42:14 INFO - 'work_dir': 'build'} 02:42:14 INFO - ##### 02:42:14 INFO - ##### Running clobber step. 02:42:14 INFO - ##### 02:42:14 INFO - Running pre-action listener: _resource_record_pre_action 02:42:14 INFO - Running main action method: clobber 02:42:14 INFO - rmtree: /builds/slave/test/build 02:42:14 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:42:15 INFO - Running post-action listener: _resource_record_post_action 02:42:15 INFO - ##### 02:42:15 INFO - ##### Finished clobber step (success) 02:42:15 INFO - ##### 02:42:15 INFO - ##### 02:42:15 INFO - ##### Running read-buildbot-config step. 02:42:15 INFO - ##### 02:42:15 INFO - Running pre-action listener: _resource_record_pre_action 02:42:15 INFO - Running main action method: read_buildbot_config 02:42:15 INFO - Using buildbot properties: 02:42:15 INFO - { 02:42:15 INFO - "project": "", 02:42:15 INFO - "product": "firefox", 02:42:15 INFO - "script_repo_revision": "production", 02:42:15 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 02:42:15 INFO - "repository": "", 02:42:15 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 02:42:15 INFO - "buildid": "20160516005330", 02:42:15 INFO - "pgo_build": "False", 02:42:15 INFO - "basedir": "/builds/slave/test", 02:42:15 INFO - "buildnumber": 14, 02:42:15 INFO - "slavename": "t-yosemite-r7-0371", 02:42:15 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 02:42:15 INFO - "platform": "yosemite_r7", 02:42:15 INFO - "scheduler": "tests-fx-team-macosx64-talos", 02:42:15 INFO - "branch": "fx-team", 02:42:15 INFO - "repo_path": "integration/fx-team", 02:42:15 INFO - "revision": "0c29ad917ac38c9ef26c9ff0b5d9762e75d13948", 02:42:15 INFO - "stage_platform": "macosx64", 02:42:15 INFO - "builduid": "30d637ae4bc34eb8b56efb33dbcb1da8", 02:42:15 INFO - "slavebuilddir": "test" 02:42:15 INFO - } 02:42:15 INFO - Found installer url https://queue.taskcluster.net/v1/task/RIdxSdjrQnq14tOfB86CoA/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg. 02:42:15 INFO - Running post-action listener: _resource_record_post_action 02:42:15 INFO - ##### 02:42:15 INFO - ##### Finished read-buildbot-config step (success) 02:42:15 INFO - ##### 02:42:15 INFO - ##### 02:42:15 INFO - ##### Running download-and-extract step. 02:42:15 INFO - ##### 02:42:15 INFO - Running pre-action listener: _resource_record_pre_action 02:42:15 INFO - Running main action method: download_and_extract 02:42:15 INFO - mkdir: /builds/slave/test/build/tests 02:42:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:42:15 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 02:42:15 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 02:42:15 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 02:42:15 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 02:42:15 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 02:42:26 INFO - retry: attempt #1 caught exception: '' 02:42:26 INFO - retry: Failed, sleeping 30 seconds before retrying 02:42:56 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 #2 02:43:02 INFO - Downloaded 1199 bytes. 02:43:02 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.mac.test_packages.json 02:43:02 INFO - Using the following test package requirements: 02:43:02 INFO - {u'common': [u'firefox-49.0a1.en-US.mac.common.tests.zip'], 02:43:02 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 02:43:02 INFO - u'firefox-49.0a1.en-US.mac.cppunittest.tests.zip'], 02:43:02 INFO - u'gtest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 02:43:02 INFO - u'firefox-49.0a1.en-US.mac.gtest.tests.zip'], 02:43:02 INFO - u'jittest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 02:43:02 INFO - u'jsshell-mac.zip'], 02:43:02 INFO - u'mochitest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 02:43:02 INFO - u'firefox-49.0a1.en-US.mac.mochitest.tests.zip'], 02:43:02 INFO - u'mozbase': [u'firefox-49.0a1.en-US.mac.common.tests.zip'], 02:43:02 INFO - u'reftest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 02:43:02 INFO - u'firefox-49.0a1.en-US.mac.reftest.tests.zip'], 02:43:02 INFO - u'talos': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 02:43:02 INFO - u'firefox-49.0a1.en-US.mac.talos.tests.zip'], 02:43:02 INFO - u'web-platform': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 02:43:02 INFO - u'firefox-49.0a1.en-US.mac.web-platform.tests.zip'], 02:43:02 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 02:43:02 INFO - u'firefox-49.0a1.en-US.mac.xpcshell.tests.zip']} 02:43:02 INFO - Downloading packages: [u'firefox-49.0a1.en-US.mac.common.tests.zip'] for test suite category: common 02:43: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')]} 02:43: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 02:43: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 02:43: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 02:43: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 02:43: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 02:43:05 INFO - Downloaded 18267733 bytes. 02:43:05 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'] 02:43:05 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 02:43:08 INFO - Return code: 0 02:43:08 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 02:43:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:43:08 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 02:43:08 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 02:43:08 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 02:43:08 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 02:43:08 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 02:43:09 INFO - Downloaded 18267733 bytes. 02:43:09 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'] 02:43:09 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 02:43:13 INFO - Return code: 0 02:43: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')]} 02:43:13 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 02:43: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.talos.tests.zip 02:43: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.talos.tests.zip 02:43: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.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.mac.talos.tests.zip 02:43:13 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 02:43:14 INFO - Downloaded 10840194 bytes. 02:43:14 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'] 02:43:14 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 02:43:14 INFO - Return code: 0 02:43:14 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')]} 02:43:14 INFO - https://queue.taskcluster.net/v1/task/RIdxSdjrQnq14tOfB86CoA/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 02:43:14 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 02:43:14 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 02:43:14 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 02:43:14 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 02:43:17 INFO - Downloaded 110055402 bytes. 02:43:17 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/RIdxSdjrQnq14tOfB86CoA/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 02:43:17 INFO - mkdir: /builds/slave/test/properties 02:43:17 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:43:17 INFO - Writing to file /builds/slave/test/properties/build_url 02:43:17 INFO - Contents: 02:43:17 INFO - build_url:https://queue.taskcluster.net/v1/task/RIdxSdjrQnq14tOfB86CoA/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 02:43:18 INFO - Running post-action listener: _resource_record_post_action 02:43:18 INFO - Running post-action listener: set_extra_try_arguments 02:43:18 INFO - ##### 02:43:18 INFO - ##### Finished download-and-extract step (success) 02:43:18 INFO - ##### 02:43:18 INFO - ##### 02:43:18 INFO - ##### Running populate-webroot step. 02:43:18 INFO - ##### 02:43:18 INFO - Running pre-action listener: _resource_record_pre_action 02:43:18 INFO - Running main action method: populate_webroot 02:43:18 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:43:18 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:43:18 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:43:18 INFO - '--tppagecycles', 02:43:18 INFO - '7'], 02:43:18 INFO - 'tests': ['tsvgm']}}, 02:43:18 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:43:18 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:43:18 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:43:18 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:43:18 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:43:18 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:43:18 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:43:18 INFO - 'talos_options': ['--disable-e10s'], 02:43:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:43:18 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:43:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:43:18 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:43:18 INFO - 'talos_options': ['--disable-e10s'], 02:43:18 INFO - 'tests': ['damp', 'tps']}, 02:43:18 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:43:18 INFO - 'tests': ['damp', 'tps']}, 02:43:18 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:43:18 INFO - 'tests': ['dromaeo_dom']}, 02:43:18 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:43:18 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:43:18 INFO - 'tests': ['a11yr', 02:43:18 INFO - 'ts_paint', 02:43:18 INFO - 'tpaint', 02:43:18 INFO - 'sessionrestore', 02:43:18 INFO - 'sessionrestore_no_auto_restore', 02:43:18 INFO - 'tabpaint']}, 02:43:18 INFO - 'other-e10s': {'tests': ['a11yr', 02:43:18 INFO - 'ts_paint', 02:43:18 INFO - 'tpaint', 02:43:18 INFO - 'sessionrestore', 02:43:18 INFO - 'sessionrestore_no_auto_restore', 02:43:18 INFO - 'tabpaint']}, 02:43:18 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:43:18 INFO - 'ts_paint', 02:43:18 INFO - 'tpaint', 02:43:18 INFO - 'sessionrestore', 02:43:18 INFO - 'sessionrestore_no_auto_restore', 02:43:18 INFO - 'tabpaint']}, 02:43:18 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:43:18 INFO - 'ts_paint', 02:43:18 INFO - 'tpaint', 02:43:18 INFO - 'sessionrestore', 02:43:18 INFO - 'sessionrestore_no_auto_restore', 02:43:18 INFO - 'tabpaint']}, 02:43:18 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:43:18 INFO - 'tests': ['a11yr', 02:43:18 INFO - 'ts_paint', 02:43:18 INFO - 'tpaint', 02:43:18 INFO - 'sessionrestore', 02:43:18 INFO - 'sessionrestore_no_auto_restore', 02:43:18 INFO - 'tabpaint']}, 02:43:18 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:43:18 INFO - 'tests': ['a11yr', 02:43:18 INFO - 'ts_paint', 02:43:18 INFO - 'tpaint', 02:43:18 INFO - 'sessionrestore', 02:43:18 INFO - 'sessionrestore_no_auto_restore', 02:43:18 INFO - 'tabpaint']}, 02:43:18 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:43:18 INFO - 'tests': ['tsvgx', 02:43:18 INFO - 'tsvgr_opacity', 02:43:18 INFO - 'tart', 02:43:18 INFO - 'tscrollx', 02:43:18 INFO - 'cart']}, 02:43:18 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:43:18 INFO - 'tsvgr_opacity', 02:43:18 INFO - 'tart', 02:43:18 INFO - 'tscrollx', 02:43:18 INFO - 'cart']}, 02:43:18 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:43:18 INFO - 'talos_options': ['--disable-e10s'], 02:43:18 INFO - 'tests': ['tp5o']}, 02:43:18 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:43:18 INFO - 'tests': ['tp5o']}, 02:43:18 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:43:18 INFO - 'talos_options': ['--disable-e10s', 02:43:18 INFO - '--xperf_path', 02:43:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:43:18 INFO - 'tests': ['tp5n']}, 02:43:18 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:43:18 INFO - 'talos_options': ['--xperf_path', 02:43:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:43:18 INFO - 'tests': ['tp5n']}}, 02:43:18 INFO - 'talos.zip': {'path': '', 02:43:18 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:43:18 INFO - Running post-action listener: _resource_record_post_action 02:43:18 INFO - ##### 02:43:18 INFO - ##### Finished populate-webroot step (success) 02:43:18 INFO - ##### 02:43:18 INFO - ##### 02:43:18 INFO - ##### Running create-virtualenv step. 02:43:18 INFO - ##### 02:43:18 INFO - Running pre-action listener: _resource_record_pre_action 02:43:18 INFO - Running main action method: create_virtualenv 02:43:18 INFO - Creating virtualenv /builds/slave/test/build/venv 02:43:18 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 02:43:18 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:43:18 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:43:18 INFO - Using real prefix '/tools/python27' 02:43:18 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:43:19 INFO - Installing distribute.............................................................................................................................................................................................done. 02:43:22 INFO - Installing pip.................done. 02:43:22 INFO - Return code: 0 02:43:22 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:43:22 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')]} 02:43:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:43:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:43:22 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')]} 02:43:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:43:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:43:22 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 0x106d92a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106d98570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fadd3cac3c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106c36d30>, '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 0x106a5adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106c2db20>, '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.hLOcPl8xEw/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.nD2QFHjdc8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/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 02:43:22 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 02:43:22 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 02:43:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hLOcPl8xEw/Render', 02:43:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:43:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:43:22 INFO - 'HOME': '/Users/cltbld', 02:43:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:43:22 INFO - 'LOGNAME': 'cltbld', 02:43:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:43:22 INFO - 'MOZ_NO_REMOTE': '1', 02:43:22 INFO - 'NO_EM_RESTART': '1', 02:43:22 INFO - 'PAGER': '/bin/cat', 02:43:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:43:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:43:22 INFO - 'PWD': '/builds/slave/test', 02:43:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:43:22 INFO - 'SHELL': '/bin/bash', 02:43:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nD2QFHjdc8/Listeners', 02:43:22 INFO - 'TMPDIR': '/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/', 02:43:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:43:22 INFO - 'USER': 'cltbld', 02:43:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:43:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:43:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:43:22 INFO - 'XPC_FLAGS': '0x0', 02:43:22 INFO - 'XPC_SERVICE_NAME': '0', 02:43:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:43:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:43:22 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 02:43:22 INFO - Cleaning up... 02:43:22 INFO - Return code: 0 02:43:22 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:43:22 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')]} 02:43:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:43:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:43:22 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')]} 02:43:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:43:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:43:22 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 0x106d92a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106d98570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fadd3cac3c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106c36d30>, '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 0x106a5adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106c2db20>, '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.hLOcPl8xEw/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.nD2QFHjdc8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/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 02:43:22 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 02:43:22 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 02:43:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hLOcPl8xEw/Render', 02:43:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:43:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:43:22 INFO - 'HOME': '/Users/cltbld', 02:43:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:43:22 INFO - 'LOGNAME': 'cltbld', 02:43:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:43:22 INFO - 'MOZ_NO_REMOTE': '1', 02:43:22 INFO - 'NO_EM_RESTART': '1', 02:43:22 INFO - 'PAGER': '/bin/cat', 02:43:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:43:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:43:22 INFO - 'PWD': '/builds/slave/test', 02:43:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:43:22 INFO - 'SHELL': '/bin/bash', 02:43:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nD2QFHjdc8/Listeners', 02:43:22 INFO - 'TMPDIR': '/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/', 02:43:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:43:22 INFO - 'USER': 'cltbld', 02:43:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:43:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:43:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:43:22 INFO - 'XPC_FLAGS': '0x0', 02:43:22 INFO - 'XPC_SERVICE_NAME': '0', 02:43:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:43:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:43:22 INFO - Downloading/unpacking psutil>=3.1.1 02:43:22 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 02:43:22 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 02:43:22 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 02:43:22 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 02:43:22 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 02:43:22 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 02:43:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:43:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:43:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:43:26 INFO - Installing collected packages: psutil 02:43:26 INFO - Running setup.py install for psutil 02:43:26 INFO - building 'psutil._psutil_osx' extension 02:43:26 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 02:43:26 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 02:43: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/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 02:43:27 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 02:43:27 INFO - building 'psutil._psutil_posix' extension 02:43:27 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 02:43:27 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 02:43:27 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 02:43:27 INFO - ^ 02:43:27 INFO - 1 warning generated. 02:43:27 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 02:43:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:43:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:43:27 INFO - Successfully installed psutil 02:43:27 INFO - Cleaning up... 02:43:27 INFO - Return code: 0 02:43:27 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:43:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:43:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:43:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:43:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:43:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:43:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:43:27 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 0x106d92a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106d98570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fadd3cac3c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106c36d30>, '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 0x106a5adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106c2db20>, '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.hLOcPl8xEw/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.nD2QFHjdc8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/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 02:43:27 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 02:43:27 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 02:43:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hLOcPl8xEw/Render', 02:43:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:43:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:43:27 INFO - 'HOME': '/Users/cltbld', 02:43:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:43:27 INFO - 'LOGNAME': 'cltbld', 02:43:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:43:27 INFO - 'MOZ_NO_REMOTE': '1', 02:43:27 INFO - 'NO_EM_RESTART': '1', 02:43:27 INFO - 'PAGER': '/bin/cat', 02:43:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:43:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:43:27 INFO - 'PWD': '/builds/slave/test', 02:43:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:43:27 INFO - 'SHELL': '/bin/bash', 02:43:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nD2QFHjdc8/Listeners', 02:43:27 INFO - 'TMPDIR': '/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/', 02:43:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:43:27 INFO - 'USER': 'cltbld', 02:43:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:43:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:43:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:43:27 INFO - 'XPC_FLAGS': '0x0', 02:43:27 INFO - 'XPC_SERVICE_NAME': '0', 02:43:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:43:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:43:27 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:43:27 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 02:43:27 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 02:43:27 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 02:43:27 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 02:43:27 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 02:43:27 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 02:43:30 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:43:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:43:30 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:43:30 INFO - Installing collected packages: mozsystemmonitor 02:43:30 INFO - Running setup.py install for mozsystemmonitor 02:43:30 INFO - Successfully installed mozsystemmonitor 02:43:30 INFO - Cleaning up... 02:43:30 INFO - Return code: 0 02:43:30 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:43:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:43:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:43:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:43:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:43:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:43:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:43:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x106d92a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106d98570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fadd3cac3c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106c36d30>, '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 0x106a5adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106c2db20>, '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.hLOcPl8xEw/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.nD2QFHjdc8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/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 02:43:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 02:43:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 02:43:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hLOcPl8xEw/Render', 02:43:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:43:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:43:30 INFO - 'HOME': '/Users/cltbld', 02:43:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:43:30 INFO - 'LOGNAME': 'cltbld', 02:43:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:43:30 INFO - 'MOZ_NO_REMOTE': '1', 02:43:30 INFO - 'NO_EM_RESTART': '1', 02:43:30 INFO - 'PAGER': '/bin/cat', 02:43:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:43:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:43:30 INFO - 'PWD': '/builds/slave/test', 02:43:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:43:30 INFO - 'SHELL': '/bin/bash', 02:43:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nD2QFHjdc8/Listeners', 02:43:30 INFO - 'TMPDIR': '/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/', 02:43:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:43:30 INFO - 'USER': 'cltbld', 02:43:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:43:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:43:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:43:30 INFO - 'XPC_FLAGS': '0x0', 02:43:30 INFO - 'XPC_SERVICE_NAME': '0', 02:43:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:43:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:43:30 INFO - Downloading/unpacking blobuploader==1.2.4 02:43:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:43:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:43:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:43:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:43:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:43:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:43:33 INFO - Downloading blobuploader-1.2.4.tar.gz 02:43:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:43:33 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:43:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:43:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:43:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:43:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:43:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:43:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:43:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:43:33 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:43:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:43:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:43:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:43:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:43:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:43:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:43:34 INFO - Downloading docopt-0.6.1.tar.gz 02:43:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:43:34 INFO - Installing collected packages: blobuploader, requests, docopt 02:43:34 INFO - Running setup.py install for blobuploader 02:43:34 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:43:34 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:43:34 INFO - Running setup.py install for requests 02:43:35 INFO - Running setup.py install for docopt 02:43:35 INFO - Successfully installed blobuploader requests docopt 02:43:35 INFO - Cleaning up... 02:43:35 INFO - Return code: 0 02:43:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:43:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:43:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:43:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:43:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:43:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:43:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:43:35 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 0x106d92a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106d98570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fadd3cac3c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106c36d30>, '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 0x106a5adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106c2db20>, '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.hLOcPl8xEw/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.nD2QFHjdc8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/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 02:43:35 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 02:43:35 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 02:43:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hLOcPl8xEw/Render', 02:43:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:43:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:43:35 INFO - 'HOME': '/Users/cltbld', 02:43:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:43:35 INFO - 'LOGNAME': 'cltbld', 02:43:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:43:35 INFO - 'MOZ_NO_REMOTE': '1', 02:43:35 INFO - 'NO_EM_RESTART': '1', 02:43:35 INFO - 'PAGER': '/bin/cat', 02:43:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:43:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:43:35 INFO - 'PWD': '/builds/slave/test', 02:43:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:43:35 INFO - 'SHELL': '/bin/bash', 02:43:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nD2QFHjdc8/Listeners', 02:43:35 INFO - 'TMPDIR': '/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/', 02:43:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:43:35 INFO - 'USER': 'cltbld', 02:43:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:43:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:43:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:43:35 INFO - 'XPC_FLAGS': '0x0', 02:43:35 INFO - 'XPC_SERVICE_NAME': '0', 02:43:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:43:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:43:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:43:35 INFO - Running setup.py (path:/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/pip-rO5Ymw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:43:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:43:35 INFO - Running setup.py (path:/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/pip-u7eLiV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:43:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:43:35 INFO - Running setup.py (path:/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/pip-WiyBzd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:43:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:43:35 INFO - Running setup.py (path:/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/pip-p2B8I7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:43:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:43:36 INFO - Running setup.py (path:/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/pip-qjLEFS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:43:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:43:36 INFO - Running setup.py (path:/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/pip-cZCgCa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:43:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:43:36 INFO - Running setup.py (path:/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/pip-yPXby9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:43:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:43:36 INFO - Running setup.py (path:/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/pip-RZnuAo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:43:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:43:36 INFO - Running setup.py (path:/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/pip-Fef7aD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:43:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:43:36 INFO - Running setup.py (path:/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/pip-Xl0rf1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:43:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:43:36 INFO - Running setup.py (path:/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/pip-tIwGxt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:43:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:43:36 INFO - Running setup.py (path:/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/pip-xOf3N7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:43:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:43:36 INFO - Running setup.py (path:/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/pip-slygYa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:43:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:43:36 INFO - Running setup.py (path:/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/pip-repaMP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:43:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:43:37 INFO - Running setup.py (path:/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/pip-b8JxcM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:43:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:43:37 INFO - Running setup.py (path:/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/pip-gYFYrg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:43:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:43:37 INFO - Running setup.py (path:/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/pip-hIgN4c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:43:37 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:43:37 INFO - Running setup.py install for manifestparser 02:43:37 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:43:37 INFO - Running setup.py install for mozcrash 02:43:37 INFO - Running setup.py install for mozdebug 02:43:37 INFO - Running setup.py install for mozdevice 02:43:37 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:43:37 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:43:37 INFO - Running setup.py install for mozfile 02:43:38 INFO - Running setup.py install for mozhttpd 02:43:38 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:43:38 INFO - Running setup.py install for mozinfo 02:43:38 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:43:38 INFO - Running setup.py install for mozInstall 02:43:38 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:43:38 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:43:38 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:43:38 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:43:38 INFO - Running setup.py install for mozleak 02:43:38 INFO - Running setup.py install for mozlog 02:43:38 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:43:38 INFO - Running setup.py install for moznetwork 02:43:38 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:43:38 INFO - Running setup.py install for mozprocess 02:43:39 INFO - Running setup.py install for mozprofile 02:43:39 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:43:39 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:43:39 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:43:39 INFO - Running setup.py install for mozrunner 02:43:39 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:43:39 INFO - Running setup.py install for mozscreenshot 02:43:39 INFO - Running setup.py install for moztest 02:43:39 INFO - Running setup.py install for mozversion 02:43:39 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:43:39 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:43:39 INFO - Cleaning up... 02:43:39 INFO - Return code: 0 02:43:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:43:39 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')]} 02:43:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:43:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:43:39 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')]} 02:43:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:43:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:43:39 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 0x106d92a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106d98570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fadd3cac3c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106c36d30>, '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 0x106a5adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106c2db20>, '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.hLOcPl8xEw/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.nD2QFHjdc8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/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 02:43:39 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 02:43:39 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 02:43:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hLOcPl8xEw/Render', 02:43:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:43:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:43:39 INFO - 'HOME': '/Users/cltbld', 02:43:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:43:39 INFO - 'LOGNAME': 'cltbld', 02:43:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:43:39 INFO - 'MOZ_NO_REMOTE': '1', 02:43:39 INFO - 'NO_EM_RESTART': '1', 02:43:39 INFO - 'PAGER': '/bin/cat', 02:43:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:43:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:43:39 INFO - 'PWD': '/builds/slave/test', 02:43:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:43:39 INFO - 'SHELL': '/bin/bash', 02:43:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nD2QFHjdc8/Listeners', 02:43:39 INFO - 'TMPDIR': '/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/', 02:43:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:43:39 INFO - 'USER': 'cltbld', 02:43:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:43:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:43:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:43:39 INFO - 'XPC_FLAGS': '0x0', 02:43:39 INFO - 'XPC_SERVICE_NAME': '0', 02:43:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:43:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:43:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:43:40 INFO - Running setup.py (path:/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/pip-VMwBh6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:43:40 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)) 02:43:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:43:40 INFO - Running setup.py (path:/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/pip-E31gaS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:43:40 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)) 02:43:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:43:40 INFO - Running setup.py (path:/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/pip-8nsery-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:43:40 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)) 02:43:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:43:40 INFO - Running setup.py (path:/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/pip-Szgr_p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:43:40 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)) 02:43:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:43:40 INFO - Running setup.py (path:/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/pip-Ti0jo3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:43:40 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)) 02:43:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:43:40 INFO - Running setup.py (path:/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/pip-5a79K5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:43:40 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)) 02:43:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:43:40 INFO - Running setup.py (path:/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/pip-XsZkQ2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:43:40 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)) 02:43:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:43:40 INFO - Running setup.py (path:/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/pip-Yru9_8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:43:41 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)) 02:43:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:43:41 INFO - Running setup.py (path:/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/pip-AFw6CG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:43:41 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)) 02:43:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:43:41 INFO - Running setup.py (path:/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/pip-HKNwIA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:43:41 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)) 02:43:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:43:41 INFO - Running setup.py (path:/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/pip-Te8SJv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:43:41 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)) 02:43:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:43:41 INFO - Running setup.py (path:/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/pip-pTexWV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:43:41 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)) 02:43:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:43:41 INFO - Running setup.py (path:/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/pip-oLHa69-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:43:41 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)) 02:43:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:43:41 INFO - Running setup.py (path:/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/pip-lK01aU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:43:41 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)) 02:43:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:43:41 INFO - Running setup.py (path:/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/pip-lE2CE8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:43:41 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)) 02:43:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:43:41 INFO - Running setup.py (path:/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/pip-J2rxh7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:43:41 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)) 02:43:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:43:41 INFO - Running setup.py (path:/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/pip-2ruq7V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:43:41 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)) 02:43:41 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)) 02:43:41 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)) 02:43:41 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)) 02:43:41 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)) 02:43:41 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)) 02:43:41 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:43:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:43:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:43:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:43:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:43:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:43:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:43:44 INFO - Downloading blessings-1.6.tar.gz 02:43:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:43:44 INFO - Installing collected packages: blessings 02:43:44 INFO - Running setup.py install for blessings 02:43:44 INFO - Successfully installed blessings 02:43:44 INFO - Cleaning up... 02:43:44 INFO - Return code: 0 02:43:44 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:43:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:43:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:43:45 INFO - Reading from file tmpfile_stdout 02:43:45 INFO - Current package versions: 02:43:45 INFO - blessings == 1.6 02:43:45 INFO - blobuploader == 1.2.4 02:43:45 INFO - docopt == 0.6.1 02:43:45 INFO - manifestparser == 1.1 02:43:45 INFO - mozInstall == 1.12 02:43:45 INFO - mozcrash == 0.17 02:43:45 INFO - mozdebug == 0.1 02:43:45 INFO - mozdevice == 0.48 02:43:45 INFO - mozfile == 1.2 02:43:45 INFO - mozhttpd == 0.7 02:43:45 INFO - mozinfo == 0.9 02:43:45 INFO - mozleak == 0.1 02:43:45 INFO - mozlog == 3.2 02:43:45 INFO - moznetwork == 0.27 02:43:45 INFO - mozprocess == 0.22 02:43:45 INFO - mozprofile == 0.28 02:43:45 INFO - mozrunner == 6.11 02:43:45 INFO - mozscreenshot == 0.1 02:43:45 INFO - mozsystemmonitor == 0.3 02:43:45 INFO - moztest == 0.7 02:43:45 INFO - mozversion == 1.4 02:43:45 INFO - psutil == 3.1.1 02:43:45 INFO - requests == 1.2.3 02:43:45 INFO - wsgiref == 0.1.2 02:43:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:43:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:43:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:43:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:43:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:43:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:43:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:43:45 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 0x106d92a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106d98570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fadd3cac3c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106c36d30>, '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 0x106a5adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106c2db20>, '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.hLOcPl8xEw/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.nD2QFHjdc8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/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 02:43:45 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 02:43:45 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 02:43:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hLOcPl8xEw/Render', 02:43:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:43:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:43:45 INFO - 'HOME': '/Users/cltbld', 02:43:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:43:45 INFO - 'LOGNAME': 'cltbld', 02:43:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:43:45 INFO - 'MOZ_NO_REMOTE': '1', 02:43:45 INFO - 'NO_EM_RESTART': '1', 02:43:45 INFO - 'PAGER': '/bin/cat', 02:43:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:43:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:43:45 INFO - 'PWD': '/builds/slave/test', 02:43:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:43:45 INFO - 'SHELL': '/bin/bash', 02:43:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nD2QFHjdc8/Listeners', 02:43:45 INFO - 'TMPDIR': '/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/', 02:43:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:43:45 INFO - 'USER': 'cltbld', 02:43:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:43:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:43:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:43:45 INFO - 'XPC_FLAGS': '0x0', 02:43:45 INFO - 'XPC_SERVICE_NAME': '0', 02:43:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:43:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:43:45 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)) 02:43:45 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)) 02:43:45 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)) 02:43:45 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)) 02:43:45 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)) 02:43:45 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)) 02:43:45 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)) 02:43:45 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)) 02:43:45 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)) 02:43:45 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)) 02:43:45 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)) 02:43:45 INFO - Cleaning up... 02:43:45 INFO - Return code: 0 02:43:45 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:43:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:43:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:43:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:43:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:43:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:43:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:43:45 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 0x106d92a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106d98570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fadd3cac3c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106c36d30>, '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 0x106a5adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106c2db20>, '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.hLOcPl8xEw/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.nD2QFHjdc8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/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 02:43:45 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 02:43:45 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 02:43:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hLOcPl8xEw/Render', 02:43:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:43:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:43:45 INFO - 'HOME': '/Users/cltbld', 02:43:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:43:45 INFO - 'LOGNAME': 'cltbld', 02:43:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:43:45 INFO - 'MOZ_NO_REMOTE': '1', 02:43:45 INFO - 'NO_EM_RESTART': '1', 02:43:45 INFO - 'PAGER': '/bin/cat', 02:43:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:43:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:43:45 INFO - 'PWD': '/builds/slave/test', 02:43:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:43:45 INFO - 'SHELL': '/bin/bash', 02:43:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nD2QFHjdc8/Listeners', 02:43:45 INFO - 'TMPDIR': '/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/', 02:43:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:43:45 INFO - 'USER': 'cltbld', 02:43:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:43:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:43:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:43:45 INFO - 'XPC_FLAGS': '0x0', 02:43:45 INFO - 'XPC_SERVICE_NAME': '0', 02:43:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:43:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:43:45 INFO - Downloading/unpacking jsonschema 02:43:45 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 02:43:45 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 02:43:45 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 02:43:45 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 02:43:45 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 02:43:45 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 02:43:48 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:43:48 INFO - Downloading/unpacking functools32 (from jsonschema) 02:43:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:43:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:43:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:43:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:43:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:43:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:43:48 INFO - Downloading functools32-3.2.3-2.tar.gz 02:43:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:43:48 INFO - warning: no files found matching '*.txt' 02:43:48 INFO - no previously-included directories found matching 'build' 02:43:48 INFO - no previously-included directories found matching 'dist' 02:43:48 INFO - no previously-included directories found matching '.git*' 02:43:48 INFO - Installing collected packages: jsonschema, functools32 02:43:48 INFO - Running setup.py install for functools32 02:43:48 INFO - warning: no files found matching '*.txt' 02:43:48 INFO - no previously-included directories found matching 'build' 02:43:48 INFO - no previously-included directories found matching 'dist' 02:43:48 INFO - no previously-included directories found matching '.git*' 02:43:48 INFO - Successfully installed jsonschema functools32 02:43:48 INFO - Cleaning up... 02:43:48 INFO - Return code: 0 02:43:48 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 02:43:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:43:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:43:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:43:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:43:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:43:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:43:48 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 0x106d92a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106d98570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fadd3cac3c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106c36d30>, '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 0x106a5adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106c2db20>, '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.hLOcPl8xEw/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.nD2QFHjdc8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/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 02:43:48 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 02:43:48 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 02:43:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hLOcPl8xEw/Render', 02:43:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:43:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:43:48 INFO - 'HOME': '/Users/cltbld', 02:43:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:43:48 INFO - 'LOGNAME': 'cltbld', 02:43:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:43:48 INFO - 'MOZ_NO_REMOTE': '1', 02:43:48 INFO - 'NO_EM_RESTART': '1', 02:43:48 INFO - 'PAGER': '/bin/cat', 02:43:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:43:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:43:48 INFO - 'PWD': '/builds/slave/test', 02:43:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:43:48 INFO - 'SHELL': '/bin/bash', 02:43:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nD2QFHjdc8/Listeners', 02:43:48 INFO - 'TMPDIR': '/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/', 02:43:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:43:48 INFO - 'USER': 'cltbld', 02:43:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:43:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:43:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:43:48 INFO - 'XPC_FLAGS': '0x0', 02:43:48 INFO - 'XPC_SERVICE_NAME': '0', 02:43:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:43:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:43:49 INFO - Downloading/unpacking flake8 02:43: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 02:43: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 02:43: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 02:43: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 02:43: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 02:43: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 02:43:51 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 02:43:51 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 02:43: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 02:43: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 02:43: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 02:43: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 02:43: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 02:43: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 02:43:51 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 02:43:51 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 02:43: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 02:43: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 02:43: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 02:43: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 02:43: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 02:43: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 02:43:52 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 02:43:52 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 02:43:52 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 02:43:52 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 02:43:52 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 02:43:52 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 02:43:52 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 02:43:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 02:43:52 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:43:52 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:43:52 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:43:52 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:43:52 INFO - no previously-included directories found matching 'docs/_build' 02:43:52 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 02:43:52 INFO - Running setup.py install for pep8 02:43:52 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:43:52 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:43:52 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:43:52 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:43:52 INFO - no previously-included directories found matching 'docs/_build' 02:43:53 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 02:43:53 INFO - Successfully installed flake8 mccabe pyflakes pep8 02:43:53 INFO - Cleaning up... 02:43:53 INFO - Return code: 0 02:43:53 INFO - Running post-action listener: _resource_record_post_action 02:43:53 INFO - Running post-action listener: _start_resource_monitoring 02:43:53 INFO - Starting resource monitoring. 02:43:53 INFO - ##### 02:43:53 INFO - ##### Finished create-virtualenv step (success) 02:43:53 INFO - ##### 02:43:53 INFO - ##### 02:43:53 INFO - ##### Running install step. 02:43:53 INFO - ##### 02:43:53 INFO - Running pre-action listener: _resource_record_pre_action 02:43:53 INFO - Running main action method: install 02:43:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:43:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:43:53 INFO - Reading from file tmpfile_stdout 02:43:53 INFO - Detecting whether we're running mozinstall >=1.0... 02:43:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:43:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:43:53 INFO - Reading from file tmpfile_stdout 02:43:53 INFO - Output received: 02:43:53 INFO - Usage: mozinstall [options] installer 02:43:53 INFO - Options: 02:43:53 INFO - -h, --help show this help message and exit 02:43:53 INFO - -d DEST, --destination=DEST 02:43:53 INFO - Directory to install application into. [default: 02:43:53 INFO - "/builds/slave/test"] 02:43:53 INFO - --app=APP Application being installed. [default: firefox] 02:43:53 INFO - mkdir: /builds/slave/test/build/application 02:43:53 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'] 02:43:53 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 02:44:27 INFO - Reading from file tmpfile_stdout 02:44:27 INFO - Output received: 02:44:27 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 02:44:27 INFO - Running post-action listener: _resource_record_post_action 02:44:27 INFO - ##### 02:44:27 INFO - ##### Finished install step (success) 02:44:27 INFO - ##### 02:44:27 INFO - ##### 02:44:27 INFO - ##### Running run-tests step. 02:44:27 INFO - ##### 02:44:27 INFO - Running pre-action listener: _resource_record_pre_action 02:44:27 INFO - Running main action method: run_tests 02:44:27 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:44:27 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:44:27 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:44:27 INFO - 2016-05-16 02:44:27.058 screenresolution[1655:9107] starting screenresolution argv=screenresolution get 02:44:27 INFO - 2016-05-16 02:44:27.061 screenresolution[1655:9107] Display 0: 1600x1200x32@60 02:44:27 INFO - 2016-05-16 02:44:27.067 screenresolution[1656:9109] starting screenresolution argv=screenresolution list 02:44:27 INFO - Available Modes on Display 0 02:44:27 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:44:27 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:44:27 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:44:27 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:44:27 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:44:27 INFO - Intel Iris: 02:44:27 INFO - Chipset Model: Intel Iris 02:44:27 INFO - Type: GPU 02:44:27 INFO - Bus: Built-In 02:44:27 INFO - VRAM (Dynamic, Max): 1536 MB 02:44:27 INFO - Vendor: Intel (0x8086) 02:44:27 INFO - Device ID: 0x0a2e 02:44:27 INFO - Revision ID: 0x0009 02:44:27 INFO - Displays: 02:44:27 INFO - Display: 02:44:27 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:44:27 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:44:27 INFO - Display Serial Number: 1600x1200 60 02:44:27 INFO - Main Display: Yes 02:44:27 INFO - Mirror: Off 02:44:27 INFO - Online: Yes 02:44:27 INFO - Rotation: Supported 02:44:27 INFO - Return code: 0 02:44:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:44:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:44:27 INFO - Python 2.7.3 02:44:27 INFO - Return code: 0 02:44:27 INFO - grabbing minidump binary from tooltool 02:44:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:44:27 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 0x106c36d30>, '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 0x106a5adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106c2db20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:44:27 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 02:44:27 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 02:44:27 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 02:44:27 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:44:27 INFO - Return code: 0 02:44:27 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 02:44:27 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:44:27 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:44:27 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 02:44:27 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:44:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 02:44:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 02:44:28 INFO - Return code: 0 02:44:28 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', '--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-0371', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 02:44:28 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 --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-0371 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 02:44:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hLOcPl8xEw/Render', 02:44:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:44:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:44:28 INFO - 'HOME': '/Users/cltbld', 02:44:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:44:28 INFO - 'LOGNAME': 'cltbld', 02:44:28 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:44:28 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 02:44:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:44:28 INFO - 'MOZ_NO_REMOTE': '1', 02:44:28 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:44:28 INFO - 'NO_EM_RESTART': '1', 02:44:28 INFO - 'PAGER': '/bin/cat', 02:44:28 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:44:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:44:28 INFO - 'PWD': '/builds/slave/test', 02:44:28 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:44:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:44:28 INFO - 'SHELL': '/bin/bash', 02:44:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nD2QFHjdc8/Listeners', 02:44:28 INFO - 'TMPDIR': '/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/', 02:44:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:44:28 INFO - 'USER': 'cltbld', 02:44:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:44:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:44:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:44:28 INFO - 'XPC_FLAGS': '0x0', 02:44:28 INFO - 'XPC_SERVICE_NAME': '0', 02:44:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:44:28 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--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-0371', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 02:44:28 INFO - mozversion application_buildid: 20160516005330 02:44:28 INFO - mozversion application_changeset: 0c29ad917ac38c9ef26c9ff0b5d9762e75d13948 02:44:28 INFO - mozversion application_display_name: Nightly 02:44:28 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:44:28 INFO - mozversion application_name: Firefox 02:44:28 INFO - mozversion application_remotingname: firefox 02:44:28 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 02:44:28 INFO - mozversion application_vendor: Mozilla 02:44:28 INFO - mozversion application_version: 49.0a1 02:44:28 INFO - mozversion platform_buildid: 20160516005330 02:44:28 INFO - mozversion platform_changeset: 0c29ad917ac38c9ef26c9ff0b5d9762e75d13948 02:44:28 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 02:44:28 INFO - mozversion platform_version: 49.0a1 02:44:28 INFO - using testdate: 1463391868 02:44:28 INFO - actual date: 1463391868 02:44:28 INFO - starting webserver on 'localhost:49278' 02:44:28 INFO - SUITE-START | Running 2 tests 02:44:28 INFO - TEST-START | dromaeo_css 02:44:28 INFO - operating with platform_type : mac_ 02:44:28 INFO - Initialising browser for dromaeo_css test... 02:44:28 INFO - TEST-INFO | started process 1674 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/tmpeb5a3o/profile http://localhost:49278/getInfo.html) 02:44:31 INFO - PROCESS | 1674 | __metrics Screen width/height:1600/1200 02:44:31 INFO - PROCESS | 1674 | colorDepth:24 02:44:31 INFO - PROCESS | 1674 | Browser inner width/height: 1024/689 02:44:31 INFO - PROCESS | 1674 | __metrics 02:44:31 INFO - PROCESS | 1674 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 02:44:31 ERROR - PROCESS | 1674 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 02:44:31 INFO - TEST-INFO | 1674: exit 0 02:44:31 INFO - Browser initialized. 02:44:31 INFO - Running cycle 1/1 for dromaeo_css test... 02:44:31 INFO - TEST-INFO | started process 1677 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/tmpeb5a3o/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:44:43 INFO - PROCESS | 1677 | RSS: Main: 239173632 02:44:43 INFO - PROCESS | 1677 | 02:45:35 INFO - PROCESS | 1677 | 1463391935798 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] 02:47:46 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49278/tests/dromaeo/cssquery-ext.html) 02:47:47 INFO - PROCESS | 1677 | RSS: Main: 343777280 02:47:47 INFO - PROCESS | 1677 | 02:50:50 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-ext.html (next: http://localhost:49278/tests/dromaeo/cssquery-jquery.html) 02:50:50 INFO - PROCESS | 1677 | RSS: Main: 372158464 02:50:50 INFO - PROCESS | 1677 | 02:53:52 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49278/tests/dromaeo/cssquery-mootools.html) 02:53:53 INFO - PROCESS | 1677 | RSS: Main: 369459200 02:53:53 INFO - PROCESS | 1677 | 02:56:55 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49278/tests/dromaeo/cssquery-prototype.html) 02:56:56 INFO - PROCESS | 1677 | RSS: Main: 363479040 02:56:56 INFO - PROCESS | 1677 | 02:59:59 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49278/tests/dromaeo/cssquery-yui.html) 03:00:00 INFO - PROCESS | 1677 | RSS: Main: 338317312 03:00:00 INFO - PROCESS | 1677 | 03:03:03 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-yui.html (next: http://localhost:49278/tests/dromaeo/cssquery-dojo.html) 03:03:03 INFO - PROCESS | 1677 | RSS: Main: 375517184 03:03:03 INFO - PROCESS | 1677 | 03:03:03 INFO - PROCESS | 1677 | __start_tp_report 03:03:03 INFO - PROCESS | 1677 | _x_x_mozilla_page_load 03:03:03 INFO - PROCESS | 1677 | _x_x_mozilla_page_load_details 03:03:03 INFO - PROCESS | 1677 | |i|pagename|runs| 03:03:03 INFO - PROCESS | 1677 | |0;dojo.html;3409.573803274591;3434.8626054957804;3455.7062649674767;3461.0655123116744;3500.2824420993697;5604;5606.35526914405;5624.550035997121;5676.489115979561;5702.087665973445;5633.80281690141;5656.264685590878;5663;5715.828525144242;5749.396313387097;5041.092603331399;5098.872528186806;5140.794368225266;5150.716710580917;5229.790808367661;5238.711870847102;5241.161414173733;5263.31576895005;5275.103232450492;5301.628885977983;5105.387353517564;5130.53825155734;5143.5113664201845;5148.021875843578;5182.144946083891;5007.273945277914;5098.490150984909;5113.233015047773;5139.049275883974;5154.355705536808;5077.720725360104;5096.413912400048;5106.540411362995;5183.222516622499;5210.895782084375;4658.742139622283;5502.9174562381595;5616.410276920906;5618.988582055228;5651.576131790132;6083.11794789753;6139;6171.845703857394;6176;6231.750729970796;6246.437820596168;6296.590721603081;6313.210848643919;6330.3669633036325;6330.3669633036325;5536.529395001389;5773.220615216934;5780.3063632363965;5823.79616713413;5828.067509198508;6290.308066112724;6347.365263473615;6351.71417286214;6364.236291644939;6421.101045853584;6090.204250113173;6106.603070800384;6107.227966617123;6112.017184454359;6130.63216207029;6112;6218.5647004710145;6259.436650701458;6267.529935254783;6286.874262514724;6040.124181993587;6119.106526814625;6122.245686735438;6123.160610921289;6131.172291740647;6131.988406491236;6136.21274067861;6170.197874276315;6173.660448675366;6259.186305780219;4869.074875773592;4874.341963834837;4883.1562520254765;4896.510348965075;4922.360093187863;4346.695731298779;4392.407025051577;4395.978020109943;4431.003024319502;4463.509014008457;5586.525145362609;5648.74580643872;5683.8863222736145;5704.001799685038;5719.857003574861;6300.27546832111;6311.021791622214;6322.462590679844;6327.050942358591;6364.363563643691;5602.747876345574;5670.603057785916;5728.083506639001;5743.4543718346695;5795;5263.605229607795;5315.73421328932;5340.652857564246;5344.706041167773;5365.08793505105;6325.841853953596;6329.873402531832;6350.555461117862;6352.333005034589;6373.71318290678;6098.704546243851;6106.642687876592;6271.717772700148;6283.151774510383;6294;6280.340564240689;6389.36106389376;6398.936010639834;6400.263969643364;6406.807795766134;6053.545984051302;6055.7577696893395;6067.817965461043;6069.51443884497;6073.483753880793;6135.171422439309;6142.170806941006;6145.494353883327;6194.132821405097;6208.968955155376;6052;6087.726052327745;6097.847553811191;6098.969505152623;6131.877362452637;6009.36901625323;6071.39286071407;6079.088136779518;6082.9695851520455;6092.421219984094;5768.50967667753;5846.853828654318;5914.881702366015;5922.851928701817;5927.792527261525;5067.645264831426;5763.221965034667;5956.285245770535;6101.816945491642;6112.005117492307;5900.822975310747;5913.763449462145;5924.140999555127;5928.762849485972;5932.288125424977 03:03:03 INFO - PROCESS | 1677 | |1;ext.html;520.1573451009363;531.893621275745;540.4784383070337;549.3325609384598;562.9746661400237;31896.521552176706;42363.576364236345;47038.529614703846;47076.293855592194;47257.763711181484;36552.26895462089;38282.425763613566;45525.54474455254;45556;45654.77172614141;8558.529280889548;9808.607655693782;10011.549480273405;10014.699559013241;10018;9727.659531916384;9775.75560610987;9775.951120244388;9779;9782.657606983757;9777.31558790885;9809.705708828747;9814.362066465692;9821.2634052446;9824;9728.610855565768;9783.804323913482;9788.510574471247;9792.608295668164;9820.116189542903;9636.518174091267;9698.224142068688;9710.805783884354;9719.319647624669;9720.416774993522;43158;43358;43433;43695.344569831475;43749.78125109354;3214.5017522284083;3226.0966929259844;3241;3242.3515296940705;3395.303962687643;29873.551896721565;29887;29997.70002299971;30025.399492010256;30450.54324185139;2715.891364345424;2725.795565332588;2774.4728501584837;2790.8046436749437;2797.1608517444683;528779;529088;530936;531262;531626;65985;66489.33510664928;66516;66617.00372472084;66678;37569.62430375716;39229.80385098056;39364.40953385702;39371.40942885859;66849.99725004128;17476;17499.212535435938;17658.205380757896;17679.292828286983;17685.292588296583;13278.402471888789;13390.799138012937;13400.865991339962;13411.463541458428;13413.597592072254;20675.6223034353;20839.8958005209;20870.495540535234;20933.685994710093;20980.580388392147;7056.54132481387;8254.380921430917;8352.582370881431;8355.248027677539;8494.70268540598;844.9788755281044;923.215267023025;1010.3129871687323;1015.9238057145743;1040.193849766437;28399.43201135966;28739.56890646642;29992.85003574968;30062.849685751433;30790.38419231603;973.3284034016506;1014.453987973169;1061.7027232374946;1072.7908057928785;1231.605886116452;13605;15713.135777532345;15733.685326293638;16169.514914552583;16273.674526509403;723719;729280;733944;735531;737447;64060;64624.35375646183;64693.353066469674;64720.20437854052;64770;1364.6179069860455;1403.5087719298165;1479.8890083243584;1508.781226722119;1528.0373364780116;30315.393692126476;31253;31299.530507041956;31910.840445798553;32111;54813.725931370085;54922;55499.89000220054;55579.44420555905;55651.49568269519;559623;564978;565516;565600;567795;24218;27239.910403583635;27977.580336294566;28071.157865264075;28237.43525129445;48411.75794121007;49115.508844912525;49266.50733492763;49487.50512494973;50155;37004.074898127765;38780.41829372505;38787;39568;39767.2046559073;38231.426528601536;38396;39034.02414939649;39880.60119398885;40093.79953100216;38634.03414914649;38706.61293387143;39150.6084939147;39582.80208598939;39612;32343.838280808446;33836;34409.403812221775;34694.65305346914;35228;24075;25191.748082519673;25572.10497632574;25743.356416089748;25938.48123037491 03:03:03 INFO - PROCESS | 1677 | |2;jquery.html;398.9567281558724;401.23965086161724;401.33378591538053;405.9411385349123;421.5342047038023;20772.480687982807;20880.791192088076;21220.681689774665;21733;21922.780772192295;20750.27374041909;21092.367228983116;21994.230201942933;22288.888555557198;22377.77622223777;5936.970315148418;6185.938140618604;6214.192155019841;6218.626882387049;6219.626822390648;5036.546710796028;6100.72546735398;6111.755529778803;6183;6194.039923811816;5130.410002849682;6093.238345206849;6104.725287362057;6118.204633397652;6131.601445906024;5964.105384192384;6550.967245163767;6614.305497922697;6634.170728658918;6640.634765087894;5632.394767491286;5865.266841644794;5886.175935369051;5891.322497912752;5901.675407852566;13654.317284135854;13971.65070873226;14145;14245;14256.429742810378;2036.4140114783327;2060.9690854637192;2063.401613532089;2069.2033567076633;2312.7802858728396;9609.471479068648;10057.994200579957;10191.03185197405;10446.425446600433;10485.161187105014;1726.7409888516697;1759.692053890564;1893;1902.9137748383732;2039.8470114741453;120436;125659;126366;127130.99999999907;127455;10591.099756520627;11073.889261107446;11876.76246475083;11906.404679765978;11910;15386.153761542999;15468.839837012045;15480;15503.147326896904;15503.379864805507;8822.558872056372;8893.066228045962;8903.109689031175;8922.955385223033;9043.728688139236;8772.736817895346;8780.824383512421;8793.120687931156;8921.643134274686;8937.46375217489;4742.786574604151;4751.59611433032;4753.691010084333;4754.833580824724;4810.735409552438;1960.4902725291527;1993.2824183294003;1993.3920154353061;1997.6204521140937;2009.4875806669497;783.3615603283306;876.9429987050821;908.5502676175336;912.397817440486;924.1636319131197;17992.820071799375;20435.87602681837;21495;21517.354479365644;21654.02556884944;785.3246208260891;811.2820154163489;898.874157617934;932.846080396727;1062.2298833345762;8803.603837827313;11162.441877906072;11375.488103035383;11389.829152562717;11404.372759498141;595719;602508;610778;621283;621879;120279.39860300643;143151;143210.28394858167;143311;144963;982.3958265666564;992.2310209587628;1065.7815147894662;1068.407034096084;1071.0735214039798;16905.830941690918;19342.8065719341;19667.70498442496;19695.409137725892;19708.50728731793;41439.7928010358;52082.43752687425;53989;55338.72330638321;57506.7124664374;83459;86241.56879215814;86963.56518217368;88674;90972;8234.588270586328;8246.257836794717;8331.750047498585;8412.87380689278;8498.872516912375;7440.181580026301;11321.603743868925;11587.5944341951;12749.87250127487;13431.395587198404;10981.176411768989;11172.765446910487;11246.493907774333;11299.604513841976;11467.942660286646;7413.073365829271;10974.176936729618;11110;11246.268992515461;11401.087912967108;11123.165762568002;11614.477348519167;11633.243839150427;11810.409479525817;11984.041276698017;7125.82185445368;8231.42380033392;8313.501189928624;8562.657493700182;8773.990991035856;9666.95166524163;11348;11681.707957301136;11739.06087513014;11798.351090689752 03:03:03 INFO - PROCESS | 1677 | |3;mootools.html;1383.7647599908014;1579.2972127403307;1627.3409269245954;1831.4963385069104;1953.5995121000196;7802.765917022484;8839.381243312962;9054.366194366397;9057.818843623132;9210.953945230282;8832.895888013998;9063.184313411792;9063.592138353773;9086.363954523185;9107;1987.860849740515;2451.350392146083;2455.177515532299;2457.0908763757348;2457.5207834472285;2413.4449076712367;2452.2152911068465;2461.913833015845;2465.149523414428;2466.149178533412;2416.4079800448912;2432.2460037388378;2452.227548322273;2454.7790698837102;2455.3370589940796;2392.4018995251186;2429.5019520998153;2434.306222726523;2438.0979037756056;2444.352246654638;2397.2927986243926;2417.8549287042833;2426.636004599324;2429.0648100481444;2430.2101816909576;8871.37900346976;8947.955260223658;9029.638814447415;9049.095090490964;9060.411073280282;5339.332583427072;5594.916076258859;5599.496045355938;5601.915971260434;5602.803901863456;3507.421275489541;3608.9097772555633;3689.2805902848954;3704.592494825567;3706.313627299572;1047.743302890789;1049.438550375553;1051.7633532455213;1052.7999680060764;1054.0250268501682;11854.288742675468;11964.40177991097;11979;11988.861058199544;12014.219075760047;4673.976630116827;4677.298405239241;4802.615790736732;4824.421069471686;4839.951600484021;9441.811163776823;9442.103000215106;9453;9477.28920330978;9477.715668529956;5387.542058925035;5398.24424580559;5400.21696853954;5407.215953686693;5409.188621706776;4151.356539736345;4540.84107056258;4669.836555720602;4930.038642464685;4984.626153038536;3897.824597893102;3914.2171565686976;3944.6252606002386;3978.9403158952637;4015.598440155961;1202.9218100823593;1211.121936595961;1219.5365761010937;1223.816427535859;1242.7887259165964;661.6890061671007;791.7228969860503;816.6814942172557;905.8505346617734;921.4425272710048;5649.745761440745;5659.886802264014;6101.84745381369;6109.908351374733;6155.569110162335;425.16455165599746;443.5054913771122;449.08386890743174;468.2554737966581;475.7145712572429;3935.252302062599;4000.3199456092534;4032.03231224504;4045.211183819127;4049.4735684360844;10419.531121099568;11032.613858515075;11112.11103111749;11129.054030407506;11136.665900023012;10798;10952.726181845517;11021.283616564897;11039.613613523488;11076.003159715665;8267.255946964802;8441.282490988335;8482.575871206538;8490.830183396298;8492.617832197566;5304.549113325411;5743.712814359349;5786.681732504752;5853.707314634336;5916.733746981482;10221.43782091992;10308.072273495422;10372.962703729869;10424.113950314006;10440.68677939663;9733.124018838338;10107.595696172071;10271;10291.279610427198;10499.632512862014;7113.928860711327;7362;7580.3556697681315;7764.184760600281;7778.805529861799;7707.730229441942;8422.747317580483;8625.223729864343;8744;8762.693305734269;7660.195679453577;7668.96468976681;7693;7787.5716835574585;7824.64789084504;7492.325690687864;7497.700091996478;7520.962395188208;7629.198934111839;7737.806554836174;6938.930610693828;7164.104486939133;7256.455765817479;7259.673314700956;7268.236835132235;4828.61371090319;4940.431850337113;5023.120953832991;5028.572571331478;5030.949690503048;4442.2892337225885;5001.799928002984;5045.974770126126;5066.214736715815;5175.249588809676 03:03:03 INFO - PROCESS | 1677 | |4;prototype.html;307.8599237347007;315.1349545497608;319.33418821756635;322.95155726641013;328.4023077998045;4442.644588432926;4673.948361618634;5074.782052307447;5167.715775632339;5210.7655155518;4658.580727734503;5049.192129259319;5120.4623514530995;5186.585073194145;5195.428502864682;3602.3969333646605;3794.6964242860504;3814.7329686921926;3966.9801650991703;3979.6418322350983;3736.8878933632036;3848.2495913296916;3908.9804550977346;3971;3986.900327491807;3280.8025070849208;3291.078498020558;3931.8034098295116;3969.8610548630804;3981.86063487778;3681.9263614727824;3702;3826.9617303826885;3937.0511596759643;3947.585503522146;2795.7623601993855;2876.2521744346623;2876.8492602958777;3431.519587257786;3437.329720704464;4173.914782156631;4868.610511159099;4926.989967056745;4929.9154186079;4945.406551213878;3971.4908334832867;4340.631046361063;4487.080148569536;4532.4334458192725;4565.315202719586;4694.647901407408;5329.946700532983;5335.973320133375;5347.144456886918;5349.331333583302;3384.1539615096226;3555.9687690569704;3702.7037836972977;3854.4411060396365;3867.3425517662067;4482.081173359518;5683.46546432465;5688.402717714622;5698.715064246771;5707.857303567403;3453.6028356738793;3763.121212272614;3767.9434808477895;3782.3002744492355;3783.9621603783607;3834.7123965702685;3846.8461261549783;3853.9421908671393;3854.6316057799077;3872.9225415491533;4416.851618579192;4442.044960333544;4458.331250312479;4462.576055274743;4470.240059189946;4316;4354.433923589913;4608.239640459286;5315.3621565412395;5357.946420535744;1177.4986891712963;1258.314218750783;1277.8019406991932;1308.1235572166481;1308.2019967819622;727.3708242370417;766.7201471462876;776.7397921696295;798.7084714079319;812.9959350203211;4576.58810707038;4786.64100192487;4923.950760492421;4965.652404331734;4966.180580204298;4757.381540399795;5108.540231379194;5512.724363781795;5597.972010140004;5603.579731520153;4099.323611604052;4402.481144005313;4891.2581874865755;5058.671186372874;5072.492750724972;2832.9716702832707;2852.3867368515866;2930.941381172365;2938.735513803768;2943.67619561848;4529.9547004530195;5563.972180139073;5783.306003279549;5802.448767367094;5835;5425.240466334716;5575.689712917461;5700.37295897451;5732.742026608813;5807.796727114531;4832.830850920201;4846.975765121152;5679.687617181012;5697.173909782975;5759.308882933991;4733.479317275028;5524;5556.610657417188;5557.861053473695;5596.580256480699;5096.184610462308;5100.897982040413;5114.667546609458;5424.403315635198;5495.6153069284765;5691.751758055628;5712.828615141552;5732.423583514566;5765.336986246635;5779.393163717749;3537.080359106599;3635.01854499289;3746.7002639788207;3757.793321367242;3794.108384529578;4942.3327850741125;5013.871878827381;5114.974425127851;5503.807366742145;5515.338159420895;4147.668186545129;4640.976795116003;5359.490848369399;5366.409694933633;5398;4922.606191504743;5356.946430535645;5378.955996721221;5411.268394113846;5427.267318912054;4237.343211802176;5225.47995983464;5280.947190528199;5282.600110970673;5298.549623282064;4786.138495070921;4876.756162191948;5050.868461553713;5299.920501192562;5343.305370301836;4429.822807087809;4435.046465010038;4852.490488498657;4890.6332025097545;5267.946410717948 03:03:03 INFO - PROCESS | 1677 | |5;yui.html;602.3645054467538;666.7033170239239;678;705.5696025424487;804.3967024731452;15223.162726050063;15854.20728963553;15865.524034278975;15878.36486540537;16884.07137607431;15670.921645391785;16024.679506409893;16026.118563479033;16031.519054428356;16067.758983615255;755.6033082631635;779.1040303650818;928.1507420710059;947.5593848860278;949.1362859797551;766.2337662337662;766.7853001159656;768.8347005393839;916.7937214126835;950.1828427552299;980.3529670417525;983.7786498037956;986.699056787683;987.8616993620899;992.1566668331932;840.848647243496;983.5672304186171;985.9942858284581;986.9654562090292;987.9061489158519;581.2617975171509;597.8415719834247;598.058058557769;600.8948434024072;728.6575309604477;14977.326020329112;15432;15453.459128930434;15640.843591564053;15642.843571564366;12387.75224495514;12425.813612795815;12497.93751031248;12684.682882927907;12815.551455699006;9919.553620087114;9939.353941993748;10010;10347.120494757955;10533.947330263376;3383.7462190335823;3458.948115778265;3513.49054387115;3535.5757309122814;3724.7951362675044;83130.58434707849;87519.12480875237;88199;88520.67218991656;88812.5559372199;9311.301652376098;9481.810363792823;9629.759256018515;10023.849642255373;10039.849402258971;21429.357119286447;21658.458538536663;21674.674879876813;21694.78305216959;21718.78281217199;7506.211847756016;7610.885836712454;7618.8095297618;7704.460687751804;7722.45942784011;3551.271989242199;4047.990198763882;4116.826704389295;4167.791610419466;4308.246056940023;3631.6005239423644;3733.8133093345223;3734.7572407793405;3743.6630703236838;3744;672.0557616548757;680.3298750730527;683.3986092238798;685.9382655561024;687.9965600172068;489.1537639883022;565.9858503537362;577.255340610616;615.4030590327375;616.1866336435861;6826.829329266808;7260.709571617182;7903.220215605421;7951.642176102089;8039.919600803917;534.1187041381673;564.6358099026105;576.5531712922435;591.4558606082414;600.6546235914367;3436.570428696413;3845.692344612424;3898.5516665583255;3923.058465968204;3938.960610393917;70728.64635676789;86982.56508717415;87727.1227287719;87858.56070719734;89748.10251897528;60809;65084;83082.16917830866;84212.57893710492;85213;52403.90384384658;67201;70449.64775176194;71555;72457;6800.217974932748;8263.338932885235;8368.83262334762;8559.887214662054;8604.225619694258;43905.78047109744;44105.67682969516;44369;45149.77425112853;45508.77245613751;59402.405975939684;64358.39104022437;65376;65435;66074;11019.724506887393;11101.666949991513;11104.722381940193;11131.10951123892;11646.534138634699;11953.22304050234;11989.520419183134;12002.519899203933;12629.179103358252;13436.731265374834;11643.074113045668;11815.940920295343;12099.296714681148;12099.395030248628;12221;10985.83521247166;11580.247283926517;11580.478878450658;11647.41762911868;11779.234349767581;11432.256903301592;11490.597829075943;11530.884691152982;11617.0706343494;11937.940310298392;9611.086946740048;9739.513024348897;9780.364276322302;9941.155001824636;10263.12763415118;9590.616375345187;9821.607135714778;9840.753981150528;9925.950370248103;9964.50177491137 03:03:03 INFO - PROCESS | 1677 | __end_tp_report 03:03:03 INFO - PROCESS | 1677 | __start_cc_report 03:03:03 INFO - PROCESS | 1677 | _x_x_mozilla_cycle_collect,1143 03:03:03 INFO - PROCESS | 1677 | __end_cc_report 03:03:03 INFO - PROCESS | 1677 | __startTimestamp1463392983492__endTimestamp 03:03:03 INFO - PROCESS | 1677 | 03:03:03 INFO - PROCESS | 1677 | ------- Summary: start ------- 03:03:03 INFO - PROCESS | 1677 | Number of tests: 6 03:03:03 INFO - PROCESS | 1677 | 03:03:03 INFO - PROCESS | 1677 | [#0] dojo.html Cycles:165 Average:5708.85 Median:5922.85 stddev:643.19 (10.9%) stddev-sans-first:619.35 03:03:03 INFO - PROCESS | 1677 | Values: 3409.6 3434.9 3455.7 3461.1 3500.3 5604.0 5606.4 5624.6 5676.5 5702.1 5633.8 5656.3 5663.0 5715.8 5749.4 5041.1 5098.9 5140.8 5150.7 5229.8 5238.7 5241.2 5263.3 5275.1 5301.6 5105.4 5130.5 5143.5 5148.0 5182.1 5007.3 5098.5 5113.2 5139.0 5154.4 5077.7 5096.4 5106.5 5183.2 5210.9 4658.7 5502.9 5616.4 5619.0 5651.6 6083.1 6139.0 6171.8 6176.0 6231.8 6246.4 6296.6 6313.2 6330.4 6330.4 5536.5 5773.2 5780.3 5823.8 5828.1 6290.3 6347.4 6351.7 6364.2 6421.1 6090.2 6106.6 6107.2 6112.0 6130.6 6112.0 6218.6 6259.4 6267.5 6286.9 6040.1 6119.1 6122.2 6123.2 6131.2 6132.0 6136.2 6170.2 6173.7 6259.2 4869.1 4874.3 4883.2 4896.5 4922.4 4346.7 4392.4 4396.0 4431.0 4463.5 5586.5 5648.7 5683.9 5704.0 5719.9 6300.3 6311.0 6322.5 6327.1 6364.4 5602.7 5670.6 5728.1 5743.5 5795.0 5263.6 5315.7 5340.7 5344.7 5365.1 6325.8 6329.9 6350.6 6352.3 6373.7 6098.7 6106.6 6271.7 6283.2 6294.0 6280.3 6389.4 6398.9 6400.3 6406.8 6053.5 6055.8 6067.8 6069.5 6073.5 6135.2 6142.2 6145.5 6194.1 6209.0 6052.0 6087.7 6097.8 6099.0 6131.9 6009.4 6071.4 6079.1 6083.0 6092.4 5768.5 5846.9 5914.9 5922.9 5927.8 5067.6 5763.2 5956.3 6101.8 6112.0 5900.8 5913.8 5924.1 5928.8 5932.3 03:03:03 INFO - PROCESS | 1677 | 03:03:03 INFO - PROCESS | 1677 | [#1] ext.html Cycles:180 Average:74024.88 Median:39469.70 stddev:164782.60 (417.5%) stddev-sans-first:165152.44 03:03:03 INFO - PROCESS | 1677 | Values: 520.2 531.9 540.5 549.3 563.0 31896.5 42363.6 47038.5 47076.3 47257.8 36552.3 38282.4 45525.5 45556.0 45654.8 8558.5 9808.6 10011.5 10014.7 10018.0 9727.7 9775.8 9776.0 9779.0 9782.7 9777.3 9809.7 9814.4 9821.3 9824.0 9728.6 9783.8 9788.5 9792.6 9820.1 9636.5 9698.2 9710.8 9719.3 9720.4 43158.0 43358.0 43433.0 43695.3 43749.8 3214.5 3226.1 3241.0 3242.4 3395.3 29873.6 29887.0 29997.7 30025.4 30450.5 2715.9 2725.8 2774.5 2790.8 2797.2 528779.0 529088.0 530936.0 531262.0 531626.0 65985.0 66489.3 66516.0 66617.0 66678.0 37569.6 39229.8 39364.4 39371.4 66850.0 17476.0 17499.2 17658.2 17679.3 17685.3 13278.4 13390.8 13400.9 13411.5 13413.6 20675.6 20839.9 20870.5 20933.7 20980.6 7056.5 8254.4 8352.6 8355.2 8494.7 845.0 923.2 1010.3 1015.9 1040.2 28399.4 28739.6 29992.9 30062.8 30790.4 973.3 1014.5 1061.7 1072.8 1231.6 13605.0 15713.1 15733.7 16169.5 16273.7 723719.0 729280.0 733944.0 735531.0 737447.0 64060.0 64624.4 64693.4 64720.2 64770.0 1364.6 1403.5 1479.9 1508.8 1528.0 30315.4 31253.0 31299.5 31910.8 32111.0 54813.7 54922.0 55499.9 55579.4 55651.5 559623.0 564978.0 565516.0 565600.0 567795.0 24218.0 27239.9 27977.6 28071.2 28237.4 48411.8 49115.5 49266.5 49487.5 50155.0 37004.1 38780.4 38787.0 39568.0 39767.2 38231.4 38396.0 39034.0 39880.6 40093.8 38634.0 38706.6 39150.6 39582.8 39612.0 32343.8 33836.0 34409.4 34694.7 35228.0 24075.0 25191.7 25572.1 25743.4 25938.5 03:03:03 INFO - PROCESS | 1677 | 03:03:03 INFO - PROCESS | 1677 | [#2] jquery.html Cycles:180 Average:35923.37 Median:22141.56 stddev:102406.15 (462.5%) stddev-sans-first:102658.68 03:03:03 INFO - PROCESS | 1677 | Values: 399.0 401.2 401.3 405.9 421.5 20772.5 20880.8 21220.7 21733.0 21922.8 20750.3 21092.4 21994.2 22288.9 22377.8 5937.0 6185.9 6214.2 6218.6 6219.6 5036.5 6100.7 6111.8 6183.0 6194.0 5130.4 6093.2 6104.7 6118.2 6131.6 5964.1 6551.0 6614.3 6634.2 6640.6 5632.4 5865.3 5886.2 5891.3 5901.7 13654.3 13971.7 14145.0 14245.0 14256.4 2036.4 2061.0 2063.4 2069.2 2312.8 9609.5 10058.0 10191.0 10446.4 10485.2 1726.7 1759.7 1893.0 1902.9 2039.8 120436.0 125659.0 126366.0 127131.0 127455.0 10591.1 11073.9 11876.8 11906.4 11910.0 15386.2 15468.8 15480.0 15503.1 15503.4 8822.6 8893.1 8903.1 8923.0 9043.7 8772.7 8780.8 8793.1 8921.6 8937.5 4742.8 4751.6 4753.7 4754.8 4810.7 1960.5 1993.3 1993.4 1997.6 2009.5 783.4 876.9 908.6 912.4 924.2 17992.8 20435.9 21495.0 21517.4 21654.0 785.3 811.3 898.9 932.8 1062.2 8803.6 11162.4 11375.5 11389.8 11404.4 595719.0 602508.0 610778.0 621283.0 621879.0 120279.4 143151.0 143210.3 143311.0 144963.0 982.4 992.2 1065.8 1068.4 1071.1 16905.8 19342.8 19667.7 19695.4 19708.5 41439.8 52082.4 53989.0 55338.7 57506.7 83459.0 86241.6 86963.6 88674.0 90972.0 8234.6 8246.3 8331.8 8412.9 8498.9 7440.2 11321.6 11587.6 12749.9 13431.4 10981.2 11172.8 11246.5 11299.6 11467.9 7413.1 10974.2 11110.0 11246.3 11401.1 11123.2 11614.5 11633.2 11810.4 11984.0 7125.8 8231.4 8313.5 8562.7 8774.0 9667.0 11348.0 11681.7 11739.1 11798.4 03:03:03 INFO - PROCESS | 1677 | 03:03:03 INFO - PROCESS | 1677 | [#3] mootools.html Cycles:180 Average:5790.74 Median:4813.52 stddev:3289.79 (68.3%) stddev-sans-first:3282.35 03:03:03 INFO - PROCESS | 1677 | Values: 1383.8 1579.3 1627.3 1831.5 1953.6 7802.8 8839.4 9054.4 9057.8 9211.0 8832.9 9063.2 9063.6 9086.4 9107.0 1987.9 2451.4 2455.2 2457.1 2457.5 2413.4 2452.2 2461.9 2465.1 2466.1 2416.4 2432.2 2452.2 2454.8 2455.3 2392.4 2429.5 2434.3 2438.1 2444.4 2397.3 2417.9 2426.6 2429.1 2430.2 8871.4 8948.0 9029.6 9049.1 9060.4 5339.3 5594.9 5599.5 5601.9 5602.8 3507.4 3608.9 3689.3 3704.6 3706.3 1047.7 1049.4 1051.8 1052.8 1054.0 11854.3 11964.4 11979.0 11988.9 12014.2 4674.0 4677.3 4802.6 4824.4 4840.0 9441.8 9442.1 9453.0 9477.3 9477.7 5387.5 5398.2 5400.2 5407.2 5409.2 4151.4 4540.8 4669.8 4930.0 4984.6 3897.8 3914.2 3944.6 3978.9 4015.6 1202.9 1211.1 1219.5 1223.8 1242.8 661.7 791.7 816.7 905.9 921.4 5649.7 5659.9 6101.8 6109.9 6155.6 425.2 443.5 449.1 468.3 475.7 3935.3 4000.3 4032.0 4045.2 4049.5 10419.5 11032.6 11112.1 11129.1 11136.7 10798.0 10952.7 11021.3 11039.6 11076.0 8267.3 8441.3 8482.6 8490.8 8492.6 5304.5 5743.7 5786.7 5853.7 5916.7 10221.4 10308.1 10373.0 10424.1 10440.7 9733.1 10107.6 10271.0 10291.3 10499.6 7113.9 7362.0 7580.4 7764.2 7778.8 7707.7 8422.7 8625.2 8744.0 8762.7 7660.2 7669.0 7693.0 7787.6 7824.6 7492.3 7497.7 7521.0 7629.2 7737.8 6938.9 7164.1 7256.5 7259.7 7268.2 4828.6 4940.4 5023.1 5028.6 5030.9 4442.3 5001.8 5046.0 5066.2 5175.2 03:03:03 INFO - PROCESS | 1677 | 03:03:03 INFO - PROCESS | 1677 | [#4] prototype.html Cycles:180 Average:4324.50 Median:4786.39 stddev:1328.02 (27.7%) stddev-sans-first:1297.08 03:03:03 INFO - PROCESS | 1677 | Values: 307.9 315.1 319.3 323.0 328.4 4442.6 4673.9 5074.8 5167.7 5210.8 4658.6 5049.2 5120.5 5186.6 5195.4 3602.4 3794.7 3814.7 3967.0 3979.6 3736.9 3848.2 3909.0 3971.0 3986.9 3280.8 3291.1 3931.8 3969.9 3981.9 3681.9 3702.0 3827.0 3937.1 3947.6 2795.8 2876.3 2876.8 3431.5 3437.3 4173.9 4868.6 4927.0 4929.9 4945.4 3971.5 4340.6 4487.1 4532.4 4565.3 4694.6 5329.9 5336.0 5347.1 5349.3 3384.2 3556.0 3702.7 3854.4 3867.3 4482.1 5683.5 5688.4 5698.7 5707.9 3453.6 3763.1 3767.9 3782.3 3784.0 3834.7 3846.8 3853.9 3854.6 3872.9 4416.9 4442.0 4458.3 4462.6 4470.2 4316.0 4354.4 4608.2 5315.4 5357.9 1177.5 1258.3 1277.8 1308.1 1308.2 727.4 766.7 776.7 798.7 813.0 4576.6 4786.6 4924.0 4965.7 4966.2 4757.4 5108.5 5512.7 5598.0 5603.6 4099.3 4402.5 4891.3 5058.7 5072.5 2833.0 2852.4 2930.9 2938.7 2943.7 4530.0 5564.0 5783.3 5802.4 5835.0 5425.2 5575.7 5700.4 5732.7 5807.8 4832.8 4847.0 5679.7 5697.2 5759.3 4733.5 5524.0 5556.6 5557.9 5596.6 5096.2 5100.9 5114.7 5424.4 5495.6 5691.8 5712.8 5732.4 5765.3 5779.4 3537.1 3635.0 3746.7 3757.8 3794.1 4942.3 5013.9 5115.0 5503.8 5515.3 4147.7 4641.0 5359.5 5366.4 5398.0 4922.6 5356.9 5379.0 5411.3 5427.3 4237.3 5225.5 5280.9 5282.6 5298.5 4786.1 4876.8 5050.9 5299.9 5343.3 4429.8 4435.0 4852.5 4890.6 5267.9 03:03:03 INFO - PROCESS | 1677 | 03:03:03 INFO - PROCESS | 1677 | [#5] yui.html Cycles:180 Average:18002.00 Median:30000.12 stddev:24970.02 (83.2%) stddev-sans-first:25005.88 03:03:03 INFO - PROCESS | 1677 | Values: 602.4 666.7 678.0 705.6 804.4 15223.2 15854.2 15865.5 15878.4 16884.1 15670.9 16024.7 16026.1 16031.5 16067.8 755.6 779.1 928.2 947.6 949.1 766.2 766.8 768.8 916.8 950.2 980.4 983.8 986.7 987.9 992.2 840.8 983.6 986.0 987.0 987.9 581.3 597.8 598.1 600.9 728.7 14977.3 15432.0 15453.5 15640.8 15642.8 12387.8 12425.8 12497.9 12684.7 12815.6 9919.6 9939.4 10010.0 10347.1 10533.9 3383.7 3458.9 3513.5 3535.6 3724.8 83130.6 87519.1 88199.0 88520.7 88812.6 9311.3 9481.8 9629.8 10023.8 10039.8 21429.4 21658.5 21674.7 21694.8 21718.8 7506.2 7610.9 7618.8 7704.5 7722.5 3551.3 4048.0 4116.8 4167.8 4308.2 3631.6 3733.8 3734.8 3743.7 3744.0 672.1 680.3 683.4 685.9 688.0 489.2 566.0 577.3 615.4 616.2 6826.8 7260.7 7903.2 7951.6 8039.9 534.1 564.6 576.6 591.5 600.7 3436.6 3845.7 3898.6 3923.1 3939.0 70728.6 86982.6 87727.1 87858.6 89748.1 60809.0 65084.0 83082.2 84212.6 85213.0 52403.9 67201.0 70449.6 71555.0 72457.0 6800.2 8263.3 8368.8 8559.9 8604.2 43905.8 44105.7 44369.0 45149.8 45508.8 59402.4 64358.4 65376.0 65435.0 66074.0 11019.7 11101.7 11104.7 11131.1 11646.5 11953.2 11989.5 12002.5 12629.2 13436.7 11643.1 11815.9 12099.3 12099.4 12221.0 10985.8 11580.2 11580.5 11647.4 11779.2 11432.3 11490.6 11530.9 11617.1 11937.9 9611.1 9739.5 9780.4 9941.2 10263.1 9590.6 9821.6 9840.8 9926.0 9964.5 03:03:03 INFO - PROCESS | 1677 | -------- Summary: end -------- 03:03:03 INFO - PROCESS | 1677 | 03:03:04 INFO - TEST-INFO | 1677: exit 0 03:03:04 INFO - TEST-OK | dromaeo_css | took 1115443ms 03:03:04 INFO - TEST-START | kraken 03:03:04 INFO - operating with platform_type : mac_ 03:03:04 INFO - Initialising browser for kraken test... 03:03:04 INFO - TEST-INFO | started process 1683 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/tmpiFHCK0/profile http://localhost:49278/getInfo.html) 03:03:06 INFO - PROCESS | 1683 | __metrics Screen width/height:1600/1200 03:03:06 INFO - PROCESS | 1683 | colorDepth:24 03:03:06 INFO - PROCESS | 1683 | Browser inner width/height: 1024/689 03:03:06 INFO - PROCESS | 1683 | __metrics 03:03:06 INFO - PROCESS | 1683 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 03:03:06 ERROR - PROCESS | 1683 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 03:03:07 INFO - TEST-INFO | 1683: exit 0 03:03:07 INFO - Browser initialized. 03:03:07 INFO - Running cycle 1/1 for kraken test... 03:03:07 INFO - TEST-INFO | started process 1685 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/tmpiFHCK0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:03:19 INFO - PROCESS | 1685 | RSS: Main: 239210496 03:03:19 INFO - PROCESS | 1685 | 03:03:22 INFO - PROCESS | 1685 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49278/tests/kraken/driver.html?testName=audio-beat-detection) 03:03:22 INFO - PROCESS | 1685 | RSS: Main: 287928320 03:03:22 INFO - PROCESS | 1685 | 03:03:25 INFO - PROCESS | 1685 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49278/tests/kraken/driver.html?testName=audio-dft) 03:03:26 INFO - PROCESS | 1685 | RSS: Main: 296292352 03:03:26 INFO - PROCESS | 1685 | 03:03:29 INFO - PROCESS | 1685 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49278/tests/kraken/driver.html?testName=audio-fft) 03:03:30 INFO - PROCESS | 1685 | RSS: Main: 387919872 03:03:30 INFO - PROCESS | 1685 | 03:03:32 INFO - PROCESS | 1685 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49278/tests/kraken/driver.html?testName=audio-oscillator) 03:03:33 INFO - PROCESS | 1685 | RSS: Main: 285057024 03:03:33 INFO - PROCESS | 1685 | 03:03:35 INFO - PROCESS | 1685 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49278/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:03:36 INFO - PROCESS | 1685 | RSS: Main: 290131968 03:03:36 INFO - PROCESS | 1685 | 03:03:39 INFO - PROCESS | 1685 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49278/tests/kraken/driver.html?testName=imaging-darkroom) 03:03:39 INFO - PROCESS | 1685 | RSS: Main: 327610368 03:03:39 INFO - PROCESS | 1685 | 03:03:42 INFO - PROCESS | 1685 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49278/tests/kraken/driver.html?testName=imaging-desaturate) 03:03:43 INFO - PROCESS | 1685 | RSS: Main: 328847360 03:03:43 INFO - PROCESS | 1685 | 03:03:46 INFO - PROCESS | 1685 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49278/tests/kraken/driver.html?testName=json-parse-financial) 03:03:47 INFO - PROCESS | 1685 | RSS: Main: 326696960 03:03:47 INFO - PROCESS | 1685 | 03:03:48 INFO - PROCESS | 1685 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49278/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:03:49 INFO - PROCESS | 1685 | RSS: Main: 316567552 03:03:49 INFO - PROCESS | 1685 | 03:03:51 INFO - PROCESS | 1685 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:03:51 INFO - PROCESS | 1685 | RSS: Main: 324407296 03:03:51 INFO - PROCESS | 1685 | 03:03:54 INFO - PROCESS | 1685 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:03:54 INFO - PROCESS | 1685 | RSS: Main: 325488640 03:03:54 INFO - PROCESS | 1685 | 03:03:57 INFO - PROCESS | 1685 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:03:58 INFO - PROCESS | 1685 | RSS: Main: 329777152 03:03:58 INFO - PROCESS | 1685 | 03:04:01 INFO - PROCESS | 1685 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:04:02 INFO - PROCESS | 1685 | RSS: Main: 327495680 03:04:02 INFO - PROCESS | 1685 | 03:04:03 INFO - PROCESS | 1685 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49278/tests/kraken/driver.html?testName=ai-astar) 03:04:04 INFO - PROCESS | 1685 | RSS: Main: 374198272 03:04:04 INFO - PROCESS | 1685 | 03:04:04 INFO - PROCESS | 1685 | __start_tp_report 03:04:04 INFO - PROCESS | 1685 | _x_x_mozilla_page_load 03:04:04 INFO - PROCESS | 1685 | _x_x_mozilla_page_load_details 03:04:04 INFO - PROCESS | 1685 | |i|pagename|runs| 03:04:04 INFO - PROCESS | 1685 | |0;ai-astar;122;159;153;111;112;111;111;112;110;112 03:04:04 INFO - PROCESS | 1685 | |1;audio-beat-detection;159;110;139;192;101;146;161;142;180;117 03:04:04 INFO - PROCESS | 1685 | |2;audio-dft;185;184;185;181;184;183;182;179;183;184 03:04:04 INFO - PROCESS | 1685 | |3;audio-fft;76;77;58;124;57;61;57;58;113;55 03:04:04 INFO - PROCESS | 1685 | |4;audio-oscillator;93;101;133;81;82;77;102;80;83;103 03:04:04 INFO - PROCESS | 1685 | |5;imaging-gaussian-blur;87;85;87;85;130;84;88;84;89;85 03:04:04 INFO - PROCESS | 1685 | |6;imaging-darkroom;94;93;93;94;93;92;93;93;92;93 03:04:04 INFO - PROCESS | 1685 | |7;imaging-desaturate;94;83;85;86;83;85;84;86;87;86 03:04:04 INFO - PROCESS | 1685 | |8;json-parse-financial;53;57;58;55;55;55;57;119;57;54 03:04:04 INFO - PROCESS | 1685 | |9;json-stringify-tinderbox;62;72;65;77;72;70;68;67;68;67 03:04:04 INFO - PROCESS | 1685 | |10;stanford-crypto-aes;86;85;86;85;84;84;85;84;84;86 03:04:04 INFO - PROCESS | 1685 | |11;stanford-crypto-ccm;141;136;136;136;137;136;132;137;231;152 03:04:04 INFO - PROCESS | 1685 | |12;stanford-crypto-pbkdf2;161;166;173;226;166;162;161;162;163;162 03:04:04 INFO - PROCESS | 1685 | |13;stanford-crypto-sha256-iterative;65;66;67;66;67;64;65;64;66;65 03:04:04 INFO - PROCESS | 1685 | __end_tp_report 03:04:04 INFO - PROCESS | 1685 | __start_cc_report 03:04:04 INFO - PROCESS | 1685 | _x_x_mozilla_cycle_collect,2285 03:04:04 INFO - PROCESS | 1685 | __end_cc_report 03:04:04 INFO - PROCESS | 1685 | __startTimestamp1463393044041__endTimestamp 03:04:04 INFO - PROCESS | 1685 | 03:04:04 INFO - PROCESS | 1685 | ------- Summary: start ------- 03:04:04 INFO - PROCESS | 1685 | Number of tests: 14 03:04:04 INFO - PROCESS | 1685 | 03:04:04 INFO - PROCESS | 1685 | [#0] ai-astar Cycles:10 Average:121.30 Median:112.00 stddev:18.66 (16.7%) stddev-sans-first:19.78 03:04:04 INFO - PROCESS | 1685 | Values: 122.0 159.0 153.0 111.0 112.0 111.0 111.0 112.0 110.0 112.0 03:04:04 INFO - PROCESS | 1685 | 03:04:04 INFO - PROCESS | 1685 | [#1] audio-beat-detection Cycles:10 Average:144.70 Median:152.50 stddev:29.58 (19.4%) stddev-sans-first:30.92 03:04:04 INFO - PROCESS | 1685 | Values: 159.0 110.0 139.0 192.0 101.0 146.0 161.0 142.0 180.0 117.0 03:04:04 INFO - PROCESS | 1685 | 03:04:04 INFO - PROCESS | 1685 | [#2] audio-dft Cycles:10 Average:183.00 Median:184.00 stddev:1.89 (1.0%) stddev-sans-first:1.86 03:04:04 INFO - PROCESS | 1685 | Values: 185.0 184.0 185.0 181.0 184.0 183.0 182.0 179.0 183.0 184.0 03:04:04 INFO - PROCESS | 1685 | 03:04:04 INFO - PROCESS | 1685 | [#3] audio-fft Cycles:10 Average:73.60 Median:58.00 stddev:25.06 (43.2%) stddev-sans-first:26.57 03:04:04 INFO - PROCESS | 1685 | Values: 76.0 77.0 58.0 124.0 57.0 61.0 57.0 58.0 113.0 55.0 03:04:04 INFO - PROCESS | 1685 | 03:04:04 INFO - PROCESS | 1685 | [#4] audio-oscillator Cycles:10 Average:93.50 Median:80.50 stddev:17.10 (21.2%) stddev-sans-first:18.14 03:04:04 INFO - PROCESS | 1685 | Values: 93.0 101.0 133.0 81.0 82.0 77.0 102.0 80.0 83.0 103.0 03:04:04 INFO - PROCESS | 1685 | 03:04:04 INFO - PROCESS | 1685 | [#5] imaging-gaussian-blur Cycles:10 Average:90.40 Median:86.00 stddev:14.02 (16.3%) stddev-sans-first:14.81 03:04:04 INFO - PROCESS | 1685 | Values: 87.0 85.0 87.0 85.0 130.0 84.0 88.0 84.0 89.0 85.0 03:04:04 INFO - PROCESS | 1685 | 03:04:04 INFO - PROCESS | 1685 | [#6] imaging-darkroom Cycles:10 Average:93.00 Median:93.00 stddev:0.67 (0.7%) stddev-sans-first:0.60 03:04:04 INFO - PROCESS | 1685 | Values: 94.0 93.0 93.0 94.0 93.0 92.0 93.0 93.0 92.0 93.0 03:04:04 INFO - PROCESS | 1685 | 03:04:04 INFO - PROCESS | 1685 | [#7] imaging-desaturate Cycles:10 Average:85.90 Median:86.00 stddev:3.14 (3.7%) stddev-sans-first:1.41 03:04:04 INFO - PROCESS | 1685 | Values: 94.0 83.0 85.0 86.0 83.0 85.0 84.0 86.0 87.0 86.0 03:04:04 INFO - PROCESS | 1685 | 03:04:04 INFO - PROCESS | 1685 | [#8] json-parse-financial Cycles:10 Average:62.00 Median:56.00 stddev:20.09 (35.9%) stddev-sans-first:21.04 03:04:04 INFO - PROCESS | 1685 | Values: 53.0 57.0 58.0 55.0 55.0 55.0 57.0 119.0 57.0 54.0 03:04:04 INFO - PROCESS | 1685 | 03:04:04 INFO - PROCESS | 1685 | [#9] json-stringify-tinderbox Cycles:10 Average:68.80 Median:69.00 stddev:4.18 (6.1%) stddev-sans-first:3.64 03:04:04 INFO - PROCESS | 1685 | Values: 62.0 72.0 65.0 77.0 72.0 70.0 68.0 67.0 68.0 67.0 03:04:04 INFO - PROCESS | 1685 | 03:04:04 INFO - PROCESS | 1685 | [#10] stanford-crypto-aes Cycles:10 Average:84.90 Median:85.00 stddev:0.88 (1.0%) stddev-sans-first:0.83 03:04:04 INFO - PROCESS | 1685 | Values: 86.0 85.0 86.0 85.0 84.0 84.0 85.0 84.0 84.0 86.0 03:04:04 INFO - PROCESS | 1685 | 03:04:04 INFO - PROCESS | 1685 | [#11] stanford-crypto-ccm Cycles:10 Average:147.40 Median:137.00 stddev:29.86 (21.8%) stddev-sans-first:31.58 03:04:04 INFO - PROCESS | 1685 | Values: 141.0 136.0 136.0 136.0 137.0 136.0 132.0 137.0 231.0 152.0 03:04:04 INFO - PROCESS | 1685 | 03:04:04 INFO - PROCESS | 1685 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.20 Median:164.50 stddev:19.94 (12.1%) stddev-sans-first:20.87 03:04:04 INFO - PROCESS | 1685 | Values: 161.0 166.0 173.0 226.0 166.0 162.0 161.0 162.0 163.0 162.0 03:04:04 INFO - PROCESS | 1685 | 03:04:04 INFO - PROCESS | 1685 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.50 Median:66.00 stddev:1.08 (1.6%) stddev-sans-first:1.13 03:04:04 INFO - PROCESS | 1685 | Values: 65.0 66.0 67.0 66.0 67.0 64.0 65.0 64.0 66.0 65.0 03:04:04 INFO - PROCESS | 1685 | -------- Summary: end -------- 03:04:04 INFO - PROCESS | 1685 | 03:04:04 INFO - TEST-INFO | 1685: exit 0 03:04:04 INFO - TEST-OK | kraken | took 60688ms 03:04:04 INFO - SUITE-END | took 1176s 03:04:05 INFO - Completed test suite (00:19:36) 03:04:05 INFO - javascript benchmark 03:04:05 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3409.573803274591, 3434.8626054957804, 3455.7062649674767, 3461.0655123116744, 3500.2824420993697, 5604.0, 5606.35526914405, 5624.550035997121, 5676.489115979561, 5702.087665973445, 5633.80281690141, 5656.264685590878, 5663.0, 5715.828525144242, 5749.396313387097, 5041.092603331399, 5098.872528186806, 5140.794368225266, 5150.716710580917, 5229.790808367661, 5238.711870847102, 5241.161414173733, 5263.31576895005, 5275.103232450492, 5301.628885977983, 5105.387353517564, 5130.53825155734, 5143.5113664201845, 5148.021875843578, 5182.144946083891, 5007.273945277914, 5098.490150984909, 5113.233015047773, 5139.049275883974, 5154.355705536808, 5077.720725360104, 5096.413912400048, 5106.540411362995, 5183.222516622499, 5210.895782084375, 4658.742139622283, 5502.9174562381595, 5616.410276920906, 5618.988582055228, 5651.576131790132, 6083.11794789753, 6139.0, 6171.845703857394, 6176.0, 6231.750729970796, 6246.437820596168, 6296.590721603081, 6313.210848643919, 6330.3669633036325, 6330.3669633036325, 5536.529395001389, 5773.220615216934, 5780.3063632363965, 5823.79616713413, 5828.067509198508, 6290.308066112724, 6347.365263473615, 6351.71417286214, 6364.236291644939, 6421.101045853584, 6090.204250113173, 6106.603070800384, 6107.227966617123, 6112.017184454359, 6130.63216207029, 6112.0, 6218.5647004710145, 6259.436650701458, 6267.529935254783, 6286.874262514724, 6040.124181993587, 6119.106526814625, 6122.245686735438, 6123.160610921289, 6131.172291740647, 6131.988406491236, 6136.21274067861, 6170.197874276315, 6173.660448675366, 6259.186305780219, 4869.074875773592, 4874.341963834837, 4883.1562520254765, 4896.510348965075, 4922.360093187863, 4346.695731298779, 4392.407025051577, 4395.978020109943, 4431.003024319502, 4463.509014008457, 5586.525145362609, 5648.74580643872, 5683.8863222736145, 5704.001799685038, 5719.857003574861, 6300.27546832111, 6311.021791622214, 6322.462590679844, 6327.050942358591, 6364.363563643691, 5602.747876345574, 5670.603057785916, 5728.083506639001, 5743.4543718346695, 5795.0, 5263.605229607795, 5315.73421328932, 5340.652857564246, 5344.706041167773, 5365.08793505105, 6325.841853953596, 6329.873402531832, 6350.555461117862, 6352.333005034589, 6373.71318290678, 6098.704546243851, 6106.642687876592, 6271.717772700148, 6283.151774510383, 6294.0, 6280.340564240689, 6389.36106389376, 6398.936010639834, 6400.263969643364, 6406.807795766134, 6053.545984051302, 6055.7577696893395, 6067.817965461043, 6069.51443884497, 6073.483753880793, 6135.171422439309, 6142.170806941006, 6145.494353883327, 6194.132821405097, 6208.968955155376, 6052.0, 6087.726052327745, 6097.847553811191, 6098.969505152623, 6131.877362452637, 6009.36901625323, 6071.39286071407, 6079.088136779518, 6082.9695851520455, 6092.421219984094, 5768.50967667753, 5846.853828654318, 5914.881702366015, 5922.851928701817, 5927.792527261525, 5067.645264831426, 5763.221965034667, 5956.285245770535, 6101.816945491642, 6112.005117492307, 5900.822975310747, 5913.763449462145, 5924.140999555127, 5928.762849485972, 5932.288125424977], "value": 5668.095804762935, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [520.1573451009363, 531.893621275745, 540.4784383070337, 549.3325609384598, 562.9746661400237, 31896.521552176706, 42363.576364236345, 47038.529614703846, 47076.293855592194, 47257.763711181484, 36552.26895462089, 38282.425763613566, 45525.54474455254, 45556.0, 45654.77172614141, 8558.529280889548, 9808.607655693782, 10011.549480273405, 10014.699559013241, 10018.0, 9727.659531916384, 9775.75560610987, 9775.951120244388, 9779.0, 9782.657606983757, 9777.31558790885, 9809.705708828747, 9814.362066465692, 9821.2634052446, 9824.0, 9728.610855565768, 9783.804323913482, 9788.510574471247, 9792.608295668164, 9820.116189542903, 9636.518174091267, 9698.224142068688, 9710.805783884354, 9719.319647624669, 9720.416774993522, 43158.0, 43358.0, 43433.0, 43695.344569831475, 43749.78125109354, 3214.5017522284083, 3226.0966929259844, 3241.0, 3242.3515296940705, 3395.303962687643, 29873.551896721565, 29887.0, 29997.70002299971, 30025.399492010256, 30450.54324185139, 2715.891364345424, 2725.795565332588, 2774.4728501584837, 2790.8046436749437, 2797.1608517444683, 528779.0, 529088.0, 530936.0, 531262.0, 531626.0, 65985.0, 66489.33510664928, 66516.0, 66617.00372472084, 66678.0, 37569.62430375716, 39229.80385098056, 39364.40953385702, 39371.40942885859, 66849.99725004128, 17476.0, 17499.212535435938, 17658.205380757896, 17679.292828286983, 17685.292588296583, 13278.402471888789, 13390.799138012937, 13400.865991339962, 13411.463541458428, 13413.597592072254, 20675.6223034353, 20839.8958005209, 20870.495540535234, 20933.685994710093, 20980.580388392147, 7056.54132481387, 8254.380921430917, 8352.582370881431, 8355.248027677539, 8494.70268540598, 844.9788755281044, 923.215267023025, 1010.3129871687323, 1015.9238057145743, 1040.193849766437, 28399.43201135966, 28739.56890646642, 29992.85003574968, 30062.849685751433, 30790.38419231603, 973.3284034016506, 1014.453987973169, 1061.7027232374946, 1072.7908057928785, 1231.605886116452, 13605.0, 15713.135777532345, 15733.685326293638, 16169.514914552583, 16273.674526509403, 723719.0, 729280.0, 733944.0, 735531.0, 737447.0, 64060.0, 64624.35375646183, 64693.353066469674, 64720.20437854052, 64770.0, 1364.6179069860455, 1403.5087719298165, 1479.8890083243584, 1508.781226722119, 1528.0373364780116, 30315.393692126476, 31253.0, 31299.530507041956, 31910.840445798553, 32111.0, 54813.725931370085, 54922.0, 55499.89000220054, 55579.44420555905, 55651.49568269519, 559623.0, 564978.0, 565516.0, 565600.0, 567795.0, 24218.0, 27239.910403583635, 27977.580336294566, 28071.157865264075, 28237.43525129445, 48411.75794121007, 49115.508844912525, 49266.50733492763, 49487.50512494973, 50155.0, 37004.074898127765, 38780.41829372505, 38787.0, 39568.0, 39767.2046559073, 38231.426528601536, 38396.0, 39034.02414939649, 39880.60119398885, 40093.79953100216, 38634.03414914649, 38706.61293387143, 39150.6084939147, 39582.80208598939, 39612.0, 32343.838280808446, 33836.0, 34409.403812221775, 34694.65305346914, 35228.0, 24075.0, 25191.748082519673, 25572.10497632574, 25743.356416089748, 25938.48123037491], "value": 20402.831122463183, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [398.9567281558724, 401.23965086161724, 401.33378591538053, 405.9411385349123, 421.5342047038023, 20772.480687982807, 20880.791192088076, 21220.681689774665, 21733.0, 21922.780772192295, 20750.27374041909, 21092.367228983116, 21994.230201942933, 22288.888555557198, 22377.77622223777, 5936.970315148418, 6185.938140618604, 6214.192155019841, 6218.626882387049, 6219.626822390648, 5036.546710796028, 6100.72546735398, 6111.755529778803, 6183.0, 6194.039923811816, 5130.410002849682, 6093.238345206849, 6104.725287362057, 6118.204633397652, 6131.601445906024, 5964.105384192384, 6550.967245163767, 6614.305497922697, 6634.170728658918, 6640.634765087894, 5632.394767491286, 5865.266841644794, 5886.175935369051, 5891.322497912752, 5901.675407852566, 13654.317284135854, 13971.65070873226, 14145.0, 14245.0, 14256.429742810378, 2036.4140114783327, 2060.9690854637192, 2063.401613532089, 2069.2033567076633, 2312.7802858728396, 9609.471479068648, 10057.994200579957, 10191.03185197405, 10446.425446600433, 10485.161187105014, 1726.7409888516697, 1759.692053890564, 1893.0, 1902.9137748383732, 2039.8470114741453, 120436.0, 125659.0, 126366.0, 127130.99999999907, 127455.0, 10591.099756520627, 11073.889261107446, 11876.76246475083, 11906.404679765978, 11910.0, 15386.153761542999, 15468.839837012045, 15480.0, 15503.147326896904, 15503.379864805507, 8822.558872056372, 8893.066228045962, 8903.109689031175, 8922.955385223033, 9043.728688139236, 8772.736817895346, 8780.824383512421, 8793.120687931156, 8921.643134274686, 8937.46375217489, 4742.786574604151, 4751.59611433032, 4753.691010084333, 4754.833580824724, 4810.735409552438, 1960.4902725291527, 1993.2824183294003, 1993.3920154353061, 1997.6204521140937, 2009.4875806669497, 783.3615603283306, 876.9429987050821, 908.5502676175336, 912.397817440486, 924.1636319131197, 17992.820071799375, 20435.87602681837, 21495.0, 21517.354479365644, 21654.02556884944, 785.3246208260891, 811.2820154163489, 898.874157617934, 932.846080396727, 1062.2298833345762, 8803.603837827313, 11162.441877906072, 11375.488103035383, 11389.829152562717, 11404.372759498141, 595719.0, 602508.0, 610778.0, 621283.0, 621879.0, 120279.39860300643, 143151.0, 143210.28394858167, 143311.0, 144963.0, 982.3958265666564, 992.2310209587628, 1065.7815147894662, 1068.407034096084, 1071.0735214039798, 16905.830941690918, 19342.8065719341, 19667.70498442496, 19695.409137725892, 19708.50728731793, 41439.7928010358, 52082.43752687425, 53989.0, 55338.72330638321, 57506.7124664374, 83459.0, 86241.56879215814, 86963.56518217368, 88674.0, 90972.0, 8234.588270586328, 8246.257836794717, 8331.750047498585, 8412.87380689278, 8498.872516912375, 7440.181580026301, 11321.603743868925, 11587.5944341951, 12749.87250127487, 13431.395587198404, 10981.176411768989, 11172.765446910487, 11246.493907774333, 11299.604513841976, 11467.942660286646, 7413.073365829271, 10974.176936729618, 11110.0, 11246.268992515461, 11401.087912967108, 11123.165762568002, 11614.477348519167, 11633.243839150427, 11810.409479525817, 11984.041276698017, 7125.82185445368, 8231.42380033392, 8313.501189928624, 8562.657493700182, 8773.990991035856, 9666.95166524163, 11348.0, 11681.707957301136, 11739.06087513014, 11798.351090689752], "value": 9599.25902356655, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1383.7647599908014, 1579.2972127403307, 1627.3409269245954, 1831.4963385069104, 1953.5995121000196, 7802.765917022484, 8839.381243312962, 9054.366194366397, 9057.818843623132, 9210.953945230282, 8832.895888013998, 9063.184313411792, 9063.592138353773, 9086.363954523185, 9107.0, 1987.860849740515, 2451.350392146083, 2455.177515532299, 2457.0908763757348, 2457.5207834472285, 2413.4449076712367, 2452.2152911068465, 2461.913833015845, 2465.149523414428, 2466.149178533412, 2416.4079800448912, 2432.2460037388378, 2452.227548322273, 2454.7790698837102, 2455.3370589940796, 2392.4018995251186, 2429.5019520998153, 2434.306222726523, 2438.0979037756056, 2444.352246654638, 2397.2927986243926, 2417.8549287042833, 2426.636004599324, 2429.0648100481444, 2430.2101816909576, 8871.37900346976, 8947.955260223658, 9029.638814447415, 9049.095090490964, 9060.411073280282, 5339.332583427072, 5594.916076258859, 5599.496045355938, 5601.915971260434, 5602.803901863456, 3507.421275489541, 3608.9097772555633, 3689.2805902848954, 3704.592494825567, 3706.313627299572, 1047.743302890789, 1049.438550375553, 1051.7633532455213, 1052.7999680060764, 1054.0250268501682, 11854.288742675468, 11964.40177991097, 11979.0, 11988.861058199544, 12014.219075760047, 4673.976630116827, 4677.298405239241, 4802.615790736732, 4824.421069471686, 4839.951600484021, 9441.811163776823, 9442.103000215106, 9453.0, 9477.28920330978, 9477.715668529956, 5387.542058925035, 5398.24424580559, 5400.21696853954, 5407.215953686693, 5409.188621706776, 4151.356539736345, 4540.84107056258, 4669.836555720602, 4930.038642464685, 4984.626153038536, 3897.824597893102, 3914.2171565686976, 3944.6252606002386, 3978.9403158952637, 4015.598440155961, 1202.9218100823593, 1211.121936595961, 1219.5365761010937, 1223.816427535859, 1242.7887259165964, 661.6890061671007, 791.7228969860503, 816.6814942172557, 905.8505346617734, 921.4425272710048, 5649.745761440745, 5659.886802264014, 6101.84745381369, 6109.908351374733, 6155.569110162335, 425.16455165599746, 443.5054913771122, 449.08386890743174, 468.2554737966581, 475.7145712572429, 3935.252302062599, 4000.3199456092534, 4032.03231224504, 4045.211183819127, 4049.4735684360844, 10419.531121099568, 11032.613858515075, 11112.11103111749, 11129.054030407506, 11136.665900023012, 10798.0, 10952.726181845517, 11021.283616564897, 11039.613613523488, 11076.003159715665, 8267.255946964802, 8441.282490988335, 8482.575871206538, 8490.830183396298, 8492.617832197566, 5304.549113325411, 5743.712814359349, 5786.681732504752, 5853.707314634336, 5916.733746981482, 10221.43782091992, 10308.072273495422, 10372.962703729869, 10424.113950314006, 10440.68677939663, 9733.124018838338, 10107.595696172071, 10271.0, 10291.279610427198, 10499.632512862014, 7113.928860711327, 7362.0, 7580.3556697681315, 7764.184760600281, 7778.805529861799, 7707.730229441942, 8422.747317580483, 8625.223729864343, 8744.0, 8762.693305734269, 7660.195679453577, 7668.96468976681, 7693.0, 7787.5716835574585, 7824.64789084504, 7492.325690687864, 7497.700091996478, 7520.962395188208, 7629.198934111839, 7737.806554836174, 6938.930610693828, 7164.104486939133, 7256.455765817479, 7259.673314700956, 7268.236835132235, 4828.61371090319, 4940.431850337113, 5023.120953832991, 5028.572571331478, 5030.949690503048, 4442.2892337225885, 5001.799928002984, 5045.974770126126, 5066.214736715815, 5175.249588809676], "value": 4550.824212613902, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [307.8599237347007, 315.1349545497608, 319.33418821756635, 322.95155726641013, 328.4023077998045, 4442.644588432926, 4673.948361618634, 5074.782052307447, 5167.715775632339, 5210.7655155518, 4658.580727734503, 5049.192129259319, 5120.4623514530995, 5186.585073194145, 5195.428502864682, 3602.3969333646605, 3794.6964242860504, 3814.7329686921926, 3966.9801650991703, 3979.6418322350983, 3736.8878933632036, 3848.2495913296916, 3908.9804550977346, 3971.0, 3986.900327491807, 3280.8025070849208, 3291.078498020558, 3931.8034098295116, 3969.8610548630804, 3981.86063487778, 3681.9263614727824, 3702.0, 3826.9617303826885, 3937.0511596759643, 3947.585503522146, 2795.7623601993855, 2876.2521744346623, 2876.8492602958777, 3431.519587257786, 3437.329720704464, 4173.914782156631, 4868.610511159099, 4926.989967056745, 4929.9154186079, 4945.406551213878, 3971.4908334832867, 4340.631046361063, 4487.080148569536, 4532.4334458192725, 4565.315202719586, 4694.647901407408, 5329.946700532983, 5335.973320133375, 5347.144456886918, 5349.331333583302, 3384.1539615096226, 3555.9687690569704, 3702.7037836972977, 3854.4411060396365, 3867.3425517662067, 4482.081173359518, 5683.46546432465, 5688.402717714622, 5698.715064246771, 5707.857303567403, 3453.6028356738793, 3763.121212272614, 3767.9434808477895, 3782.3002744492355, 3783.9621603783607, 3834.7123965702685, 3846.8461261549783, 3853.9421908671393, 3854.6316057799077, 3872.9225415491533, 4416.851618579192, 4442.044960333544, 4458.331250312479, 4462.576055274743, 4470.240059189946, 4316.0, 4354.433923589913, 4608.239640459286, 5315.3621565412395, 5357.946420535744, 1177.4986891712963, 1258.314218750783, 1277.8019406991932, 1308.1235572166481, 1308.2019967819622, 727.3708242370417, 766.7201471462876, 776.7397921696295, 798.7084714079319, 812.9959350203211, 4576.58810707038, 4786.64100192487, 4923.950760492421, 4965.652404331734, 4966.180580204298, 4757.381540399795, 5108.540231379194, 5512.724363781795, 5597.972010140004, 5603.579731520153, 4099.323611604052, 4402.481144005313, 4891.2581874865755, 5058.671186372874, 5072.492750724972, 2832.9716702832707, 2852.3867368515866, 2930.941381172365, 2938.735513803768, 2943.67619561848, 4529.9547004530195, 5563.972180139073, 5783.306003279549, 5802.448767367094, 5835.0, 5425.240466334716, 5575.689712917461, 5700.37295897451, 5732.742026608813, 5807.796727114531, 4832.830850920201, 4846.975765121152, 5679.687617181012, 5697.173909782975, 5759.308882933991, 4733.479317275028, 5524.0, 5556.610657417188, 5557.861053473695, 5596.580256480699, 5096.184610462308, 5100.897982040413, 5114.667546609458, 5424.403315635198, 5495.6153069284765, 5691.751758055628, 5712.828615141552, 5732.423583514566, 5765.336986246635, 5779.393163717749, 3537.080359106599, 3635.01854499289, 3746.7002639788207, 3757.793321367242, 3794.108384529578, 4942.3327850741125, 5013.871878827381, 5114.974425127851, 5503.807366742145, 5515.338159420895, 4147.668186545129, 4640.976795116003, 5359.490848369399, 5366.409694933633, 5398.0, 4922.606191504743, 5356.946430535645, 5378.955996721221, 5411.268394113846, 5427.267318912054, 4237.343211802176, 5225.47995983464, 5280.947190528199, 5282.600110970673, 5298.549623282064, 4786.138495070921, 4876.756162191948, 5050.868461553713, 5299.920501192562, 5343.305370301836, 4429.822807087809, 4435.046465010038, 4852.490488498657, 4890.6332025097545, 5267.946410717948], "value": 3905.0820253330544, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [602.3645054467538, 666.7033170239239, 678.0, 705.5696025424487, 804.3967024731452, 15223.162726050063, 15854.20728963553, 15865.524034278975, 15878.36486540537, 16884.07137607431, 15670.921645391785, 16024.679506409893, 16026.118563479033, 16031.519054428356, 16067.758983615255, 755.6033082631635, 779.1040303650818, 928.1507420710059, 947.5593848860278, 949.1362859797551, 766.2337662337662, 766.7853001159656, 768.8347005393839, 916.7937214126835, 950.1828427552299, 980.3529670417525, 983.7786498037956, 986.699056787683, 987.8616993620899, 992.1566668331932, 840.848647243496, 983.5672304186171, 985.9942858284581, 986.9654562090292, 987.9061489158519, 581.2617975171509, 597.8415719834247, 598.058058557769, 600.8948434024072, 728.6575309604477, 14977.326020329112, 15432.0, 15453.459128930434, 15640.843591564053, 15642.843571564366, 12387.75224495514, 12425.813612795815, 12497.93751031248, 12684.682882927907, 12815.551455699006, 9919.553620087114, 9939.353941993748, 10010.0, 10347.120494757955, 10533.947330263376, 3383.7462190335823, 3458.948115778265, 3513.49054387115, 3535.5757309122814, 3724.7951362675044, 83130.58434707849, 87519.12480875237, 88199.0, 88520.67218991656, 88812.5559372199, 9311.301652376098, 9481.810363792823, 9629.759256018515, 10023.849642255373, 10039.849402258971, 21429.357119286447, 21658.458538536663, 21674.674879876813, 21694.78305216959, 21718.78281217199, 7506.211847756016, 7610.885836712454, 7618.8095297618, 7704.460687751804, 7722.45942784011, 3551.271989242199, 4047.990198763882, 4116.826704389295, 4167.791610419466, 4308.246056940023, 3631.6005239423644, 3733.8133093345223, 3734.7572407793405, 3743.6630703236838, 3744.0, 672.0557616548757, 680.3298750730527, 683.3986092238798, 685.9382655561024, 687.9965600172068, 489.1537639883022, 565.9858503537362, 577.255340610616, 615.4030590327375, 616.1866336435861, 6826.829329266808, 7260.709571617182, 7903.220215605421, 7951.642176102089, 8039.919600803917, 534.1187041381673, 564.6358099026105, 576.5531712922435, 591.4558606082414, 600.6546235914367, 3436.570428696413, 3845.692344612424, 3898.5516665583255, 3923.058465968204, 3938.960610393917, 70728.64635676789, 86982.56508717415, 87727.1227287719, 87858.56070719734, 89748.10251897528, 60809.0, 65084.0, 83082.16917830866, 84212.57893710492, 85213.0, 52403.90384384658, 67201.0, 70449.64775176194, 71555.0, 72457.0, 6800.217974932748, 8263.338932885235, 8368.83262334762, 8559.887214662054, 8604.225619694258, 43905.78047109744, 44105.67682969516, 44369.0, 45149.77425112853, 45508.77245613751, 59402.405975939684, 64358.39104022437, 65376.0, 65435.0, 66074.0, 11019.724506887393, 11101.666949991513, 11104.722381940193, 11131.10951123892, 11646.534138634699, 11953.22304050234, 11989.520419183134, 12002.519899203933, 12629.179103358252, 13436.731265374834, 11643.074113045668, 11815.940920295343, 12099.296714681148, 12099.395030248628, 12221.0, 10985.83521247166, 11580.247283926517, 11580.478878450658, 11647.41762911868, 11779.234349767581, 11432.256903301592, 11490.597829075943, 11530.884691152982, 11617.0706343494, 11937.940310298392, 9611.086946740048, 9739.513024348897, 9780.364276322302, 9941.155001824636, 10263.12763415118, 9590.616375345187, 9821.607135714778, 9840.753981150528, 9925.950370248103, 9964.50177491137], "value": 6893.707848547577, "unit": "score"}], "name": "dromaeo_css", "value": 7171.301365351042, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [122.0, 159.0, 153.0, 111.0, 112.0, 111.0, 111.0, 112.0, 110.0, 112.0], "value": 121.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 110.0, 139.0, 192.0, 101.0, 146.0, 161.0, 142.0, 180.0, 117.0], "value": 144.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 184.0, 185.0, 181.0, 184.0, 183.0, 182.0, 179.0, 183.0, 184.0], "value": 183.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 58.0, 124.0, 57.0, 61.0, 57.0, 58.0, 113.0, 55.0], "value": 73.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 101.0, 133.0, 81.0, 82.0, 77.0, 102.0, 80.0, 83.0, 103.0], "value": 93.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 85.0, 87.0, 85.0, 130.0, 84.0, 88.0, 84.0, 89.0, 85.0], "value": 90.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 93.0, 93.0, 94.0, 93.0, 92.0, 93.0, 93.0, 92.0, 93.0], "value": 93.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 83.0, 85.0, 86.0, 83.0, 85.0, 84.0, 86.0, 87.0, 86.0], "value": 85.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 57.0, 58.0, 55.0, 55.0, 55.0, 57.0, 119.0, 57.0, 54.0], "value": 62.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 72.0, 65.0, 77.0, 72.0, 70.0, 68.0, 67.0, 68.0, 67.0], "value": 68.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 86.0, 85.0, 84.0, 84.0, 85.0, 84.0, 84.0, 86.0], "value": 84.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 136.0, 136.0, 136.0, 137.0, 136.0, 132.0, 137.0, 231.0, 152.0], "value": 147.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 166.0, 173.0, 226.0, 166.0, 162.0, 161.0, 162.0, 163.0, 162.0], "value": 170.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 67.0, 66.0, 67.0, 64.0, 65.0, 64.0, 66.0, 65.0], "value": 65.5, "unit": "score"}], "name": "kraken", "value": 1484.2, "alertThreshold": 2.0}]} 03:04:05 INFO - Return code: 0 03:04:05 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 03:04:05 ERROR - # TBPL SUCCESS # 03:04:05 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:04:05 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:04:05 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:04:05 INFO - 2016-05-16 03:04:05.355 screenresolution[1689:11340] starting screenresolution argv=screenresolution get 03:04:05 INFO - 2016-05-16 03:04:05.358 screenresolution[1689:11340] Display 0: 1600x1200x32@60 03:04:05 INFO - 2016-05-16 03:04:05.364 screenresolution[1690:11343] starting screenresolution argv=screenresolution list 03:04:05 INFO - Available Modes on Display 0 03:04:05 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:04:05 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:04:05 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:04:05 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:04:05 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:04:05 INFO - Intel Iris: 03:04:05 INFO - Chipset Model: Intel Iris 03:04:05 INFO - Type: GPU 03:04:05 INFO - Bus: Built-In 03:04:05 INFO - VRAM (Dynamic, Max): 1536 MB 03:04:05 INFO - Vendor: Intel (0x8086) 03:04:05 INFO - Device ID: 0x0a2e 03:04:05 INFO - Revision ID: 0x0009 03:04:05 INFO - Displays: 03:04:05 INFO - Display: 03:04:05 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:04:05 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:04:05 INFO - Display Serial Number: 1600x1200 60 03:04:05 INFO - Main Display: Yes 03:04:05 INFO - Mirror: Off 03:04:05 INFO - Online: Yes 03:04:05 INFO - Rotation: Supported 03:04:05 INFO - Return code: 0 03:04:05 INFO - Running post-action listener: _resource_record_post_action 03:04:05 INFO - ##### 03:04:05 INFO - ##### Finished run-tests step (success) 03:04:05 INFO - ##### 03:04:05 INFO - Running post-run listener: _resource_record_post_run 03:04:05 INFO - Total resource usage - Wall time: 1211s; CPU: 54.0%; Read bytes: 31292928; Write bytes: 694836224; Read time: 194; Write time: 1912 03:04:05 INFO - TinderboxPrint: CPU usage
53.6% 03:04:05 INFO - TinderboxPrint: I/O read bytes / time
31,292,928 / 194 03:04:05 INFO - TinderboxPrint: I/O write bytes / time
694,836,224 / 1,912 03:04:05 INFO - TinderboxPrint: CPU idle
2,248.6 (46.4%) 03:04:05 INFO - TinderboxPrint: CPU system
963.9 (19.9%) 03:04:05 INFO - TinderboxPrint: CPU user
1,633.1 (33.7%) 03:04:05 INFO - TinderboxPrint: Swap in / out
421,888,000 / 0 03:04:05 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 376283648; Write bytes: 371582976; Read time: 28474; Write time: 767 03:04:05 INFO - run-tests - Wall time: 1179s; CPU: 54.0%; Read bytes: 30371328; Write bytes: 296223744; Read time: 184; Write time: 1076 03:04:06 INFO - Running post-run listener: _upload_blobber_files 03:04:06 INFO - Blob upload gear active. 03:04:06 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:04: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 03:04: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'] 03:04: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 03:04:06 INFO - (blobuploader) - INFO - Open directory for files ... 03:04:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 03:04:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:04:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:04:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 03:04:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:04:07 INFO - (blobuploader) - INFO - Done attempting. 03:04:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 03:04:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:04:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:04:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 03:04:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:04:08 INFO - (blobuploader) - INFO - Done attempting. 03:04:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:04:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:04:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:04:11 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:04:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:04:11 INFO - (blobuploader) - INFO - Done attempting. 03:04:11 INFO - (blobuploader) - INFO - Iteration through files over. 03:04:11 INFO - Return code: 0 03:04:11 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:04:11 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:04:11 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4387f504469c54d7a72b9ae5889ff5a19877977253374394a056546ce2e2c39f3f935fbf6fe0ace945586426b2609eaed47014f06fa07903596805ed2310b6d6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e295b1255522602b54e9572ebe1584688983ccbb61b60e7a37374fc1d900dc25fdcc616346dfe6e19a36abaa114a945151e50823311ff6a57576218b71b5c587", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d4253a23bae3b85dd753a3a056b14ae9af1cde8af554088d8344b3adb3e8037d1fa36fe0c8a6aa5a49029d7a493ec0a1b23c94da394027fb77de0e925b5c4bf6"} 03:04:11 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:04:11 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:04:11 INFO - Contents: 03:04:11 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4387f504469c54d7a72b9ae5889ff5a19877977253374394a056546ce2e2c39f3f935fbf6fe0ace945586426b2609eaed47014f06fa07903596805ed2310b6d6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e295b1255522602b54e9572ebe1584688983ccbb61b60e7a37374fc1d900dc25fdcc616346dfe6e19a36abaa114a945151e50823311ff6a57576218b71b5c587", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d4253a23bae3b85dd753a3a056b14ae9af1cde8af554088d8344b3adb3e8037d1fa36fe0c8a6aa5a49029d7a493ec0a1b23c94da394027fb77de0e925b5c4bf6"} 03:04:11 INFO - Running post-run listener: copy_logs_to_upload_dir 03:04:11 INFO - Copying logs to upload dir... 03:04:11 INFO - mkdir: /builds/slave/test/build/upload/logs 03:04:11 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1317.153285 ========= master_lag: 0.06 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 57 secs) (at 2016-05-16 03:04:11.147012) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-16 03:04:11.151057) ========= 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.hLOcPl8xEw/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.nD2QFHjdc8/Listeners TMPDIR=/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4387f504469c54d7a72b9ae5889ff5a19877977253374394a056546ce2e2c39f3f935fbf6fe0ace945586426b2609eaed47014f06fa07903596805ed2310b6d6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e295b1255522602b54e9572ebe1584688983ccbb61b60e7a37374fc1d900dc25fdcc616346dfe6e19a36abaa114a945151e50823311ff6a57576218b71b5c587", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d4253a23bae3b85dd753a3a056b14ae9af1cde8af554088d8344b3adb3e8037d1fa36fe0c8a6aa5a49029d7a493ec0a1b23c94da394027fb77de0e925b5c4bf6"} 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.011473 build_url: 'https://queue.taskcluster.net/v1/task/RIdxSdjrQnq14tOfB86CoA/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4387f504469c54d7a72b9ae5889ff5a19877977253374394a056546ce2e2c39f3f935fbf6fe0ace945586426b2609eaed47014f06fa07903596805ed2310b6d6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e295b1255522602b54e9572ebe1584688983ccbb61b60e7a37374fc1d900dc25fdcc616346dfe6e19a36abaa114a945151e50823311ff6a57576218b71b5c587", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d4253a23bae3b85dd753a3a056b14ae9af1cde8af554088d8344b3adb3e8037d1fa36fe0c8a6aa5a49029d7a493ec0a1b23c94da394027fb77de0e925b5c4bf6"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-16 03:04:11.179671) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-16 03:04:11.179997) ========= 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.hLOcPl8xEw/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.nD2QFHjdc8/Listeners TMPDIR=/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/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.004989 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-16 03:04:11.229758) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-16 03:04:11.230295) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-16 03:04:11.230917) ========= ========= Total master_lag: 0.28 =========