builder: autoland_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0320 starttime: 1467978344.81 results: success (0) buildid: 20160708022325 builduid: da2c2839738144d3af7b5bc0e7d67491 revision: 0164fbe346839e2c77f82e4f587d66760a37bc26 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-08 04:45:44.807590) ========= master: http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-08 04:45:44.808303) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-08 04:45:44.808585) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-08 04:45:44.868884) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 04:45:44.869416) ========= 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.ARfqb1Dj0Z/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.eqpPbgH9V5/Listeners TMPDIR=/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/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-07-08 04:45:44-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 163M=0s 2016-07-08 04:45:45 (163 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.136585 ========= master_lag: 0.38 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 04:45:45.383214) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 04:45:45.383515) ========= 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.ARfqb1Dj0Z/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.eqpPbgH9V5/Listeners TMPDIR=/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/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.026136 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 04:45:45.449867) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-08 04:45:45.450185) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev 0164fbe346839e2c77f82e4f587d66760a37bc26 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/autoland --rev 0164fbe346839e2c77f82e4f587d66760a37bc26 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.ARfqb1Dj0Z/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.eqpPbgH9V5/Listeners TMPDIR=/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/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-07-08 04:45:45,534 truncating revision to first 12 chars 2016-07-08 04:45:45,534 Setting DEBUG logging. 2016-07-08 04:45:45,534 attempt 1/10 2016-07-08 04:45:45,534 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/0164fbe34683?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-08 04:45:46,169 unpacking tar archive at: autoland-0164fbe34683/testing/mozharness/ program finished with exit code 0 elapsedTime=1.005904 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-08 04:45:46.481891) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-08 04:45:46.482479) ========= script_repo_revision: 0164fbe346839e2c77f82e4f587d66760a37bc26 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-08 04:45:46.483007) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-08 04:45:46.483572) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-08 04:45:46.502135) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 19 secs) (at 2016-07-08 04:45:46.502624) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Autoland --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Autoland', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.ARfqb1Dj0Z/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.eqpPbgH9V5/Listeners TMPDIR=/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/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 04:45:46 INFO - MultiFileLogger online at 20160708 04:45:46 in /builds/slave/test 04:45:46 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Autoland --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland 04:45:46 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:45:46 INFO - {'append_to_log': False, 04:45:46 INFO - 'base_work_dir': '/builds/slave/test', 04:45:46 INFO - 'blob_upload_branch': 'Autoland', 04:45:46 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:45:46 INFO - 'branch': 'Autoland', 04:45:46 INFO - 'buildbot_json_path': 'buildprops.json', 04:45:46 INFO - 'config_files': ('talos/mac_config.py',), 04:45:46 INFO - 'default_actions': ('clobber', 04:45:46 INFO - 'read-buildbot-config', 04:45:46 INFO - 'download-and-extract', 04:45:46 INFO - 'populate-webroot', 04:45:46 INFO - 'create-virtualenv', 04:45:46 INFO - 'install', 04:45:46 INFO - 'run-tests'), 04:45:46 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:45:46 INFO - 'download_minidump_stackwalk': True, 04:45:46 INFO - 'download_symbols': 'ondemand', 04:45:46 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:45:46 INFO - 'tooltool.py': '/tools/tooltool.py', 04:45:46 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:45:46 INFO - '/tools/misc-python/virtualenv.py')}, 04:45:46 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:45:46 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:45:46 INFO - 'installer_path': 'installer.exe', 04:45:46 INFO - 'log_level': 'info', 04:45:46 INFO - 'log_name': 'talos', 04:45:46 INFO - 'log_to_console': True, 04:45:46 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 04:45:46 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 04:45:46 INFO - 'opt_config_files': (), 04:45:46 INFO - 'pip_index': False, 04:45:46 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:45:46 INFO - 'cmd': ('bash', 04:45:46 INFO - '-c', 04:45:46 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:45:46 INFO - 'enabled': True, 04:45:46 INFO - 'halt_on_failure': False, 04:45:46 INFO - 'name': 'check_screen_resolution'},), 04:45:46 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:45:46 INFO - 'cmd': ('bash', 04:45:46 INFO - '-c', 04:45:46 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:45:46 INFO - 'enabled': True, 04:45:46 INFO - 'halt_on_failure': False, 04:45:46 INFO - 'name': 'check_screen_resolution'},), 04:45:46 INFO - 'run_cmd_checks_enabled': True, 04:45:46 INFO - 'sps_profile': False, 04:45:46 INFO - 'sps_profile_interval': 0, 04:45:46 INFO - 'suite': 'dromaeojs-e10s', 04:45:46 INFO - 'system_bits': '32', 04:45:46 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:45:46 INFO - 'title': 't-yosemite-r7-0320', 04:45:46 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:45:46 INFO - 'use_talos_json': True, 04:45:46 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:45:46 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:45:46 INFO - 'work_dir': 'build'} 04:45:46 INFO - ##### 04:45:46 INFO - ##### Running clobber step. 04:45:46 INFO - ##### 04:45:46 INFO - Running pre-action listener: _resource_record_pre_action 04:45:46 INFO - Running main action method: clobber 04:45:46 INFO - rmtree: /builds/slave/test/build 04:45:46 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:45:48 INFO - Running post-action listener: _resource_record_post_action 04:45:48 INFO - ##### 04:45:48 INFO - ##### Finished clobber step (success) 04:45:48 INFO - ##### 04:45:48 INFO - ##### 04:45:48 INFO - ##### Running read-buildbot-config step. 04:45:48 INFO - ##### 04:45:48 INFO - Running pre-action listener: _resource_record_pre_action 04:45:48 INFO - Running main action method: read_buildbot_config 04:45:48 INFO - Using buildbot properties: 04:45:48 INFO - { 04:45:48 INFO - "project": "", 04:45:48 INFO - "product": "firefox", 04:45:48 INFO - "script_repo_revision": "production", 04:45:48 INFO - "builddir": "autoland_yosemite_r7_test-dromaeojs-e10s", 04:45:48 INFO - "repository": "", 04:45:48 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 autoland talos dromaeojs-e10s", 04:45:48 INFO - "buildid": "20160708022325", 04:45:48 INFO - "pgo_build": "False", 04:45:48 INFO - "basedir": "/builds/slave/test", 04:45:48 INFO - "buildnumber": 28, 04:45:48 INFO - "slavename": "t-yosemite-r7-0320", 04:45:48 INFO - "master": "http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/", 04:45:48 INFO - "platform": "yosemite_r7", 04:45:48 INFO - "scheduler": "tests-autoland-macosx64-talos", 04:45:48 INFO - "branch": "autoland", 04:45:48 INFO - "repo_path": "integration/autoland", 04:45:48 INFO - "revision": "0164fbe346839e2c77f82e4f587d66760a37bc26", 04:45:48 INFO - "stage_platform": "macosx64", 04:45:48 INFO - "builduid": "da2c2839738144d3af7b5bc0e7d67491", 04:45:48 INFO - "slavebuilddir": "test" 04:45:48 INFO - } 04:45:48 INFO - Found installer url https://queue.taskcluster.net/v1/task/NAgq4EkmTwe9cFxA6wZ0Ug/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg. 04:45:48 INFO - Running post-action listener: _resource_record_post_action 04:45:48 INFO - ##### 04:45:48 INFO - ##### Finished read-buildbot-config step (success) 04:45:48 INFO - ##### 04:45:48 INFO - ##### 04:45:48 INFO - ##### Running download-and-extract step. 04:45:48 INFO - ##### 04:45:48 INFO - Running pre-action listener: _resource_record_pre_action 04:45:48 INFO - Running main action method: download_and_extract 04:45:48 INFO - mkdir: /builds/slave/test/build/tests 04:45: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')]} 04:45:48 INFO - https://queue.taskcluster.net/v1/task/NAgq4EkmTwe9cFxA6wZ0Ug/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 04:45:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NAgq4EkmTwe9cFxA6wZ0Ug/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json 04:45:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NAgq4EkmTwe9cFxA6wZ0Ug/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json 04:45:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NAgq4EkmTwe9cFxA6wZ0Ug/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.mac.test_packages.json 04:45:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NAgq4EkmTwe9cFxA6wZ0Ug/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.mac.test_packages.json'}, attempt #1 04:45:53 INFO - Downloaded 1199 bytes. 04:45:53 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.mac.test_packages.json 04:45:53 INFO - Using the following test package requirements: 04:45:53 INFO - {u'common': [u'firefox-50.0a1.en-US.mac.common.tests.zip'], 04:45:53 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 04:45:53 INFO - u'firefox-50.0a1.en-US.mac.cppunittest.tests.zip'], 04:45:53 INFO - u'gtest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 04:45:53 INFO - u'firefox-50.0a1.en-US.mac.gtest.tests.zip'], 04:45:53 INFO - u'jittest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 04:45:53 INFO - u'jsshell-mac.zip'], 04:45:53 INFO - u'mochitest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 04:45:53 INFO - u'firefox-50.0a1.en-US.mac.mochitest.tests.zip'], 04:45:53 INFO - u'mozbase': [u'firefox-50.0a1.en-US.mac.common.tests.zip'], 04:45:53 INFO - u'reftest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 04:45:53 INFO - u'firefox-50.0a1.en-US.mac.reftest.tests.zip'], 04:45:53 INFO - u'talos': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 04:45:53 INFO - u'firefox-50.0a1.en-US.mac.talos.tests.zip'], 04:45:53 INFO - u'web-platform': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 04:45:53 INFO - u'firefox-50.0a1.en-US.mac.web-platform.tests.zip'], 04:45:53 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 04:45:53 INFO - u'firefox-50.0a1.en-US.mac.xpcshell.tests.zip']} 04:45:53 INFO - Downloading packages: [u'firefox-50.0a1.en-US.mac.common.tests.zip'] for test suite category: common 04:45:53 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')]} 04:45:53 INFO - https://queue.taskcluster.net/v1/task/NAgq4EkmTwe9cFxA6wZ0Ug/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 04:45:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NAgq4EkmTwe9cFxA6wZ0Ug/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 04:45:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NAgq4EkmTwe9cFxA6wZ0Ug/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 04:45:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NAgq4EkmTwe9cFxA6wZ0Ug/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip 04:45:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NAgq4EkmTwe9cFxA6wZ0Ug/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:45:57 INFO - Downloaded 18806350 bytes. 04:45:57 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:45:57 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 04:46:00 INFO - Return code: 0 04:46:00 INFO - Downloading packages: [u'firefox-50.0a1.en-US.mac.common.tests.zip', u'firefox-50.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 04:46:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:46:00 INFO - https://queue.taskcluster.net/v1/task/NAgq4EkmTwe9cFxA6wZ0Ug/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 04:46:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NAgq4EkmTwe9cFxA6wZ0Ug/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 04:46:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NAgq4EkmTwe9cFxA6wZ0Ug/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 04:46:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NAgq4EkmTwe9cFxA6wZ0Ug/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip 04:46:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NAgq4EkmTwe9cFxA6wZ0Ug/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:46:05 INFO - Downloaded 18806350 bytes. 04:46:05 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:46:05 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 04:46:08 INFO - Return code: 0 04:46: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')]} 04:46:08 INFO - https://queue.taskcluster.net/v1/task/NAgq4EkmTwe9cFxA6wZ0Ug/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 04:46:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NAgq4EkmTwe9cFxA6wZ0Ug/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip 04:46:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NAgq4EkmTwe9cFxA6wZ0Ug/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip 04:46:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NAgq4EkmTwe9cFxA6wZ0Ug/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.mac.talos.tests.zip 04:46:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NAgq4EkmTwe9cFxA6wZ0Ug/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.talos.tests.zip'}, attempt #1 04:46:11 INFO - Downloaded 14403333 bytes. 04:46:11 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:46:11 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 04:46:11 INFO - Return code: 0 04:46:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:46:11 INFO - https://queue.taskcluster.net/v1/task/NAgq4EkmTwe9cFxA6wZ0Ug/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 04:46:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NAgq4EkmTwe9cFxA6wZ0Ug/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 04:46:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NAgq4EkmTwe9cFxA6wZ0Ug/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 04:46:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NAgq4EkmTwe9cFxA6wZ0Ug/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg 04:46:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NAgq4EkmTwe9cFxA6wZ0Ug/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg'}, attempt #1 04:46:18 INFO - Downloaded 112442298 bytes. 04:46:18 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/NAgq4EkmTwe9cFxA6wZ0Ug/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 04:46:18 INFO - mkdir: /builds/slave/test/properties 04:46:18 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:46:18 INFO - Writing to file /builds/slave/test/properties/build_url 04:46:18 INFO - Contents: 04:46:18 INFO - build_url:https://queue.taskcluster.net/v1/task/NAgq4EkmTwe9cFxA6wZ0Ug/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 04:46:20 INFO - Running post-action listener: _resource_record_post_action 04:46:20 INFO - Running post-action listener: set_extra_try_arguments 04:46:20 INFO - ##### 04:46:20 INFO - ##### Finished download-and-extract step (success) 04:46:20 INFO - ##### 04:46:20 INFO - ##### 04:46:20 INFO - ##### Running populate-webroot step. 04:46:20 INFO - ##### 04:46:20 INFO - Running pre-action listener: _resource_record_pre_action 04:46:20 INFO - Running main action method: populate_webroot 04:46:20 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:46:20 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:46:20 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:46:20 INFO - '--tppagecycles', 04:46:20 INFO - '7'], 04:46:20 INFO - 'tests': ['tsvgm']}}, 04:46:20 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:46:20 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:46:20 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:46:20 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:46:20 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:46:20 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:46:20 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:46:20 INFO - 'talos_options': ['--disable-e10s'], 04:46:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:46:20 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:46:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:46:20 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:46:20 INFO - 'talos_options': ['--disable-e10s'], 04:46:20 INFO - 'tests': ['damp', 'tps']}, 04:46:20 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:46:20 INFO - 'tests': ['damp', 'tps']}, 04:46:20 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:46:20 INFO - 'tests': ['dromaeo_dom']}, 04:46:20 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:46:20 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:46:20 INFO - 'tests': ['basic_compositor_video']}, 04:46:20 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:46:20 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:46:20 INFO - 'tests': ['a11yr', 04:46:20 INFO - 'ts_paint', 04:46:20 INFO - 'tpaint', 04:46:20 INFO - 'sessionrestore', 04:46:20 INFO - 'sessionrestore_no_auto_restore', 04:46:20 INFO - 'tabpaint']}, 04:46:20 INFO - 'other-e10s': {'tests': ['a11yr', 04:46:20 INFO - 'ts_paint', 04:46:20 INFO - 'tpaint', 04:46:20 INFO - 'sessionrestore', 04:46:20 INFO - 'sessionrestore_no_auto_restore', 04:46:20 INFO - 'tabpaint']}, 04:46:20 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:46:20 INFO - 'ts_paint', 04:46:20 INFO - 'tpaint', 04:46:20 INFO - 'sessionrestore', 04:46:20 INFO - 'sessionrestore_no_auto_restore', 04:46:20 INFO - 'tabpaint']}, 04:46:20 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:46:20 INFO - 'ts_paint', 04:46:20 INFO - 'tpaint', 04:46:20 INFO - 'sessionrestore', 04:46:20 INFO - 'sessionrestore_no_auto_restore', 04:46:20 INFO - 'tabpaint']}, 04:46:20 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:46:20 INFO - 'tests': ['a11yr', 04:46:20 INFO - 'ts_paint', 04:46:20 INFO - 'tpaint', 04:46:20 INFO - 'sessionrestore', 04:46:20 INFO - 'sessionrestore_no_auto_restore', 04:46:20 INFO - 'tabpaint']}, 04:46:20 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:46:20 INFO - 'tests': ['a11yr', 04:46:20 INFO - 'ts_paint', 04:46:20 INFO - 'tpaint', 04:46:20 INFO - 'sessionrestore', 04:46:20 INFO - 'sessionrestore_no_auto_restore', 04:46:20 INFO - 'tabpaint']}, 04:46:20 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:46:20 INFO - 'tests': ['tsvgx', 04:46:20 INFO - 'tsvgr_opacity', 04:46:20 INFO - 'tart', 04:46:20 INFO - 'tscrollx', 04:46:20 INFO - 'cart']}, 04:46:20 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:46:20 INFO - 'tsvgr_opacity', 04:46:20 INFO - 'tart', 04:46:20 INFO - 'tscrollx', 04:46:20 INFO - 'cart']}, 04:46:20 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:46:20 INFO - 'talos_options': ['--disable-e10s'], 04:46:20 INFO - 'tests': ['tp5o']}, 04:46:20 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:46:20 INFO - 'tests': ['tp5o']}, 04:46:20 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:46:20 INFO - 'talos_options': ['--disable-e10s', 04:46:20 INFO - '--xperf_path', 04:46:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:46:20 INFO - 'tests': ['tp5n']}, 04:46:20 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:46:20 INFO - 'talos_options': ['--xperf_path', 04:46:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:46:20 INFO - 'tests': ['tp5n']}}, 04:46:20 INFO - 'talos.zip': {'path': '', 04:46:20 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:46:20 INFO - Running post-action listener: _resource_record_post_action 04:46:20 INFO - ##### 04:46:20 INFO - ##### Finished populate-webroot step (success) 04:46:20 INFO - ##### 04:46:20 INFO - ##### 04:46:20 INFO - ##### Running create-virtualenv step. 04:46:20 INFO - ##### 04:46:20 INFO - Running pre-action listener: _resource_record_pre_action 04:46:20 INFO - Running main action method: create_virtualenv 04:46:20 INFO - Creating virtualenv /builds/slave/test/build/venv 04:46:20 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 04:46:20 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:46:20 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:46:20 INFO - Using real prefix '/tools/python27' 04:46:20 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:46:21 INFO - Installing distribute.............................................................................................................................................................................................done. 04:46:23 INFO - Installing pip.................done. 04:46:23 INFO - Return code: 0 04:46:23 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:46:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:46:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:46:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:46:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:46:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:46:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:46:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1039b3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103a48618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff301cc5ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103917d30>, '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 0x10367cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10390fb20>, '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.ARfqb1Dj0Z/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.eqpPbgH9V5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/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 04:46:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 04:46:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:46:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ARfqb1Dj0Z/Render', 04:46:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:46:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:46:23 INFO - 'HOME': '/Users/cltbld', 04:46:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:46:23 INFO - 'LOGNAME': 'cltbld', 04:46:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:46:23 INFO - 'MOZ_NO_REMOTE': '1', 04:46:23 INFO - 'NO_EM_RESTART': '1', 04:46:23 INFO - 'PAGER': '/bin/cat', 04:46:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:46:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:46:23 INFO - 'PWD': '/builds/slave/test', 04:46:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:46:23 INFO - 'SHELL': '/bin/bash', 04:46:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eqpPbgH9V5/Listeners', 04:46:23 INFO - 'TMPDIR': '/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/', 04:46:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:46:23 INFO - 'USER': 'cltbld', 04:46:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:46:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:46:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:46:23 INFO - 'XPC_FLAGS': '0x0', 04:46:23 INFO - 'XPC_SERVICE_NAME': '0', 04:46:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:46:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:46:24 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 04:46:24 INFO - Cleaning up... 04:46:24 INFO - Return code: 0 04:46:24 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:46:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:46:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:46:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:46:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:46:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:46:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:46:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1039b3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103a48618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff301cc5ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103917d30>, '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 0x10367cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10390fb20>, '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.ARfqb1Dj0Z/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.eqpPbgH9V5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/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 04:46:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 04:46:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 04:46:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ARfqb1Dj0Z/Render', 04:46:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:46:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:46:24 INFO - 'HOME': '/Users/cltbld', 04:46:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:46:24 INFO - 'LOGNAME': 'cltbld', 04:46:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:46:24 INFO - 'MOZ_NO_REMOTE': '1', 04:46:24 INFO - 'NO_EM_RESTART': '1', 04:46:24 INFO - 'PAGER': '/bin/cat', 04:46:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:46:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:46:24 INFO - 'PWD': '/builds/slave/test', 04:46:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:46:24 INFO - 'SHELL': '/bin/bash', 04:46:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eqpPbgH9V5/Listeners', 04:46:24 INFO - 'TMPDIR': '/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/', 04:46:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:46:24 INFO - 'USER': 'cltbld', 04:46:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:46:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:46:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:46:24 INFO - 'XPC_FLAGS': '0x0', 04:46:24 INFO - 'XPC_SERVICE_NAME': '0', 04:46:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:46:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:46:24 INFO - Downloading/unpacking psutil>=3.1.1 04:46:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:46:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:46:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:46:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:46:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:46:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:46:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:46:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:46:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:46:27 INFO - Installing collected packages: psutil 04:46:27 INFO - Running setup.py install for psutil 04:46:27 INFO - building 'psutil._psutil_osx' extension 04:46:27 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 04:46:28 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 04:46:28 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 04:46:28 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 04:46:28 INFO - building 'psutil._psutil_posix' extension 04:46:28 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 04:46:28 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 04:46:28 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 04:46:28 INFO - ^ 04:46:28 INFO - 1 warning generated. 04:46:28 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 04:46:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:46:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:46:28 INFO - Successfully installed psutil 04:46:28 INFO - Cleaning up... 04:46:29 INFO - Return code: 0 04:46:29 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:46:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:46:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:46:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:46:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:46:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:46:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:46:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1039b3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103a48618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff301cc5ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103917d30>, '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 0x10367cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10390fb20>, '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.ARfqb1Dj0Z/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.eqpPbgH9V5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/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 04:46:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 04:46:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 04:46:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ARfqb1Dj0Z/Render', 04:46:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:46:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:46:29 INFO - 'HOME': '/Users/cltbld', 04:46:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:46:29 INFO - 'LOGNAME': 'cltbld', 04:46:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:46:29 INFO - 'MOZ_NO_REMOTE': '1', 04:46:29 INFO - 'NO_EM_RESTART': '1', 04:46:29 INFO - 'PAGER': '/bin/cat', 04:46:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:46:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:46:29 INFO - 'PWD': '/builds/slave/test', 04:46:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:46:29 INFO - 'SHELL': '/bin/bash', 04:46:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eqpPbgH9V5/Listeners', 04:46:29 INFO - 'TMPDIR': '/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/', 04:46:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:46:29 INFO - 'USER': 'cltbld', 04:46:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:46:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:46:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:46:29 INFO - 'XPC_FLAGS': '0x0', 04:46:29 INFO - 'XPC_SERVICE_NAME': '0', 04:46:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:46:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:46:29 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:46:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:46:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:46:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:46:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:46:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:46:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:46:31 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:46:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:46:31 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:46:31 INFO - Installing collected packages: mozsystemmonitor 04:46:31 INFO - Running setup.py install for mozsystemmonitor 04:46:32 INFO - Successfully installed mozsystemmonitor 04:46:32 INFO - Cleaning up... 04:46:32 INFO - Return code: 0 04:46:32 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:46:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:46:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:46:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:46:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:46:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:46:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:46:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1039b3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103a48618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff301cc5ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103917d30>, '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 0x10367cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10390fb20>, '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.ARfqb1Dj0Z/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.eqpPbgH9V5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/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 04:46:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 04:46:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 04:46:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ARfqb1Dj0Z/Render', 04:46:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:46:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:46:32 INFO - 'HOME': '/Users/cltbld', 04:46:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:46:32 INFO - 'LOGNAME': 'cltbld', 04:46:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:46:32 INFO - 'MOZ_NO_REMOTE': '1', 04:46:32 INFO - 'NO_EM_RESTART': '1', 04:46:32 INFO - 'PAGER': '/bin/cat', 04:46:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:46:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:46:32 INFO - 'PWD': '/builds/slave/test', 04:46:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:46:32 INFO - 'SHELL': '/bin/bash', 04:46:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eqpPbgH9V5/Listeners', 04:46:32 INFO - 'TMPDIR': '/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/', 04:46:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:46:32 INFO - 'USER': 'cltbld', 04:46:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:46:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:46:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:46:32 INFO - 'XPC_FLAGS': '0x0', 04:46:32 INFO - 'XPC_SERVICE_NAME': '0', 04:46:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:46:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:46:32 INFO - Downloading/unpacking jsonschema==2.5.1 04:46:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:46:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:46:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:46:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:46:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:46:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:46:34 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:46:34 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:46:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:46:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:46:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:46:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:46:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:46:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:46:35 INFO - Downloading functools32-3.2.3-2.tar.gz 04:46:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:46:35 INFO - warning: no files found matching '*.txt' 04:46:35 INFO - no previously-included directories found matching 'build' 04:46:35 INFO - no previously-included directories found matching 'dist' 04:46:35 INFO - no previously-included directories found matching '.git*' 04:46:35 INFO - Installing collected packages: jsonschema, functools32 04:46:35 INFO - Running setup.py install for functools32 04:46:35 INFO - warning: no files found matching '*.txt' 04:46:35 INFO - no previously-included directories found matching 'build' 04:46:35 INFO - no previously-included directories found matching 'dist' 04:46:35 INFO - no previously-included directories found matching '.git*' 04:46:35 INFO - Successfully installed jsonschema functools32 04:46:35 INFO - Cleaning up... 04:46:35 INFO - Return code: 0 04:46:35 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:46: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')]} 04:46:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:46:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:46: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')]} 04:46:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:46:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:46:35 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 0x1039b3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103a48618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff301cc5ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103917d30>, '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 0x10367cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10390fb20>, '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.ARfqb1Dj0Z/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.eqpPbgH9V5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/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 04:46:35 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 04:46:35 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 04:46:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ARfqb1Dj0Z/Render', 04:46:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:46:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:46:35 INFO - 'HOME': '/Users/cltbld', 04:46:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:46:35 INFO - 'LOGNAME': 'cltbld', 04:46:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:46:35 INFO - 'MOZ_NO_REMOTE': '1', 04:46:35 INFO - 'NO_EM_RESTART': '1', 04:46:35 INFO - 'PAGER': '/bin/cat', 04:46:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:46:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:46:35 INFO - 'PWD': '/builds/slave/test', 04:46:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:46:35 INFO - 'SHELL': '/bin/bash', 04:46:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eqpPbgH9V5/Listeners', 04:46:35 INFO - 'TMPDIR': '/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/', 04:46:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:46:35 INFO - 'USER': 'cltbld', 04:46:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:46:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:46:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:46:35 INFO - 'XPC_FLAGS': '0x0', 04:46:35 INFO - 'XPC_SERVICE_NAME': '0', 04:46:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:46:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:46:35 INFO - Downloading/unpacking blobuploader==1.2.4 04:46:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:46:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:46:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:46:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:46:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:46:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:46:38 INFO - Downloading blobuploader-1.2.4.tar.gz 04:46:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:46:38 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:46:38 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 04:46:38 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 04:46:38 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 04:46:38 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 04:46:38 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 04:46:38 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 04:46:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:46:39 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:46:39 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 04:46:39 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 04:46:39 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 04:46:39 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 04:46:39 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 04:46:39 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 04:46:39 INFO - Downloading docopt-0.6.1.tar.gz 04:46:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:46:39 INFO - Installing collected packages: blobuploader, requests, docopt 04:46:39 INFO - Running setup.py install for blobuploader 04:46:39 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:46:39 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:46:39 INFO - Running setup.py install for requests 04:46:40 INFO - Running setup.py install for docopt 04:46:40 INFO - Successfully installed blobuploader requests docopt 04:46:40 INFO - Cleaning up... 04:46:40 INFO - Return code: 0 04:46:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:46:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:46:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:46:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:46:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:46:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:46:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:46:40 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 0x1039b3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103a48618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff301cc5ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103917d30>, '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 0x10367cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10390fb20>, '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.ARfqb1Dj0Z/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.eqpPbgH9V5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/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 04:46:40 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 04:46:40 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 04:46:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ARfqb1Dj0Z/Render', 04:46:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:46:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:46:40 INFO - 'HOME': '/Users/cltbld', 04:46:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:46:40 INFO - 'LOGNAME': 'cltbld', 04:46:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:46:40 INFO - 'MOZ_NO_REMOTE': '1', 04:46:40 INFO - 'NO_EM_RESTART': '1', 04:46:40 INFO - 'PAGER': '/bin/cat', 04:46:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:46:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:46:40 INFO - 'PWD': '/builds/slave/test', 04:46:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:46:40 INFO - 'SHELL': '/bin/bash', 04:46:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eqpPbgH9V5/Listeners', 04:46:40 INFO - 'TMPDIR': '/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/', 04:46:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:46:40 INFO - 'USER': 'cltbld', 04:46:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:46:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:46:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:46:40 INFO - 'XPC_FLAGS': '0x0', 04:46:40 INFO - 'XPC_SERVICE_NAME': '0', 04:46:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:46:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:46:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:46:40 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-6PgeHg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:46:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:46:40 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-a91FiO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:46:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:46:40 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-HOfeAK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:46:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:46:40 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-dDFdot-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:46:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:46:41 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-7vYyKz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:46:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:46:41 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-_qZGx7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:46:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:46:41 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-8J9dtk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:46:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:46:41 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-e6bDnQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:46:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:46:41 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-8vvWl7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:46:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:46:41 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-vkfvN7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:46:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:46:41 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-kfnKa1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:46:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:46:41 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-JImKwT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:46:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:46:41 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-z8M2s6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:46:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:46:41 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-AM1cgD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:46:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:46:42 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-Ac_D3W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:46:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:46:42 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-qZZEfd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:46:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:46:42 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-jORe6Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:46:42 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:46:42 INFO - Running setup.py install for manifestparser 04:46:42 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:46:42 INFO - Running setup.py install for mozcrash 04:46:42 INFO - Running setup.py install for mozdebug 04:46:42 INFO - Running setup.py install for mozdevice 04:46:42 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:46:42 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:46:43 INFO - Running setup.py install for mozfile 04:46:43 INFO - Running setup.py install for mozhttpd 04:46:43 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:46:43 INFO - Running setup.py install for mozinfo 04:46:43 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:46:43 INFO - Running setup.py install for mozInstall 04:46:43 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:46:43 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:46:43 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:46:43 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:46:43 INFO - Running setup.py install for mozleak 04:46:43 INFO - Running setup.py install for mozlog 04:46:43 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:46:43 INFO - Running setup.py install for moznetwork 04:46:44 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:46:44 INFO - Running setup.py install for mozprocess 04:46:44 INFO - Running setup.py install for mozprofile 04:46:44 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:46:44 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:46:44 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:46:44 INFO - Running setup.py install for mozrunner 04:46:44 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:46:44 INFO - Running setup.py install for mozscreenshot 04:46:44 INFO - Running setup.py install for moztest 04:46:44 INFO - Running setup.py install for mozversion 04:46:44 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:46:44 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:46:44 INFO - Cleaning up... 04:46:44 INFO - Return code: 0 04:46:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:46:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:46:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:46:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:46:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:46:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:46:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:46:44 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 0x1039b3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103a48618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff301cc5ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103917d30>, '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 0x10367cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10390fb20>, '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.ARfqb1Dj0Z/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.eqpPbgH9V5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/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 04:46:44 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 04:46:44 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 04:46:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ARfqb1Dj0Z/Render', 04:46:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:46:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:46:44 INFO - 'HOME': '/Users/cltbld', 04:46:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:46:44 INFO - 'LOGNAME': 'cltbld', 04:46:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:46:44 INFO - 'MOZ_NO_REMOTE': '1', 04:46:44 INFO - 'NO_EM_RESTART': '1', 04:46:44 INFO - 'PAGER': '/bin/cat', 04:46:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:46:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:46:44 INFO - 'PWD': '/builds/slave/test', 04:46:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:46:44 INFO - 'SHELL': '/bin/bash', 04:46:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eqpPbgH9V5/Listeners', 04:46:44 INFO - 'TMPDIR': '/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/', 04:46:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:46:44 INFO - 'USER': 'cltbld', 04:46:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:46:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:46:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:46:44 INFO - 'XPC_FLAGS': '0x0', 04:46:44 INFO - 'XPC_SERVICE_NAME': '0', 04:46:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:46:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:46:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:46:45 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-wGNqaI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:46:45 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)) 04:46:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:46:45 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-BfZ_7y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:46:45 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)) 04:46:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:46:45 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-SdJu7r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:46:45 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)) 04:46:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:46:45 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-PJkqJx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:46:45 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)) 04:46:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:46:45 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-C5kWNB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:46:45 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)) 04:46:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:46:45 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-DBCX00-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:46:45 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)) 04:46:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:46:45 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-zQk95Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:46:45 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)) 04:46:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:46:45 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-b0dPls-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:46:46 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)) 04:46:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:46:46 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-ccz4CE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:46:46 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)) 04:46:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:46:46 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-DWMUEg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:46:46 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)) 04:46:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:46:46 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-92MBLX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:46:46 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)) 04:46:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:46:46 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-q1wJTG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:46:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 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)) 04:46:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:46:46 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-X8gkbh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:46:46 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)) 04:46:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:46:46 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-AvJ760-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:46:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 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)) 04:46:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:46:46 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-5KhKxW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:46:46 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)) 04:46:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:46:46 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-ar4FW3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:46:46 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)) 04:46:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:46:46 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-u6vCkx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:46:47 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)) 04:46:47 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)) 04:46:47 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)) 04:46:47 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)) 04:46:47 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)) 04:46:47 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)) 04:46:47 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:46:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:46:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:46:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:46:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:46:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:46:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:46:49 INFO - Downloading blessings-1.6.tar.gz 04:46:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:46:49 INFO - Installing collected packages: blessings 04:46:49 INFO - Running setup.py install for blessings 04:46:49 INFO - Successfully installed blessings 04:46:49 INFO - Cleaning up... 04:46:49 INFO - Return code: 0 04:46:49 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:46:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:46:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:46:50 INFO - Reading from file tmpfile_stdout 04:46:50 INFO - Current package versions: 04:46:50 INFO - blessings == 1.6 04:46:50 INFO - blobuploader == 1.2.4 04:46:50 INFO - docopt == 0.6.1 04:46:50 INFO - functools32 == 3.2.3-2 04:46:50 INFO - jsonschema == 2.5.1 04:46:50 INFO - manifestparser == 1.1 04:46:50 INFO - mozInstall == 1.12 04:46:50 INFO - mozcrash == 0.17 04:46:50 INFO - mozdebug == 0.1 04:46:50 INFO - mozdevice == 0.48 04:46:50 INFO - mozfile == 1.2 04:46:50 INFO - mozhttpd == 0.7 04:46:50 INFO - mozinfo == 0.9 04:46:50 INFO - mozleak == 0.1 04:46:50 INFO - mozlog == 3.2 04:46:50 INFO - moznetwork == 0.27 04:46:50 INFO - mozprocess == 0.23 04:46:50 INFO - mozprofile == 0.28 04:46:50 INFO - mozrunner == 6.12 04:46:50 INFO - mozscreenshot == 0.1 04:46:50 INFO - mozsystemmonitor == 0.3 04:46:50 INFO - moztest == 0.7 04:46:50 INFO - mozversion == 1.4 04:46:50 INFO - psutil == 3.1.1 04:46:50 INFO - requests == 1.2.3 04:46:50 INFO - wsgiref == 0.1.2 04:46:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:46:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:46:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:46:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:46:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:46:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:46:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:46:50 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 0x1039b3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103a48618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff301cc5ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103917d30>, '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 0x10367cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10390fb20>, '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.ARfqb1Dj0Z/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.eqpPbgH9V5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/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 04:46:50 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 04:46:50 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 04:46:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ARfqb1Dj0Z/Render', 04:46:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:46:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:46:50 INFO - 'HOME': '/Users/cltbld', 04:46:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:46:50 INFO - 'LOGNAME': 'cltbld', 04:46:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:46:50 INFO - 'MOZ_NO_REMOTE': '1', 04:46:50 INFO - 'NO_EM_RESTART': '1', 04:46:50 INFO - 'PAGER': '/bin/cat', 04:46:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:46:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:46:50 INFO - 'PWD': '/builds/slave/test', 04:46:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:46:50 INFO - 'SHELL': '/bin/bash', 04:46:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eqpPbgH9V5/Listeners', 04:46:50 INFO - 'TMPDIR': '/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/', 04:46:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:46:50 INFO - 'USER': 'cltbld', 04:46:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:46:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:46:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:46:50 INFO - 'XPC_FLAGS': '0x0', 04:46:50 INFO - 'XPC_SERVICE_NAME': '0', 04:46:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:46:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:46:50 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)) 04:46:50 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)) 04:46:50 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)) 04:46:50 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)) 04:46:50 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)) 04:46:50 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)) 04:46:50 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)) 04:46:50 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)) 04:46:50 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)) 04:46:50 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)) 04:46:50 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)) 04:46:50 INFO - Cleaning up... 04:46:50 INFO - Return code: 0 04:46:50 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:46:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:46:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:46:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:46:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:46:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:46:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:46:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1039b3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103a48618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff301cc5ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103917d30>, '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 0x10367cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10390fb20>, '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.ARfqb1Dj0Z/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.eqpPbgH9V5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/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 04:46:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 04:46:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 04:46:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ARfqb1Dj0Z/Render', 04:46:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:46:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:46:50 INFO - 'HOME': '/Users/cltbld', 04:46:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:46:50 INFO - 'LOGNAME': 'cltbld', 04:46:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:46:50 INFO - 'MOZ_NO_REMOTE': '1', 04:46:50 INFO - 'NO_EM_RESTART': '1', 04:46:50 INFO - 'PAGER': '/bin/cat', 04:46:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:46:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:46:50 INFO - 'PWD': '/builds/slave/test', 04:46:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:46:50 INFO - 'SHELL': '/bin/bash', 04:46:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eqpPbgH9V5/Listeners', 04:46:50 INFO - 'TMPDIR': '/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/', 04:46:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:46:50 INFO - 'USER': 'cltbld', 04:46:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:46:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:46:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:46:50 INFO - 'XPC_FLAGS': '0x0', 04:46:50 INFO - 'XPC_SERVICE_NAME': '0', 04:46:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:46:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:46:50 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:46:50 INFO - Cleaning up... 04:46:50 INFO - Return code: 0 04:46:50 INFO - Running post-action listener: _resource_record_post_action 04:46:50 INFO - Running post-action listener: _start_resource_monitoring 04:46:50 INFO - Starting resource monitoring. 04:46:50 INFO - ##### 04:46:50 INFO - ##### Finished create-virtualenv step (success) 04:46:50 INFO - ##### 04:46:50 INFO - ##### 04:46:50 INFO - ##### Running install step. 04:46:50 INFO - ##### 04:46:50 INFO - Running pre-action listener: _resource_record_pre_action 04:46:50 INFO - Running main action method: install 04:46:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:46:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:46:50 INFO - Reading from file tmpfile_stdout 04:46:50 INFO - Detecting whether we're running mozinstall >=1.0... 04:46:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:46:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:46:51 INFO - Reading from file tmpfile_stdout 04:46:51 INFO - Output received: 04:46:51 INFO - Usage: mozinstall [options] installer 04:46:51 INFO - Options: 04:46:51 INFO - -h, --help show this help message and exit 04:46:51 INFO - -d DEST, --destination=DEST 04:46:51 INFO - Directory to install application into. [default: 04:46:51 INFO - "/builds/slave/test"] 04:46:51 INFO - --app=APP Application being installed. [default: firefox] 04:46:51 INFO - mkdir: /builds/slave/test/build/application 04:46:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 04:46:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 04:47:25 INFO - Reading from file tmpfile_stdout 04:47:25 INFO - Output received: 04:47:25 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 04:47:25 INFO - Running post-action listener: _resource_record_post_action 04:47:25 INFO - ##### 04:47:25 INFO - ##### Finished install step (success) 04:47:25 INFO - ##### 04:47:25 INFO - ##### 04:47:25 INFO - ##### Running run-tests step. 04:47:25 INFO - ##### 04:47:25 INFO - Running pre-action listener: _resource_record_pre_action 04:47:25 INFO - Running main action method: run_tests 04:47:25 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:47:25 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:47:25 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:47:25 INFO - 2016-07-08 04:47:25.867 screenresolution[1649:7931] starting screenresolution argv=screenresolution get 04:47:25 INFO - 2016-07-08 04:47:25.870 screenresolution[1649:7931] Display 0: 1600x1200x32@60 04:47:25 INFO - 2016-07-08 04:47:25.876 screenresolution[1650:7933] starting screenresolution argv=screenresolution list 04:47:25 INFO - Available Modes on Display 0 04:47:25 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:47:25 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:47:25 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:47:25 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:47:26 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:47:26 INFO - Intel Iris: 04:47:26 INFO - Chipset Model: Intel Iris 04:47:26 INFO - Type: GPU 04:47:26 INFO - Bus: Built-In 04:47:26 INFO - VRAM (Dynamic, Max): 1536 MB 04:47:26 INFO - Vendor: Intel (0x8086) 04:47:26 INFO - Device ID: 0x0a2e 04:47:26 INFO - Revision ID: 0x0009 04:47:26 INFO - Displays: 04:47:26 INFO - Display: 04:47:26 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:47:26 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:47:26 INFO - Display Serial Number: 1600x1200 60 04:47:26 INFO - Main Display: Yes 04:47:26 INFO - Mirror: Off 04:47:26 INFO - Online: Yes 04:47:26 INFO - Rotation: Supported 04:47:26 INFO - Return code: 0 04:47:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:47:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:47:26 INFO - Python 2.7.3 04:47:26 INFO - Return code: 0 04:47:26 INFO - grabbing minidump binary from tooltool 04:47:26 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')]} 04:47:26 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 0x103917d30>, '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 0x10367cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10390fb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:47:26 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 04:47:26 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 04:47:26 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 04:47:26 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:47:26 INFO - Return code: 0 04:47:26 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 04:47:26 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:47:26 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:47:26 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 04:47:26 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:47:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NAgq4EkmTwe9cFxA6wZ0Ug/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0320', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 04:47:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/NAgq4EkmTwe9cFxA6wZ0Ug/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0320 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 04:47:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ARfqb1Dj0Z/Render', 04:47:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:47:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:47:26 INFO - 'HOME': '/Users/cltbld', 04:47:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:47:26 INFO - 'LOGNAME': 'cltbld', 04:47:26 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:47:26 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 04:47:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:47:26 INFO - 'MOZ_NO_REMOTE': '1', 04:47:26 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:47:26 INFO - 'NO_EM_RESTART': '1', 04:47:26 INFO - 'PAGER': '/bin/cat', 04:47:26 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:47:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:47:26 INFO - 'PWD': '/builds/slave/test', 04:47:26 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:47:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:47:26 INFO - 'SHELL': '/bin/bash', 04:47:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eqpPbgH9V5/Listeners', 04:47:26 INFO - 'TMPDIR': '/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/', 04:47:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:47:26 INFO - 'USER': 'cltbld', 04:47:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:47:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:47:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:47:26 INFO - 'XPC_FLAGS': '0x0', 04:47:26 INFO - 'XPC_SERVICE_NAME': '0', 04:47:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:47:26 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NAgq4EkmTwe9cFxA6wZ0Ug/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0320', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 04:47:26 INFO - mozversion application_buildid: 20160708022325 04:47:26 INFO - mozversion application_changeset: 0164fbe346839e2c77f82e4f587d66760a37bc26 04:47:26 INFO - mozversion application_display_name: Nightly 04:47:26 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:47:26 INFO - mozversion application_name: Firefox 04:47:26 INFO - mozversion application_remotingname: firefox 04:47:26 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 04:47:26 INFO - mozversion application_vendor: Mozilla 04:47:26 INFO - mozversion application_version: 50.0a1 04:47:26 INFO - mozversion platform_buildid: 20160708022325 04:47:26 INFO - mozversion platform_changeset: 0164fbe346839e2c77f82e4f587d66760a37bc26 04:47:26 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 04:47:26 INFO - mozversion platform_version: 50.0a1 04:47:26 INFO - using testdate: 1467978446 04:47:26 INFO - actual date: 1467978446 04:47:26 INFO - starting webserver on 'localhost:49273' 04:47:26 INFO - SUITE-START | Running 2 tests 04:47:26 INFO - TEST-START | dromaeo_css 04:47:26 INFO - operating with platform_type : mac_ 04:47:26 INFO - Initialising browser for dromaeo_css test... 04:47:26 INFO - TEST-INFO | started process 1660 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/tmpSymWkO/profile http://localhost:49273/getInfo.html) 04:47:29 INFO - PROCESS | 1660 | __metrics Screen width/height:1600/1200 04:47:29 INFO - PROCESS | 1660 | colorDepth:24 04:47:29 INFO - PROCESS | 1660 | Browser inner width/height: 1024/689 04:47:29 INFO - PROCESS | 1660 | __metrics 04:47:29 ERROR - PROCESS | 1660 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2957: TypeError: this.tabs is undefined 04:47:30 INFO - TEST-INFO | 1660: exit 0 04:47:30 INFO - Browser initialized. 04:47:30 INFO - Running cycle 1/1 for dromaeo_css test... 04:47:30 INFO - TEST-INFO | started process 1664 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/tmpSymWkO/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:47:42 INFO - PROCESS | 1664 | RSS: Main: 254578688 04:47:42 INFO - PROCESS | 1664 | 04:48:31 INFO - PROCESS | 1664 | 1467978511923 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] 04:50:43 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49273/tests/dromaeo/cssquery-ext.html) 04:50:44 INFO - PROCESS | 1664 | RSS: Main: 266964992 04:50:44 INFO - PROCESS | 1664 | 04:53:47 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-ext.html (next: http://localhost:49273/tests/dromaeo/cssquery-jquery.html) 04:53:47 INFO - PROCESS | 1664 | RSS: Main: 275484672 04:53:47 INFO - PROCESS | 1664 | 04:56:49 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49273/tests/dromaeo/cssquery-mootools.html) 04:56:50 INFO - PROCESS | 1664 | RSS: Main: 280092672 04:56:50 INFO - PROCESS | 1664 | 04:59:52 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49273/tests/dromaeo/cssquery-prototype.html) 04:59:52 INFO - PROCESS | 1664 | RSS: Main: 279457792 04:59:52 INFO - PROCESS | 1664 | 05:02:55 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49273/tests/dromaeo/cssquery-yui.html) 05:02:56 INFO - PROCESS | 1664 | RSS: Main: 283082752 05:02:56 INFO - PROCESS | 1664 | 05:05:58 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-yui.html (next: http://localhost:49273/tests/dromaeo/cssquery-dojo.html) 05:05:59 INFO - PROCESS | 1664 | RSS: Main: 282796032 05:05:59 INFO - PROCESS | 1664 | 05:05:59 INFO - PROCESS | 1664 | __start_tp_report 05:05:59 INFO - PROCESS | 1664 | _x_x_mozilla_page_load 05:05:59 INFO - PROCESS | 1664 | _x_x_mozilla_page_load_details 05:05:59 INFO - PROCESS | 1664 | |i|pagename|runs| 05:05:59 INFO - PROCESS | 1664 | |0;dojo.html;3238.2713889374895;3340.4154273002227;3347.548081009063;3367.5958884933802;3374.8481318340673;5715.371309155989;5738.741756620957;5764.365919748824;5775.249217601717;5828.883422331551;4721.3390125382475;5581.246531718217;5618.634788738739;5691.658500489973;5791.768329266824;5173.896522069575;5177.48225177483;5226.947730522703;5272.024675435037;5346.385165705935;5249.186376111708;5407.702576358299;5416.783328666848;5436.3476382834115;5456.154296084113;5212.27028216052;5220.6084543659;5253.658512196695;5301.125314323132;5306.7611957462;5298.125809241471;5302.44324345942;5307.3896501902;5318.494742999409;5329.2006199070065;4983.426905905795;5279.313689220377;5312.3093997780425;5312.548433383167;5327.760250788724;4695.718256904563;5509.393966663663;5614.466625670555;5711.457411545896;5758.395368486291;5270;5382.461753824626;6238.844028899269;6323.20959880015;6328.968355158241;6144.218176728743;6283.497320214372;6287.937120628781;6291.182146320994;6291.559590828644;4843.2735089736825;5780.3063632363965;5800.187973683687;5893;5908.438698323653;6233.781817636361;6255;6257.09272155544;6267.373262673787;6290.748370065237;5386.892262154735;5903.7048147593305;6138.14066030756;6218.751249950042;6244.500439964792;5006.74966251686;5782.479576838105;5808.157817116495;6159.19930409044;6169.475594574512;5365.865853353619;6117.327094019654;6169.136320915076;6195.752169913243;6201.472874805692;6229.657368844666;6261.311255761862;6262.279837818618;6280.2777680566405;6285.685715714288;4326.65386769064;4793.849476125774;4817.566419022235;4987.152184128707;5000.449950505442;4078.490188726409;4206.695924263488;4406.669499787528;4459;4470.240059189946;5473.863153421196;5756.683382413924;6010.338862725097;6070.484008859208;6106.72519736613;5965.094556389144;6195.791820595031;6208.286047104551;6225.439710426083;6233.065040243909;5183.637145399785;6002.129691194752;6003.909941350883;6006.939930600638;6027.849303767441;5333.893322133536;5370.838874833761;5459.945400545944;5472.2338872557875;5484.067708489566;6174.25908890936;6294.874102518015;6296.968515157487;6307.117003619405;6309.242890853127;5173.22401639757;6221.151117108422;6254.530910181846;6264.060390941395;6266.780662676784;5035.345405097314;6205.627662340274;6221.875562488634;6264.997600384099;6276.686165691788;6185.84535386619;6239.126522286792;6240.625562466266;6265.530085243716;6267.529935254783;5394.811181608625;6114.38856114385;6185.41238582334;6239.220097487814;6250.937490625036;6060.878782424415;6096.725647345791;6107.097787096225;6115.388461153849;6135.753292002456;6042.75828966854;6123.84690382744;6129.832282918493;6131.101423540838;6138.478229350555;5868.589198756046;5990.640561566146;6053.152558641882;6092.634441933498;6094.634321940698;6018.789342372996;6035.849103772441;6120.357362476876;6195.721192546256;6219.782307619212;6030.48740857032;6036.69816509164;6039.214902062704;6065.3934606539;6080.665563394055 05:05:59 INFO - PROCESS | 1664 | |1;ext.html;483.95402436768507;509.5439581574491;522.2896860270034;525.8667571383668;563.7237753500785;39194;41723.37414938771;41790.58209417909;41816.16367672645;42038.36942445866;42304.788476057576;42448.57551424485;42957.57042429575;43032;43080.569194308046;9523.238140948708;9671.661491847786;9727.36772109814;9734.221262299;9743.464109473976;9550.761230969212;9636.662716804913;9652.324337296392;9654.17939475142;9655.03449655036;9656.324057315991;9659.80680386392;9680.661176858812;9710.320277580573;9732.562034708455;9596.95201523995;9636.988116247834;9639.759006024835;9644.565994530298;9682.75793105171;9528.190103841182;9542.618295268181;9618.422894626276;9642.517874106266;9645.131938125602;39249.01877453058;40096.39855402171;40253;40382.79808600938;40791.7960410199;3041.8935337263088;3505.8247087645514;3773.3962565989586;4014.5532518973364;4041.191761647682;31395.686043139503;32923;33146;33208.501872471934;33465.49801752975;3284.178955261185;3284.6058472983154;3330.81680507572;3358.0429577570276;3399.8640054398043;502820;504489;505217;507771;508694;35199.82400088034;35855.82072089623;63116;63360.36639633545;63903.72192556123;35401.46897796535;35722.821385893425;35910.640893591255;35923.82038089793;35940.82029589835;14955.40178392852;15104.697906042038;15113.16877571722;15129.47046853355;15145.545633631009;12738;12860.421281042189;12872.935635321763;12875.54935577269;12956.67608309781;7065.717371305091;7741.651625676858;7785.688572457151;7824.295813376823;7831.530108193527;3120.438321102223;3130.577372054789;3132.2326030122767;3195.888143914998;3198.856051477689;956.5982287439292;978.2369751593768;995.4773743784426;1001.639409812467;1131.675939151195;30937.44219414796;31274.68725312763;31346.589403476897;31679;31725.524117138262;870.7910101575576;1089.2865173311493;1091.5579190427889;1099.6755956992706;1117.8211486162174;16407.671846563;16435.753463698053;16458.670826583402;16497.587560311087;16594.090511413404;663745;674347;677471;679878;681365;61241;61558.38441615526;61816;61818;61926.90365481708;1360.843502997168;1368.5004973184716;1415.7380884536394;1420.0343766239057;1420.3040510149951;30762;31075.53386699156;31305;31365.372692545567;31705.68294317027;42477.72566823;52974.73512632412;53336.1999569999;53549.92900142053;53671.73164134155;583628;596479;598474.0762961921;598983;601319;27548;27642.44715105727;27946.44107117887;27958.72041279561;28095.016674416296;41381.58618413777;50004.49995500144;50088.99822003613;51022.48977510177;51031.2345314828;41085.58914410818;41256.174876502904;41257.58742412538;42447.787761060994;42458.363124553776;41453.29028610508;41818.790906046495;42347.57652423436;42765.35851962161;42872.571274286856;33960.15099622431;39131.80434097811;39497.80251098726;39682.20635587214;40470.79764601158;29309.025120033366;31269.292720753932;34671.65328346684;36193;36544.45183322306;21775;26087.347816304744;26783.928642854848;26836.46327073487;26939.05713300025 05:05:59 INFO - PROCESS | 1664 | |2;jquery.html;374.4832131658313;375.63375708684026;378.2095420571007;391.1472988884231;392.59170462718777;19347.419577412682;20418.89790551045;21926.671099933494;21933.780662193414;22009.889950550245;11917.404129793518;12276.693082672915;12285.938570307158;12800.935995320011;21128.683069753926;4566.977165114178;5585.8603534911545;5617;5621.128725047624;5625.38120806711;3940.2119576084756;6550.475961923058;6853.252420632756;6875.381215690587;6922.376986071253;5629.268195134648;6022.518198544106;6887.7244910203535;6900.723971041152;6919.65401729914;5976;6054.303755068157;6056.364081771395;6080.635161890279;6091.604045737035;5810.5932584719085;5934.614250073774;5948.524118070544;5971.611845230046;5978.730957106941;24463.877680611662;25180.748192518022;25523.87238063798;25624.743752562423;26127.477450451075;1881.2380985700813;1886.8678792724393;2152.7954844289766;2202.757696653367;2433.7931275841574;10085.445300508469;10266;10337.89662103377;11416.972472477517;15479.5356139316;1862.655408749372;1876.6622008038548;1896.6586014517381;1961.460598335455;1968.8228059474716;86129;127061;130420;139492;139812.30093849465;11335.886641133648;11391.715207119723;11637.010854077329;11707.180497365272;11806.173567850168;14614.488492902698;14647.633809154857;14658.853411465749;14666.779998300033;14667.339969701388;8539.658413663508;8660.8700869487;8662.090480499583;8741.606627701769;8771.780705482286;8572.828543429096;8637.438566493158;8662.133786621287;8740.99478559961;8742.956285218534;4050.25070361984;4103.466549348565;4281.400603915392;4512;4567.497575266718;1835.5941751541848;1970.6649869522216;1977.8318842898516;1978.0801927103678;1987.3044434447827;865.6840253307497;907.8138981508907;949.0035462764071;977.63827383867;1069.5935544493043;21201.515893887587;21559.46101347479;21905.452363691034;21910.671339929915;21950.45123871884;773.2692605487761;957.5068839547639;974.4835237324229;1026.9717308316165;1055.2771351624162;11159.38623375722;11382;11556.88443115558;11565.132615053904;11590.652280431601;614485;616163.8383616107;627564;627671;630926;110694.89305107007;127670.72329276588;135951;136576;141049.29475352558;976.8632391465201;1044.8328267477318;1051.1013083813382;1052.8052310322614;1054.504382940017;19692.80307196967;19803.306884258982;19983.400497985083;20110.49723756918;20309;58313.12530311964;58382;59455.99999999827;60153.7969240604;61479.692601536706;88184.1181588176;88381;88991.11008890087;89350.65974010526;89827.55086224528;8421.831563368576;8502.192291732275;8506.61720222579;8630.223279904838;8646.78383040429;9363.485008324607;11289.37908415045;13261.336933153496;13377.933110334387;13947.953903457485;10519.158467322442;10930.781384372427;11410.543578256777;11446.82829757571;11892.940535297268;11498.25261358009;11535.884641153816;11662.825057624312;11780.469878855301;11813.527458901548;10776.191785615953;11663.59177428786;11775.352355620524;11883.227590206609;11899.405029748652;8314.376421768271;8324.83350333002;8342.874856877273;8601.827963440572;8625;8453.830923381622;10306.793864122825;10688.625898093529;11559.884401155881;11842.881571184178 05:05:59 INFO - PROCESS | 1664 | |3;mootools.html;1551.309667198097;1569.5997520632236;1811.7554130192427;1899.2687815191157;1914.148204049197;8218.342532597393;8707.172818582225;8708.60811263493;9143.99999999999;9172.54137293136;8815.911840881605;8868.91131088689;9002.414843035198;9005.909940900605;9017.233535149504;2343.964840527398;2373.5727569037567;2378.1795280628157;2378.8334816562847;2383.511380167062;2345.6129738593113;2363.019346971005;2392.9042838286446;2401.2076014915124;2404.927852164429;1982.3061928325114;2358.41039740065;2378.2627385510546;2385.487120269142;2405.1581946318825;2350.071721669931;2356.905723771056;2360.8701521416315;2375.489269806991;2376.809855211579;2326.8720220387872;2337.7311609164994;2345.319857241398;2352.847064940773;2354.176038386568;9060.637574497012;9117.270618350516;9142.77143071422;9153.496557689325;9170.587323570455;5285.603579731535;5414.43148469409;5425.267588875491;5428.4028756836715;5485.6434331768305;3290.700173431505;3298.96701032989;3620.5474315710535;3680.0063982724514;3700.685441737429;1068.1401471815186;1077.084478193537;1077.9191560632985;1100.9760922342218;1103.784761971416;9181.540922953893;11574.247673901169;12045.939770301093;12060.035197184205;12072.154949153475;4727.338172655762;4770.61835053195;4772.75547943504;4831.154547954094;4906.31311616374;9969.950150249348;10133.391996480235;10203;10235.283530152967;10285.588576456857;5344.625876188629;5411.269478620415;5433.456654334614;5442.863928401743;5446.754896029688;4411.09572537629;4808.567228949341;4954.578860796801;4967.875803104951;4978.8257410990445;3945.9802700986884;4003.979980100081;4035.5762644922447;4080.775557344315;4116.156187981456;1241.273854794955;1284.062634276983;1299.811527328532;1306.9607911762662;1308.3327502973552;835.8202986357962;898.6046139698511;942.1991307388665;971.1939090554822;1006.285537268533;6167.599106058092;6206.596571222856;6220.844478888064;6238.532110091761;6258.843528911722;989.1246247071393;993.9503024848729;1021.9131373833308;1025.3489034463169;1033.963811266602;4207.705460617727;4242.300020496584;4361.869143925687;4423.823047078081;4437.201303765353;10895;10948.233623646427;11159.442027898573;11196.94401527987;11212.495437705324;11126;11134.10927125828;11151.498182581803;11153.10775137987;11178.385188814693;7988.121306656263;8307.750767476864;8389.119142490195;8510.234078932926;8537.573121343908;5194.3247377840635;6153.938460615336;6195.256569211723;6276.340984196594;6317.6209427434505;10269.229807764297;10291.84562231552;10417.635382761568;10429.58281668755;10434.843477347695;10124.645637402655;10142.442165680959;10413.11488523484;10460.895391046297;10465.9476702616;7099.503034787515;7547.73582924595;7689.461737678309;7754.418418618739;7826.5695386751995;8489.108643592333;8676.219140277406;8685.696000639948;8720.520371379635;8728;7622.085349758065;7772.92227077722;7838.9216107840475;7881.881771773314;7884.605769711607;7488.438367122379;7495.025646665898;7547.245275472409;7682;7690.115636701851;7152.392046676091;7218;7220.350168484862;7230.6384680766805;7238.420926325986;5072.163093089599;5190.455002224712;5231.843044708665;5263.552598029058;5308.124159513637;4732.881677957941;5216.191490319006;5266.183741520071;5374.731263436891;5421.83734487966 05:05:59 INFO - PROCESS | 1664 | |4;prototype.html;311.7381399624316;318.1394328341834;320.4552261156035;320.971112599866;325.23407375630404;4574.748388838612;5375.973120134398;5542.528885044776;5614.29821272341;5825.65046097234;5213.504717051884;5780.710964451771;5795.449432303924;5811.244538210027;5811.476967072963;4139.6959957613335;4235.8729238122905;4326.502452217988;4346.913061738779;4353.586409291112;4254.319308910575;4318.546552611978;4329.696921215516;4348.478182618091;4354.847580334689;4266.679999000072;4309.0735491869245;4333.464923020037;4339.088791353819;4352.996432461608;4192.853250136246;4247.8300867965245;4342.610364683303;4346.413234213404;4367.3667318238995;3219.116816662232;3721.5348081489815;3723.3670276053135;3737.794421306827;3743.4571987061995;4673.275642275453;5576.693281869496;5592.161175823619;5608.355039170507;5698.430156984268;4628.745419001953;4723.4884836852225;4879.902401951941;4913.803447862081;5026.497350264981;5131.461196574381;5887.175795388649;6003.969980150071;6021.066734656135;6062.575619706622;4025.6175663311938;4039.6970227233073;4074.348104303327;4075.470188875427;4085.7957102144774;5283.524482796528;5901.7934372297195;6193.473554747807;6322.4942004639515;6336.778212762577;3258.7718859680067;4029.851492324732;4081.4490043843703;4103.4460347852655;4121.62905338521;3229.564008858774;3833.271678381099;4161.646260067928;4183.686223533186;4192.673066448089;3948.782816945038;4779.498152693986;4808.63935204861;4880.170371036932;4899;5260.500252476008;6036.939630603725;6052.273727152682;6074.54440916933;6084.505352805329;1394.316784775473;1407.7325308191412;1410.6684929041667;1414.9363278652486;1424.5370254667275;864.576357584779;875.0811647769816;877.3858299190592;918.875951746519;950.7860731335394;5226.529612334832;5260.948649783117;5548.5838562108;5621.988042152452;5624.437556244343;4703.670743047954;5577.2191893135;6016.518678505797;6106.938930610726;6182.196314479179;4784.569388755029;4890;5366.819299754048;5611.354694210137;5662.773489060474;3217.51737239416;3228.5641438405983;3256.446404111307;3264.2329052672603;3266.852991615383;5859.882802343929;6333.271673757485;6347.301796802348;6391.497997970473;6419.775307864295;5579.358373786985;6043.373975614596;6235.256487145642;6259.838781415356;6311.715972781236;5501.614886957875;6212.937870621417;6291.842703932347;6378.77674281398;6386.233651961795;5466.71532189943;5694.886102278014;5930.703464826655;6070.726817293321;6140.385961403824;5199.634166454179;5903.380145084704;6070.939290607214;6102.725377358119;6122.387761223842;5489.149181876815;5891.852703682443;6090.573659843769;6204.906926396017;6260.7495700171485;3368.343173081226;3536.045267777737;3703.9444408333356;3836.616338366141;4047.6357127858632;4673.485916549245;6123.357047510125;6151.954167791397;6178.845528861814;6210.441060304594;4975.348049573516;5306.495882891119;5668.829935101953;6076.149339092619;6118.2658081028785;5846.503047241032;6137.478314343331;6138.25566404484;6168.61206228595;6185.505159587312;4877.073755746524;5357.928414317074;5596.692181930033;6012.63924164534;6019.759209631566;5668.781212039431;5973.820785376446;6045.879082418415;6057.909131362945;6067.362926892612;4861.829835955725;4948.119714508463;5327.387350454593;5898.997170480942;5950.322354940207 05:05:59 INFO - PROCESS | 1664 | |5;yui.html;646.6411141816292;735.2867718313238;801.3148757812071;828.6643909216767;838.6310023589616;16056.83943160568;16106.194690265484;16367.754483682755;16468.505944821674;16496.42262520812;13554.864451355483;13650.590482285523;13674.179549227054;13698.863011369907;13714;686.5468790598206;872.9170728780788;882.15753954973;894.9060348663394;895.6014573514789;742.4728442805615;890.2966656341482;892.3797960417512;902.7788191892995;903.2954295649404;937.7327461673425;954.374884450686;957.286821318119;958.5255298627189;959.9856002159974;919.4345477531336;929.9209567186797;945.2343601682659;947.0198344713223;951.8905325887473;680.9897851532231;708.8405108850519;709.3651182191961;710.4848984486258;711.1324184494908;15209.543713688607;15344.769828452581;15368.923155384151;15600.98593591413;15604.531864044096;13832.792508112387;13999.110120133753;14009.649758756012;14137.222452765094;14158.29208539569;11129.443527823658;11157.609483668113;11177.49701263445;11207.439628018648;11480.254676002181;3899.278633452792;3913.3738601823857;3943.842246310173;3953.960460395388;4085.121698834735;111801.44099279532;120552.19171712431;120762;121262.78737212603;121608.17587736191;9048.23090037341;10488.737781555523;10938.726531836768;10986.340819550853;12053.457594408274;17117.14414279281;21457;21631.35105946824;21859.453513662287;21882.562348752937;7295.905614157813;7560.848783024308;8031.55826429552;8053.1946805319;8148.5419575381275;3765.7175711821724;3901.6098390160755;4615.930761038587;4639.953600463952;4716.622670186377;3346.297277571737;3670.926581468409;3674.669279764834;3678.797666128335;3683.686886614614;666.1539844397588;676.6887231873393;678.260695841535;680.3604611665019;690.8756423843656;510.9795608175706;530.4562823106347;705.4391758551861;709.3722055980494;716.9856602868018;8622.741317760478;9174.86237706435;9571.760705982406;9907.009299070036;9974.202063834875;671.8488340123531;685.4995853027218;691.865086308165;696.0418814944095;717.9446214065316;4665.836695715634;4680.789364478606;4739.194336962724;4743.1225223333795;4797.850371955329;94870;96211;120150.79849201396;163083;166830;112894;116222;142595.28702356628;145062.82405763923;147558;79896.60051699821;103265;109554.3566846498;111151;111472.4426377863;8846.646134154562;8886.822263554823;9824.36141650819;10107;10390.532426040998;48657.27014094721;63179.670794171034;63788.362116378245;63975.68012159909;65353.67323163354;91213;92984;94866.52566737123;95838;97385;13338.799918001043;13385.799213011618;13689.520866769615;14152.009359344747;14205.147691138565;15276.541703748906;15344.539663810103;15422.614434638775;15423.84576154269;15433.382664693287;14042.2978851055;14080.718385632024;14151.858481415054;14175.645608859448;14756.63108422298;13809.861901380858;14015.421144589456;14219.431222750974;14525.418983240552;14915.701685966003;13958.58124256274;13988.860111399163;14106.647333816327;14334.784978225127;14542.054766440147;10820.18848586375;11382.487788049722;11383.715407114889;11453.370064646191;11572.710682233012;11368.488418021043;11607.6517704469;11632.418379081182;11647.184697071123;11732.94133529327 05:05:59 INFO - PROCESS | 1664 | __end_tp_report 05:05:59 INFO - PROCESS | 1664 | __start_cc_report 05:05:59 INFO - PROCESS | 1664 | _x_x_mozilla_cycle_collect,437 05:05:59 INFO - PROCESS | 1664 | __end_cc_report 05:05:59 INFO - PROCESS | 1664 | __startTimestamp1467979559006__endTimestamp 05:05:59 INFO - PROCESS | 1664 | 05:05:59 INFO - PROCESS | 1664 | ------- Summary: start ------- 05:05:59 INFO - PROCESS | 1664 | Number of tests: 6 05:05:59 INFO - PROCESS | 1664 | 05:05:59 INFO - PROCESS | 1664 | [#0] dojo.html Cycles:165 Average:5697.48 Median:6002.13 stddev:663.03 (11.0%) stddev-sans-first:636.38 05:05:59 INFO - PROCESS | 1664 | Values: 3238.3 3340.4 3347.5 3367.6 3374.8 5715.4 5738.7 5764.4 5775.2 5828.9 4721.3 5581.2 5618.6 5691.7 5791.8 5173.9 5177.5 5226.9 5272.0 5346.4 5249.2 5407.7 5416.8 5436.3 5456.2 5212.3 5220.6 5253.7 5301.1 5306.8 5298.1 5302.4 5307.4 5318.5 5329.2 4983.4 5279.3 5312.3 5312.5 5327.8 4695.7 5509.4 5614.5 5711.5 5758.4 5270.0 5382.5 6238.8 6323.2 6329.0 6144.2 6283.5 6287.9 6291.2 6291.6 4843.3 5780.3 5800.2 5893.0 5908.4 6233.8 6255.0 6257.1 6267.4 6290.7 5386.9 5903.7 6138.1 6218.8 6244.5 5006.7 5782.5 5808.2 6159.2 6169.5 5365.9 6117.3 6169.1 6195.8 6201.5 6229.7 6261.3 6262.3 6280.3 6285.7 4326.7 4793.8 4817.6 4987.2 5000.4 4078.5 4206.7 4406.7 4459.0 4470.2 5473.9 5756.7 6010.3 6070.5 6106.7 5965.1 6195.8 6208.3 6225.4 6233.1 5183.6 6002.1 6003.9 6006.9 6027.8 5333.9 5370.8 5459.9 5472.2 5484.1 6174.3 6294.9 6297.0 6307.1 6309.2 5173.2 6221.2 6254.5 6264.1 6266.8 5035.3 6205.6 6221.9 6265.0 6276.7 6185.8 6239.1 6240.6 6265.5 6267.5 5394.8 6114.4 6185.4 6239.2 6250.9 6060.9 6096.7 6107.1 6115.4 6135.8 6042.8 6123.8 6129.8 6131.1 6138.5 5868.6 5990.6 6053.2 6092.6 6094.6 6018.8 6035.8 6120.4 6195.7 6219.8 6030.5 6036.7 6039.2 6065.4 6080.7 05:05:59 INFO - PROCESS | 1664 | 05:05:59 INFO - PROCESS | 1664 | [#1] ext.html Cycles:180 Average:71398.84 Median:41256.88 stddev:159739.44 (387.2%) stddev-sans-first:160098.82 05:05:59 INFO - PROCESS | 1664 | Values: 484.0 509.5 522.3 525.9 563.7 39194.0 41723.4 41790.6 41816.2 42038.4 42304.8 42448.6 42957.6 43032.0 43080.6 9523.2 9671.7 9727.4 9734.2 9743.5 9550.8 9636.7 9652.3 9654.2 9655.0 9656.3 9659.8 9680.7 9710.3 9732.6 9597.0 9637.0 9639.8 9644.6 9682.8 9528.2 9542.6 9618.4 9642.5 9645.1 39249.0 40096.4 40253.0 40382.8 40791.8 3041.9 3505.8 3773.4 4014.6 4041.2 31395.7 32923.0 33146.0 33208.5 33465.5 3284.2 3284.6 3330.8 3358.0 3399.9 502820.0 504489.0 505217.0 507771.0 508694.0 35199.8 35855.8 63116.0 63360.4 63903.7 35401.5 35722.8 35910.6 35923.8 35940.8 14955.4 15104.7 15113.2 15129.5 15145.5 12738.0 12860.4 12872.9 12875.5 12956.7 7065.7 7741.7 7785.7 7824.3 7831.5 3120.4 3130.6 3132.2 3195.9 3198.9 956.6 978.2 995.5 1001.6 1131.7 30937.4 31274.7 31346.6 31679.0 31725.5 870.8 1089.3 1091.6 1099.7 1117.8 16407.7 16435.8 16458.7 16497.6 16594.1 663745.0 674347.0 677471.0 679878.0 681365.0 61241.0 61558.4 61816.0 61818.0 61926.9 1360.8 1368.5 1415.7 1420.0 1420.3 30762.0 31075.5 31305.0 31365.4 31705.7 42477.7 52974.7 53336.2 53549.9 53671.7 583628.0 596479.0 598474.1 598983.0 601319.0 27548.0 27642.4 27946.4 27958.7 28095.0 41381.6 50004.5 50089.0 51022.5 51031.2 41085.6 41256.2 41257.6 42447.8 42458.4 41453.3 41818.8 42347.6 42765.4 42872.6 33960.2 39131.8 39497.8 39682.2 40470.8 29309.0 31269.3 34671.7 36193.0 36544.5 21775.0 26087.3 26783.9 26836.5 26939.1 05:05:59 INFO - PROCESS | 1664 | 05:05:59 INFO - PROCESS | 1664 | [#2] jquery.html Cycles:180 Average:36490.22 Median:21980.17 stddev:104259.47 (474.3%) stddev-sans-first:104516.68 05:05:59 INFO - PROCESS | 1664 | Values: 374.5 375.6 378.2 391.1 392.6 19347.4 20418.9 21926.7 21933.8 22009.9 11917.4 12276.7 12285.9 12800.9 21128.7 4567.0 5585.9 5617.0 5621.1 5625.4 3940.2 6550.5 6853.3 6875.4 6922.4 5629.3 6022.5 6887.7 6900.7 6919.7 5976.0 6054.3 6056.4 6080.6 6091.6 5810.6 5934.6 5948.5 5971.6 5978.7 24463.9 25180.7 25523.9 25624.7 26127.5 1881.2 1886.9 2152.8 2202.8 2433.8 10085.4 10266.0 10337.9 11417.0 15479.5 1862.7 1876.7 1896.7 1961.5 1968.8 86129.0 127061.0 130420.0 139492.0 139812.3 11335.9 11391.7 11637.0 11707.2 11806.2 14614.5 14647.6 14658.9 14666.8 14667.3 8539.7 8660.9 8662.1 8741.6 8771.8 8572.8 8637.4 8662.1 8741.0 8743.0 4050.3 4103.5 4281.4 4512.0 4567.5 1835.6 1970.7 1977.8 1978.1 1987.3 865.7 907.8 949.0 977.6 1069.6 21201.5 21559.5 21905.5 21910.7 21950.5 773.3 957.5 974.5 1027.0 1055.3 11159.4 11382.0 11556.9 11565.1 11590.7 614485.0 616163.8 627564.0 627671.0 630926.0 110694.9 127670.7 135951.0 136576.0 141049.3 976.9 1044.8 1051.1 1052.8 1054.5 19692.8 19803.3 19983.4 20110.5 20309.0 58313.1 58382.0 59456.0 60153.8 61479.7 88184.1 88381.0 88991.1 89350.7 89827.6 8421.8 8502.2 8506.6 8630.2 8646.8 9363.5 11289.4 13261.3 13377.9 13948.0 10519.2 10930.8 11410.5 11446.8 11892.9 11498.3 11535.9 11662.8 11780.5 11813.5 10776.2 11663.6 11775.4 11883.2 11899.4 8314.4 8324.8 8342.9 8601.8 8625.0 8453.8 10306.8 10688.6 11559.9 11842.9 05:05:59 INFO - PROCESS | 1664 | 05:05:59 INFO - PROCESS | 1664 | [#3] mootools.html Cycles:180 Average:5870.73 Median:4771.69 stddev:3281.44 (68.8%) stddev-sans-first:3274.59 05:05:59 INFO - PROCESS | 1664 | Values: 1551.3 1569.6 1811.8 1899.3 1914.1 8218.3 8707.2 8708.6 9144.0 9172.5 8815.9 8868.9 9002.4 9005.9 9017.2 2344.0 2373.6 2378.2 2378.8 2383.5 2345.6 2363.0 2392.9 2401.2 2404.9 1982.3 2358.4 2378.3 2385.5 2405.2 2350.1 2356.9 2360.9 2375.5 2376.8 2326.9 2337.7 2345.3 2352.8 2354.2 9060.6 9117.3 9142.8 9153.5 9170.6 5285.6 5414.4 5425.3 5428.4 5485.6 3290.7 3299.0 3620.5 3680.0 3700.7 1068.1 1077.1 1077.9 1101.0 1103.8 9181.5 11574.2 12045.9 12060.0 12072.2 4727.3 4770.6 4772.8 4831.2 4906.3 9970.0 10133.4 10203.0 10235.3 10285.6 5344.6 5411.3 5433.5 5442.9 5446.8 4411.1 4808.6 4954.6 4967.9 4978.8 3946.0 4004.0 4035.6 4080.8 4116.2 1241.3 1284.1 1299.8 1307.0 1308.3 835.8 898.6 942.2 971.2 1006.3 6167.6 6206.6 6220.8 6238.5 6258.8 989.1 994.0 1021.9 1025.3 1034.0 4207.7 4242.3 4361.9 4423.8 4437.2 10895.0 10948.2 11159.4 11196.9 11212.5 11126.0 11134.1 11151.5 11153.1 11178.4 7988.1 8307.8 8389.1 8510.2 8537.6 5194.3 6153.9 6195.3 6276.3 6317.6 10269.2 10291.8 10417.6 10429.6 10434.8 10124.6 10142.4 10413.1 10460.9 10465.9 7099.5 7547.7 7689.5 7754.4 7826.6 8489.1 8676.2 8685.7 8720.5 8728.0 7622.1 7772.9 7838.9 7881.9 7884.6 7488.4 7495.0 7547.2 7682.0 7690.1 7152.4 7218.0 7220.4 7230.6 7238.4 5072.2 5190.5 5231.8 5263.6 5308.1 4732.9 5216.2 5266.2 5374.7 5421.8 05:05:59 INFO - PROCESS | 1664 | 05:05:59 INFO - PROCESS | 1664 | [#4] prototype.html Cycles:180 Average:4812.49 Median:5371.40 stddev:1494.70 (27.8%) stddev-sans-first:1460.22 05:05:59 INFO - PROCESS | 1664 | Values: 311.7 318.1 320.5 321.0 325.2 4574.7 5376.0 5542.5 5614.3 5825.7 5213.5 5780.7 5795.4 5811.2 5811.5 4139.7 4235.9 4326.5 4346.9 4353.6 4254.3 4318.5 4329.7 4348.5 4354.8 4266.7 4309.1 4333.5 4339.1 4353.0 4192.9 4247.8 4342.6 4346.4 4367.4 3219.1 3721.5 3723.4 3737.8 3743.5 4673.3 5576.7 5592.2 5608.4 5698.4 4628.7 4723.5 4879.9 4913.8 5026.5 5131.5 5887.2 6004.0 6021.1 6062.6 4025.6 4039.7 4074.3 4075.5 4085.8 5283.5 5901.8 6193.5 6322.5 6336.8 3258.8 4029.9 4081.4 4103.4 4121.6 3229.6 3833.3 4161.6 4183.7 4192.7 3948.8 4779.5 4808.6 4880.2 4899.0 5260.5 6036.9 6052.3 6074.5 6084.5 1394.3 1407.7 1410.7 1414.9 1424.5 864.6 875.1 877.4 918.9 950.8 5226.5 5260.9 5548.6 5622.0 5624.4 4703.7 5577.2 6016.5 6106.9 6182.2 4784.6 4890.0 5366.8 5611.4 5662.8 3217.5 3228.6 3256.4 3264.2 3266.9 5859.9 6333.3 6347.3 6391.5 6419.8 5579.4 6043.4 6235.3 6259.8 6311.7 5501.6 6212.9 6291.8 6378.8 6386.2 5466.7 5694.9 5930.7 6070.7 6140.4 5199.6 5903.4 6070.9 6102.7 6122.4 5489.1 5891.9 6090.6 6204.9 6260.7 3368.3 3536.0 3703.9 3836.6 4047.6 4673.5 6123.4 6152.0 6178.8 6210.4 4975.3 5306.5 5668.8 6076.1 6118.3 5846.5 6137.5 6138.3 6168.6 6185.5 4877.1 5357.9 5596.7 6012.6 6019.8 5668.8 5973.8 6045.9 6057.9 6067.4 4861.8 4948.1 5327.4 5899.0 5950.3 05:05:59 INFO - PROCESS | 1664 | 05:05:59 INFO - PROCESS | 1664 | [#5] yui.html Cycles:180 Average:24619.71 Median:3676.73 stddev:38959.26 (1059.6%) stddev-sans-first:39026.97 05:05:59 INFO - PROCESS | 1664 | Values: 646.6 735.3 801.3 828.7 838.6 16056.8 16106.2 16367.8 16468.5 16496.4 13554.9 13650.6 13674.2 13698.9 13714.0 686.5 872.9 882.2 894.9 895.6 742.5 890.3 892.4 902.8 903.3 937.7 954.4 957.3 958.5 960.0 919.4 929.9 945.2 947.0 951.9 681.0 708.8 709.4 710.5 711.1 15209.5 15344.8 15368.9 15601.0 15604.5 13832.8 13999.1 14009.6 14137.2 14158.3 11129.4 11157.6 11177.5 11207.4 11480.3 3899.3 3913.4 3943.8 3954.0 4085.1 111801.4 120552.2 120762.0 121262.8 121608.2 9048.2 10488.7 10938.7 10986.3 12053.5 17117.1 21457.0 21631.4 21859.5 21882.6 7295.9 7560.8 8031.6 8053.2 8148.5 3765.7 3901.6 4615.9 4640.0 4716.6 3346.3 3670.9 3674.7 3678.8 3683.7 666.2 676.7 678.3 680.4 690.9 511.0 530.5 705.4 709.4 717.0 8622.7 9174.9 9571.8 9907.0 9974.2 671.8 685.5 691.9 696.0 717.9 4665.8 4680.8 4739.2 4743.1 4797.9 94870.0 96211.0 120150.8 163083.0 166830.0 112894.0 116222.0 142595.3 145062.8 147558.0 79896.6 103265.0 109554.4 111151.0 111472.4 8846.6 8886.8 9824.4 10107.0 10390.5 48657.3 63179.7 63788.4 63975.7 65353.7 91213.0 92984.0 94866.5 95838.0 97385.0 13338.8 13385.8 13689.5 14152.0 14205.1 15276.5 15344.5 15422.6 15423.8 15433.4 14042.3 14080.7 14151.9 14175.6 14756.6 13809.9 14015.4 14219.4 14525.4 14915.7 13958.6 13988.9 14106.6 14334.8 14542.1 10820.2 11382.5 11383.7 11453.4 11572.7 11368.5 11607.7 11632.4 11647.2 11732.9 05:05:59 INFO - PROCESS | 1664 | -------- Summary: end -------- 05:05:59 INFO - PROCESS | 1664 | 05:05:59 INFO - TEST-INFO | 1664: exit 0 05:05:59 INFO - TEST-OK | dromaeo_css | took 1113127ms 05:05:59 INFO - TEST-START | kraken 05:05:59 INFO - operating with platform_type : mac_ 05:05:59 INFO - Initialising browser for kraken test... 05:05:59 INFO - TEST-INFO | started process 1672 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/tmplXXX9O/profile http://localhost:49273/getInfo.html) 05:06:02 INFO - PROCESS | 1672 | __metrics Screen width/height:1600/1200 05:06:02 INFO - PROCESS | 1672 | colorDepth:24 05:06:02 INFO - PROCESS | 1672 | Browser inner width/height: 1024/689 05:06:02 INFO - PROCESS | 1672 | __metrics 05:06:02 ERROR - PROCESS | 1672 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2957: TypeError: this.tabs is undefined 05:06:03 INFO - TEST-INFO | 1672: exit 0 05:06:03 INFO - Browser initialized. 05:06:03 INFO - Running cycle 1/1 for kraken test... 05:06:03 INFO - TEST-INFO | started process 1674 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/tmplXXX9O/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:06:15 INFO - PROCESS | 1674 | RSS: Main: 254263296 05:06:15 INFO - PROCESS | 1674 | 05:06:17 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-beat-detection) 05:06:18 INFO - PROCESS | 1674 | RSS: Main: 267083776 05:06:18 INFO - PROCESS | 1674 | 05:06:21 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-dft) 05:06:22 INFO - PROCESS | 1674 | RSS: Main: 271142912 05:06:22 INFO - PROCESS | 1674 | 05:06:25 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-fft) 05:06:26 INFO - PROCESS | 1674 | RSS: Main: 271540224 05:06:26 INFO - PROCESS | 1674 | 05:06:28 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-oscillator) 05:06:28 INFO - PROCESS | 1674 | RSS: Main: 272429056 05:06:28 INFO - PROCESS | 1674 | 05:06:30 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49273/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:06:31 INFO - PROCESS | 1674 | RSS: Main: 273133568 05:06:31 INFO - PROCESS | 1674 | 05:06:34 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49273/tests/kraken/driver.html?testName=imaging-darkroom) 05:06:34 INFO - PROCESS | 1674 | RSS: Main: 273850368 05:06:34 INFO - PROCESS | 1674 | 05:06:37 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49273/tests/kraken/driver.html?testName=imaging-desaturate) 05:06:38 INFO - PROCESS | 1674 | RSS: Main: 274010112 05:06:38 INFO - PROCESS | 1674 | 05:06:41 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49273/tests/kraken/driver.html?testName=json-parse-financial) 05:06:41 INFO - PROCESS | 1674 | RSS: Main: 274382848 05:06:41 INFO - PROCESS | 1674 | 05:06:43 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49273/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:06:44 INFO - PROCESS | 1674 | RSS: Main: 273948672 05:06:44 INFO - PROCESS | 1674 | 05:06:46 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:06:46 INFO - PROCESS | 1674 | RSS: Main: 273645568 05:06:46 INFO - PROCESS | 1674 | 05:06:48 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:06:49 INFO - PROCESS | 1674 | RSS: Main: 273653760 05:06:49 INFO - PROCESS | 1674 | 05:06:52 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:06:53 INFO - PROCESS | 1674 | RSS: Main: 273817600 05:06:53 INFO - PROCESS | 1674 | 05:06:56 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:06:57 INFO - PROCESS | 1674 | RSS: Main: 274280448 05:06:57 INFO - PROCESS | 1674 | 05:06:58 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49273/tests/kraken/driver.html?testName=ai-astar) 05:06:59 INFO - PROCESS | 1674 | RSS: Main: 275005440 05:06:59 INFO - PROCESS | 1674 | 05:06:59 INFO - PROCESS | 1674 | __start_tp_report 05:06:59 INFO - PROCESS | 1674 | _x_x_mozilla_page_load 05:06:59 INFO - PROCESS | 1674 | _x_x_mozilla_page_load_details 05:06:59 INFO - PROCESS | 1674 | |i|pagename|runs| 05:06:59 INFO - PROCESS | 1674 | |0;ai-astar;103;117;108;115;131;116;115;113;116;116 05:06:59 INFO - PROCESS | 1674 | |1;audio-beat-detection;149;142;134;150;107;121;142;140;199;140 05:06:59 INFO - PROCESS | 1674 | |2;audio-dft;279;230;203;228;228;199;191;246;225;283 05:06:59 INFO - PROCESS | 1674 | |3;audio-fft;69;82;75;141;60;59;59;64;136;59 05:06:59 INFO - PROCESS | 1674 | |4;audio-oscillator;71;70;143;70;72;88;112;68;72;115 05:06:59 INFO - PROCESS | 1674 | |5;imaging-gaussian-blur;91;90;91;90;93;89;94;90;95;128 05:06:59 INFO - PROCESS | 1674 | |6;imaging-darkroom;110;146;96;103;97;97;96;147;96;101 05:06:59 INFO - PROCESS | 1674 | |7;imaging-desaturate;89;92;90;90;95;89;89;91;91;90 05:06:59 INFO - PROCESS | 1674 | |8;json-parse-financial;57;60;58;67;88;89;88;58;56;56 05:06:59 INFO - PROCESS | 1674 | |9;json-stringify-tinderbox;67;69;78;71;68;78;74;69;71;71 05:06:59 INFO - PROCESS | 1674 | |10;stanford-crypto-aes;90;84;88;71;96;77;102;109;104;107 05:06:59 INFO - PROCESS | 1674 | |11;stanford-crypto-ccm;138;137;186;144;143;153;171;163;197;147 05:06:59 INFO - PROCESS | 1674 | |12;stanford-crypto-pbkdf2;186;187;189;191;184;187;186;188;194;262 05:06:59 INFO - PROCESS | 1674 | |13;stanford-crypto-sha256-iterative;72;71;69;69;69;70;68;69;72;70 05:06:59 INFO - PROCESS | 1674 | __end_tp_report 05:06:59 INFO - PROCESS | 1674 | __start_cc_report 05:06:59 INFO - PROCESS | 1674 | _x_x_mozilla_cycle_collect,1107 05:06:59 INFO - PROCESS | 1674 | __end_cc_report 05:06:59 INFO - PROCESS | 1674 | __startTimestamp1467979619005__endTimestamp 05:06:59 INFO - PROCESS | 1674 | 05:06:59 INFO - PROCESS | 1674 | ------- Summary: start ------- 05:06:59 INFO - PROCESS | 1674 | Number of tests: 14 05:06:59 INFO - PROCESS | 1674 | 05:06:59 INFO - PROCESS | 1674 | [#0] ai-astar Cycles:10 Average:115.00 Median:116.00 stddev:7.15 (6.2%) stddev-sans-first:6.12 05:06:59 INFO - PROCESS | 1674 | Values: 103.0 117.0 108.0 115.0 131.0 116.0 115.0 113.0 116.0 116.0 05:06:59 INFO - PROCESS | 1674 | 05:06:59 INFO - PROCESS | 1674 | [#1] audio-beat-detection Cycles:10 Average:142.40 Median:142.00 stddev:23.80 (16.8%) stddev-sans-first:25.12 05:06:59 INFO - PROCESS | 1674 | Values: 149.0 142.0 134.0 150.0 107.0 121.0 142.0 140.0 199.0 140.0 05:06:59 INFO - PROCESS | 1674 | 05:06:59 INFO - PROCESS | 1674 | [#2] audio-dft Cycles:10 Average:231.20 Median:229.00 stddev:31.08 (13.6%) stddev-sans-first:27.74 05:06:59 INFO - PROCESS | 1674 | Values: 279.0 230.0 203.0 228.0 228.0 199.0 191.0 246.0 225.0 283.0 05:06:59 INFO - PROCESS | 1674 | 05:06:59 INFO - PROCESS | 1674 | [#3] audio-fft Cycles:10 Average:80.40 Median:62.00 stddev:31.60 (51.0%) stddev-sans-first:33.24 05:06:59 INFO - PROCESS | 1674 | Values: 69.0 82.0 75.0 141.0 60.0 59.0 59.0 64.0 136.0 59.0 05:06:59 INFO - PROCESS | 1674 | 05:06:59 INFO - PROCESS | 1674 | [#4] audio-oscillator Cycles:10 Average:88.10 Median:70.50 stddev:26.20 (37.2%) stddev-sans-first:27.05 05:06:59 INFO - PROCESS | 1674 | Values: 71.0 70.0 143.0 70.0 72.0 88.0 112.0 68.0 72.0 115.0 05:06:59 INFO - PROCESS | 1674 | 05:06:59 INFO - PROCESS | 1674 | [#5] imaging-gaussian-blur Cycles:10 Average:95.10 Median:91.00 stddev:11.72 (12.9%) stddev-sans-first:12.34 05:06:59 INFO - PROCESS | 1674 | Values: 91.0 90.0 91.0 90.0 93.0 89.0 94.0 90.0 95.0 128.0 05:06:59 INFO - PROCESS | 1674 | 05:06:59 INFO - PROCESS | 1674 | [#6] imaging-darkroom Cycles:10 Average:108.90 Median:96.00 stddev:20.30 (21.1%) stddev-sans-first:21.53 05:06:59 INFO - PROCESS | 1674 | Values: 110.0 146.0 96.0 103.0 97.0 97.0 96.0 147.0 96.0 101.0 05:06:59 INFO - PROCESS | 1674 | 05:06:59 INFO - PROCESS | 1674 | [#7] imaging-desaturate Cycles:10 Average:90.60 Median:90.50 stddev:1.84 (2.0%) stddev-sans-first:1.86 05:06:59 INFO - PROCESS | 1674 | Values: 89.0 92.0 90.0 90.0 95.0 89.0 89.0 91.0 91.0 90.0 05:06:59 INFO - PROCESS | 1674 | 05:06:59 INFO - PROCESS | 1674 | [#8] json-parse-financial Cycles:10 Average:67.70 Median:63.50 stddev:14.58 (23.0%) stddev-sans-first:14.95 05:06:59 INFO - PROCESS | 1674 | Values: 57.0 60.0 58.0 67.0 88.0 89.0 88.0 58.0 56.0 56.0 05:06:59 INFO - PROCESS | 1674 | 05:06:59 INFO - PROCESS | 1674 | [#9] json-stringify-tinderbox Cycles:10 Average:71.60 Median:71.00 stddev:3.89 (5.5%) stddev-sans-first:3.76 05:06:59 INFO - PROCESS | 1674 | Values: 67.0 69.0 78.0 71.0 68.0 78.0 74.0 69.0 71.0 71.0 05:06:59 INFO - PROCESS | 1674 | 05:06:59 INFO - PROCESS | 1674 | [#10] stanford-crypto-aes Cycles:10 Average:92.80 Median:80.50 stddev:12.99 (16.1%) stddev-sans-first:13.73 05:06:59 INFO - PROCESS | 1674 | Values: 90.0 84.0 88.0 71.0 96.0 77.0 102.0 109.0 104.0 107.0 05:06:59 INFO - PROCESS | 1674 | 05:06:59 INFO - PROCESS | 1674 | [#11] stanford-crypto-ccm Cycles:10 Average:157.90 Median:158.00 stddev:20.84 (13.2%) stddev-sans-first:20.82 05:06:59 INFO - PROCESS | 1674 | Values: 138.0 137.0 186.0 144.0 143.0 153.0 171.0 163.0 197.0 147.0 05:06:59 INFO - PROCESS | 1674 | 05:06:59 INFO - PROCESS | 1674 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:195.40 Median:188.50 stddev:23.57 (12.5%) stddev-sans-first:24.75 05:06:59 INFO - PROCESS | 1674 | Values: 186.0 187.0 189.0 191.0 184.0 187.0 186.0 188.0 194.0 262.0 05:06:59 INFO - PROCESS | 1674 | 05:06:59 INFO - PROCESS | 1674 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.90 Median:70.00 stddev:1.37 (2.0%) stddev-sans-first:1.22 05:06:59 INFO - PROCESS | 1674 | Values: 72.0 71.0 69.0 69.0 69.0 70.0 68.0 69.0 72.0 70.0 05:06:59 INFO - PROCESS | 1674 | -------- Summary: end -------- 05:06:59 INFO - PROCESS | 1674 | 05:06:59 INFO - TEST-INFO | 1674: exit 0 05:06:59 INFO - TEST-OK | kraken | took 60315ms 05:06:59 INFO - SUITE-END | took 1173s 05:07:00 INFO - Completed test suite (00:19:33) 05:07:00 INFO - javascript benchmark 05:07:00 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7453.4138987876595, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3238.2713889374895, 3340.4154273002227, 3347.548081009063, 3367.5958884933802, 3374.8481318340673, 5715.371309155989, 5738.741756620957, 5764.365919748824, 5775.249217601717, 5828.883422331551, 4721.3390125382475, 5581.246531718217, 5618.634788738739, 5691.658500489973, 5791.768329266824, 5173.896522069575, 5177.48225177483, 5226.947730522703, 5272.024675435037, 5346.385165705935, 5249.186376111708, 5407.702576358299, 5416.783328666848, 5436.3476382834115, 5456.154296084113, 5212.27028216052, 5220.6084543659, 5253.658512196695, 5301.125314323132, 5306.7611957462, 5298.125809241471, 5302.44324345942, 5307.3896501902, 5318.494742999409, 5329.2006199070065, 4983.426905905795, 5279.313689220377, 5312.3093997780425, 5312.548433383167, 5327.760250788724, 4695.718256904563, 5509.393966663663, 5614.466625670555, 5711.457411545896, 5758.395368486291, 5270.0, 5382.461753824626, 6238.844028899269, 6323.20959880015, 6328.968355158241, 6144.218176728743, 6283.497320214372, 6287.937120628781, 6291.182146320994, 6291.559590828644, 4843.2735089736825, 5780.3063632363965, 5800.187973683687, 5893.0, 5908.438698323653, 6233.781817636361, 6255.0, 6257.09272155544, 6267.373262673787, 6290.748370065237, 5386.892262154735, 5903.7048147593305, 6138.14066030756, 6218.751249950042, 6244.500439964792, 5006.74966251686, 5782.479576838105, 5808.157817116495, 6159.19930409044, 6169.475594574512, 5365.865853353619, 6117.327094019654, 6169.136320915076, 6195.752169913243, 6201.472874805692, 6229.657368844666, 6261.311255761862, 6262.279837818618, 6280.2777680566405, 6285.685715714288, 4326.65386769064, 4793.849476125774, 4817.566419022235, 4987.152184128707, 5000.449950505442, 4078.490188726409, 4206.695924263488, 4406.669499787528, 4459.0, 4470.240059189946, 5473.863153421196, 5756.683382413924, 6010.338862725097, 6070.484008859208, 6106.72519736613, 5965.094556389144, 6195.791820595031, 6208.286047104551, 6225.439710426083, 6233.065040243909, 5183.637145399785, 6002.129691194752, 6003.909941350883, 6006.939930600638, 6027.849303767441, 5333.893322133536, 5370.838874833761, 5459.945400545944, 5472.2338872557875, 5484.067708489566, 6174.25908890936, 6294.874102518015, 6296.968515157487, 6307.117003619405, 6309.242890853127, 5173.22401639757, 6221.151117108422, 6254.530910181846, 6264.060390941395, 6266.780662676784, 5035.345405097314, 6205.627662340274, 6221.875562488634, 6264.997600384099, 6276.686165691788, 6185.84535386619, 6239.126522286792, 6240.625562466266, 6265.530085243716, 6267.529935254783, 5394.811181608625, 6114.38856114385, 6185.41238582334, 6239.220097487814, 6250.937490625036, 6060.878782424415, 6096.725647345791, 6107.097787096225, 6115.388461153849, 6135.753292002456, 6042.75828966854, 6123.84690382744, 6129.832282918493, 6131.101423540838, 6138.478229350555, 5868.589198756046, 5990.640561566146, 6053.152558641882, 6092.634441933498, 6094.634321940698, 6018.789342372996, 6035.849103772441, 6120.357362476876, 6195.721192546256, 6219.782307619212, 6030.48740857032, 6036.69816509164, 6039.214902062704, 6065.3934606539, 6080.665563394055], "value": 5657.400011598394, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [483.95402436768507, 509.5439581574491, 522.2896860270034, 525.8667571383668, 563.7237753500785, 39194.0, 41723.37414938771, 41790.58209417909, 41816.16367672645, 42038.36942445866, 42304.788476057576, 42448.57551424485, 42957.57042429575, 43032.0, 43080.569194308046, 9523.238140948708, 9671.661491847786, 9727.36772109814, 9734.221262299, 9743.464109473976, 9550.761230969212, 9636.662716804913, 9652.324337296392, 9654.17939475142, 9655.03449655036, 9656.324057315991, 9659.80680386392, 9680.661176858812, 9710.320277580573, 9732.562034708455, 9596.95201523995, 9636.988116247834, 9639.759006024835, 9644.565994530298, 9682.75793105171, 9528.190103841182, 9542.618295268181, 9618.422894626276, 9642.517874106266, 9645.131938125602, 39249.01877453058, 40096.39855402171, 40253.0, 40382.79808600938, 40791.7960410199, 3041.8935337263088, 3505.8247087645514, 3773.3962565989586, 4014.5532518973364, 4041.191761647682, 31395.686043139503, 32923.0, 33146.0, 33208.501872471934, 33465.49801752975, 3284.178955261185, 3284.6058472983154, 3330.81680507572, 3358.0429577570276, 3399.8640054398043, 502820.0, 504489.0, 505217.0, 507771.0, 508694.0, 35199.82400088034, 35855.82072089623, 63116.0, 63360.36639633545, 63903.72192556123, 35401.46897796535, 35722.821385893425, 35910.640893591255, 35923.82038089793, 35940.82029589835, 14955.40178392852, 15104.697906042038, 15113.16877571722, 15129.47046853355, 15145.545633631009, 12738.0, 12860.421281042189, 12872.935635321763, 12875.54935577269, 12956.67608309781, 7065.717371305091, 7741.651625676858, 7785.688572457151, 7824.295813376823, 7831.530108193527, 3120.438321102223, 3130.577372054789, 3132.2326030122767, 3195.888143914998, 3198.856051477689, 956.5982287439292, 978.2369751593768, 995.4773743784426, 1001.639409812467, 1131.675939151195, 30937.44219414796, 31274.68725312763, 31346.589403476897, 31679.0, 31725.524117138262, 870.7910101575576, 1089.2865173311493, 1091.5579190427889, 1099.6755956992706, 1117.8211486162174, 16407.671846563, 16435.753463698053, 16458.670826583402, 16497.587560311087, 16594.090511413404, 663745.0, 674347.0, 677471.0, 679878.0, 681365.0, 61241.0, 61558.38441615526, 61816.0, 61818.0, 61926.90365481708, 1360.843502997168, 1368.5004973184716, 1415.7380884536394, 1420.0343766239057, 1420.3040510149951, 30762.0, 31075.53386699156, 31305.0, 31365.372692545567, 31705.68294317027, 42477.72566823, 52974.73512632412, 53336.1999569999, 53549.92900142053, 53671.73164134155, 583628.0, 596479.0, 598474.0762961921, 598983.0, 601319.0, 27548.0, 27642.44715105727, 27946.44107117887, 27958.72041279561, 28095.016674416296, 41381.58618413777, 50004.49995500144, 50088.99822003613, 51022.48977510177, 51031.2345314828, 41085.58914410818, 41256.174876502904, 41257.58742412538, 42447.787761060994, 42458.363124553776, 41453.29028610508, 41818.790906046495, 42347.57652423436, 42765.35851962161, 42872.571274286856, 33960.15099622431, 39131.80434097811, 39497.80251098726, 39682.20635587214, 40470.79764601158, 29309.025120033366, 31269.292720753932, 34671.65328346684, 36193.0, 36544.45183322306, 21775.0, 26087.347816304744, 26783.928642854848, 26836.46327073487, 26939.05713300025], "value": 19114.219819606602, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [374.4832131658313, 375.63375708684026, 378.2095420571007, 391.1472988884231, 392.59170462718777, 19347.419577412682, 20418.89790551045, 21926.671099933494, 21933.780662193414, 22009.889950550245, 11917.404129793518, 12276.693082672915, 12285.938570307158, 12800.935995320011, 21128.683069753926, 4566.977165114178, 5585.8603534911545, 5617.0, 5621.128725047624, 5625.38120806711, 3940.2119576084756, 6550.475961923058, 6853.252420632756, 6875.381215690587, 6922.376986071253, 5629.268195134648, 6022.518198544106, 6887.7244910203535, 6900.723971041152, 6919.65401729914, 5976.0, 6054.303755068157, 6056.364081771395, 6080.635161890279, 6091.604045737035, 5810.5932584719085, 5934.614250073774, 5948.524118070544, 5971.611845230046, 5978.730957106941, 24463.877680611662, 25180.748192518022, 25523.87238063798, 25624.743752562423, 26127.477450451075, 1881.2380985700813, 1886.8678792724393, 2152.7954844289766, 2202.757696653367, 2433.7931275841574, 10085.445300508469, 10266.0, 10337.89662103377, 11416.972472477517, 15479.5356139316, 1862.655408749372, 1876.6622008038548, 1896.6586014517381, 1961.460598335455, 1968.8228059474716, 86129.0, 127061.0, 130420.0, 139492.0, 139812.30093849465, 11335.886641133648, 11391.715207119723, 11637.010854077329, 11707.180497365272, 11806.173567850168, 14614.488492902698, 14647.633809154857, 14658.853411465749, 14666.779998300033, 14667.339969701388, 8539.658413663508, 8660.8700869487, 8662.090480499583, 8741.606627701769, 8771.780705482286, 8572.828543429096, 8637.438566493158, 8662.133786621287, 8740.99478559961, 8742.956285218534, 4050.25070361984, 4103.466549348565, 4281.400603915392, 4512.0, 4567.497575266718, 1835.5941751541848, 1970.6649869522216, 1977.8318842898516, 1978.0801927103678, 1987.3044434447827, 865.6840253307497, 907.8138981508907, 949.0035462764071, 977.63827383867, 1069.5935544493043, 21201.515893887587, 21559.46101347479, 21905.452363691034, 21910.671339929915, 21950.45123871884, 773.2692605487761, 957.5068839547639, 974.4835237324229, 1026.9717308316165, 1055.2771351624162, 11159.38623375722, 11382.0, 11556.88443115558, 11565.132615053904, 11590.652280431601, 614485.0, 616163.8383616107, 627564.0, 627671.0, 630926.0, 110694.89305107007, 127670.72329276588, 135951.0, 136576.0, 141049.29475352558, 976.8632391465201, 1044.8328267477318, 1051.1013083813382, 1052.8052310322614, 1054.504382940017, 19692.80307196967, 19803.306884258982, 19983.400497985083, 20110.49723756918, 20309.0, 58313.12530311964, 58382.0, 59455.99999999827, 60153.7969240604, 61479.692601536706, 88184.1181588176, 88381.0, 88991.11008890087, 89350.65974010526, 89827.55086224528, 8421.831563368576, 8502.192291732275, 8506.61720222579, 8630.223279904838, 8646.78383040429, 9363.485008324607, 11289.37908415045, 13261.336933153496, 13377.933110334387, 13947.953903457485, 10519.158467322442, 10930.781384372427, 11410.543578256777, 11446.82829757571, 11892.940535297268, 11498.25261358009, 11535.884641153816, 11662.825057624312, 11780.469878855301, 11813.527458901548, 10776.191785615953, 11663.59177428786, 11775.352355620524, 11883.227590206609, 11899.405029748652, 8314.376421768271, 8324.83350333002, 8342.874856877273, 8601.827963440572, 8625.0, 8453.830923381622, 10306.793864122825, 10688.625898093529, 11559.884401155881, 11842.881571184178], "value": 9751.714012972798, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1551.309667198097, 1569.5997520632236, 1811.7554130192427, 1899.2687815191157, 1914.148204049197, 8218.342532597393, 8707.172818582225, 8708.60811263493, 9143.99999999999, 9172.54137293136, 8815.911840881605, 8868.91131088689, 9002.414843035198, 9005.909940900605, 9017.233535149504, 2343.964840527398, 2373.5727569037567, 2378.1795280628157, 2378.8334816562847, 2383.511380167062, 2345.6129738593113, 2363.019346971005, 2392.9042838286446, 2401.2076014915124, 2404.927852164429, 1982.3061928325114, 2358.41039740065, 2378.2627385510546, 2385.487120269142, 2405.1581946318825, 2350.071721669931, 2356.905723771056, 2360.8701521416315, 2375.489269806991, 2376.809855211579, 2326.8720220387872, 2337.7311609164994, 2345.319857241398, 2352.847064940773, 2354.176038386568, 9060.637574497012, 9117.270618350516, 9142.77143071422, 9153.496557689325, 9170.587323570455, 5285.603579731535, 5414.43148469409, 5425.267588875491, 5428.4028756836715, 5485.6434331768305, 3290.700173431505, 3298.96701032989, 3620.5474315710535, 3680.0063982724514, 3700.685441737429, 1068.1401471815186, 1077.084478193537, 1077.9191560632985, 1100.9760922342218, 1103.784761971416, 9181.540922953893, 11574.247673901169, 12045.939770301093, 12060.035197184205, 12072.154949153475, 4727.338172655762, 4770.61835053195, 4772.75547943504, 4831.154547954094, 4906.31311616374, 9969.950150249348, 10133.391996480235, 10203.0, 10235.283530152967, 10285.588576456857, 5344.625876188629, 5411.269478620415, 5433.456654334614, 5442.863928401743, 5446.754896029688, 4411.09572537629, 4808.567228949341, 4954.578860796801, 4967.875803104951, 4978.8257410990445, 3945.9802700986884, 4003.979980100081, 4035.5762644922447, 4080.775557344315, 4116.156187981456, 1241.273854794955, 1284.062634276983, 1299.811527328532, 1306.9607911762662, 1308.3327502973552, 835.8202986357962, 898.6046139698511, 942.1991307388665, 971.1939090554822, 1006.285537268533, 6167.599106058092, 6206.596571222856, 6220.844478888064, 6238.532110091761, 6258.843528911722, 989.1246247071393, 993.9503024848729, 1021.9131373833308, 1025.3489034463169, 1033.963811266602, 4207.705460617727, 4242.300020496584, 4361.869143925687, 4423.823047078081, 4437.201303765353, 10895.0, 10948.233623646427, 11159.442027898573, 11196.94401527987, 11212.495437705324, 11126.0, 11134.10927125828, 11151.498182581803, 11153.10775137987, 11178.385188814693, 7988.121306656263, 8307.750767476864, 8389.119142490195, 8510.234078932926, 8537.573121343908, 5194.3247377840635, 6153.938460615336, 6195.256569211723, 6276.340984196594, 6317.6209427434505, 10269.229807764297, 10291.84562231552, 10417.635382761568, 10429.58281668755, 10434.843477347695, 10124.645637402655, 10142.442165680959, 10413.11488523484, 10460.895391046297, 10465.9476702616, 7099.503034787515, 7547.73582924595, 7689.461737678309, 7754.418418618739, 7826.5695386751995, 8489.108643592333, 8676.219140277406, 8685.696000639948, 8720.520371379635, 8728.0, 7622.085349758065, 7772.92227077722, 7838.9216107840475, 7881.881771773314, 7884.605769711607, 7488.438367122379, 7495.025646665898, 7547.245275472409, 7682.0, 7690.115636701851, 7152.392046676091, 7218.0, 7220.350168484862, 7230.6384680766805, 7238.420926325986, 5072.163093089599, 5190.455002224712, 5231.843044708665, 5263.552598029058, 5308.124159513637, 4732.881677957941, 5216.191490319006, 5266.183741520071, 5374.731263436891, 5421.83734487966], "value": 4719.088824663669, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [311.7381399624316, 318.1394328341834, 320.4552261156035, 320.971112599866, 325.23407375630404, 4574.748388838612, 5375.973120134398, 5542.528885044776, 5614.29821272341, 5825.65046097234, 5213.504717051884, 5780.710964451771, 5795.449432303924, 5811.244538210027, 5811.476967072963, 4139.6959957613335, 4235.8729238122905, 4326.502452217988, 4346.913061738779, 4353.586409291112, 4254.319308910575, 4318.546552611978, 4329.696921215516, 4348.478182618091, 4354.847580334689, 4266.679999000072, 4309.0735491869245, 4333.464923020037, 4339.088791353819, 4352.996432461608, 4192.853250136246, 4247.8300867965245, 4342.610364683303, 4346.413234213404, 4367.3667318238995, 3219.116816662232, 3721.5348081489815, 3723.3670276053135, 3737.794421306827, 3743.4571987061995, 4673.275642275453, 5576.693281869496, 5592.161175823619, 5608.355039170507, 5698.430156984268, 4628.745419001953, 4723.4884836852225, 4879.902401951941, 4913.803447862081, 5026.497350264981, 5131.461196574381, 5887.175795388649, 6003.969980150071, 6021.066734656135, 6062.575619706622, 4025.6175663311938, 4039.6970227233073, 4074.348104303327, 4075.470188875427, 4085.7957102144774, 5283.524482796528, 5901.7934372297195, 6193.473554747807, 6322.4942004639515, 6336.778212762577, 3258.7718859680067, 4029.851492324732, 4081.4490043843703, 4103.4460347852655, 4121.62905338521, 3229.564008858774, 3833.271678381099, 4161.646260067928, 4183.686223533186, 4192.673066448089, 3948.782816945038, 4779.498152693986, 4808.63935204861, 4880.170371036932, 4899.0, 5260.500252476008, 6036.939630603725, 6052.273727152682, 6074.54440916933, 6084.505352805329, 1394.316784775473, 1407.7325308191412, 1410.6684929041667, 1414.9363278652486, 1424.5370254667275, 864.576357584779, 875.0811647769816, 877.3858299190592, 918.875951746519, 950.7860731335394, 5226.529612334832, 5260.948649783117, 5548.5838562108, 5621.988042152452, 5624.437556244343, 4703.670743047954, 5577.2191893135, 6016.518678505797, 6106.938930610726, 6182.196314479179, 4784.569388755029, 4890.0, 5366.819299754048, 5611.354694210137, 5662.773489060474, 3217.51737239416, 3228.5641438405983, 3256.446404111307, 3264.2329052672603, 3266.852991615383, 5859.882802343929, 6333.271673757485, 6347.301796802348, 6391.497997970473, 6419.775307864295, 5579.358373786985, 6043.373975614596, 6235.256487145642, 6259.838781415356, 6311.715972781236, 5501.614886957875, 6212.937870621417, 6291.842703932347, 6378.77674281398, 6386.233651961795, 5466.71532189943, 5694.886102278014, 5930.703464826655, 6070.726817293321, 6140.385961403824, 5199.634166454179, 5903.380145084704, 6070.939290607214, 6102.725377358119, 6122.387761223842, 5489.149181876815, 5891.852703682443, 6090.573659843769, 6204.906926396017, 6260.7495700171485, 3368.343173081226, 3536.045267777737, 3703.9444408333356, 3836.616338366141, 4047.6357127858632, 4673.485916549245, 6123.357047510125, 6151.954167791397, 6178.845528861814, 6210.441060304594, 4975.348049573516, 5306.495882891119, 5668.829935101953, 6076.149339092619, 6118.2658081028785, 5846.503047241032, 6137.478314343331, 6138.25566404484, 6168.61206228595, 6185.505159587312, 4877.073755746524, 5357.928414317074, 5596.692181930033, 6012.63924164534, 6019.759209631566, 5668.781212039431, 5973.820785376446, 6045.879082418415, 6057.909131362945, 6067.362926892612, 4861.829835955725, 4948.119714508463, 5327.387350454593, 5898.997170480942, 5950.322354940207], "value": 4333.140185797569, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [646.6411141816292, 735.2867718313238, 801.3148757812071, 828.6643909216767, 838.6310023589616, 16056.83943160568, 16106.194690265484, 16367.754483682755, 16468.505944821674, 16496.42262520812, 13554.864451355483, 13650.590482285523, 13674.179549227054, 13698.863011369907, 13714.0, 686.5468790598206, 872.9170728780788, 882.15753954973, 894.9060348663394, 895.6014573514789, 742.4728442805615, 890.2966656341482, 892.3797960417512, 902.7788191892995, 903.2954295649404, 937.7327461673425, 954.374884450686, 957.286821318119, 958.5255298627189, 959.9856002159974, 919.4345477531336, 929.9209567186797, 945.2343601682659, 947.0198344713223, 951.8905325887473, 680.9897851532231, 708.8405108850519, 709.3651182191961, 710.4848984486258, 711.1324184494908, 15209.543713688607, 15344.769828452581, 15368.923155384151, 15600.98593591413, 15604.531864044096, 13832.792508112387, 13999.110120133753, 14009.649758756012, 14137.222452765094, 14158.29208539569, 11129.443527823658, 11157.609483668113, 11177.49701263445, 11207.439628018648, 11480.254676002181, 3899.278633452792, 3913.3738601823857, 3943.842246310173, 3953.960460395388, 4085.121698834735, 111801.44099279532, 120552.19171712431, 120762.0, 121262.78737212603, 121608.17587736191, 9048.23090037341, 10488.737781555523, 10938.726531836768, 10986.340819550853, 12053.457594408274, 17117.14414279281, 21457.0, 21631.35105946824, 21859.453513662287, 21882.562348752937, 7295.905614157813, 7560.848783024308, 8031.55826429552, 8053.1946805319, 8148.5419575381275, 3765.7175711821724, 3901.6098390160755, 4615.930761038587, 4639.953600463952, 4716.622670186377, 3346.297277571737, 3670.926581468409, 3674.669279764834, 3678.797666128335, 3683.686886614614, 666.1539844397588, 676.6887231873393, 678.260695841535, 680.3604611665019, 690.8756423843656, 510.9795608175706, 530.4562823106347, 705.4391758551861, 709.3722055980494, 716.9856602868018, 8622.741317760478, 9174.86237706435, 9571.760705982406, 9907.009299070036, 9974.202063834875, 671.8488340123531, 685.4995853027218, 691.865086308165, 696.0418814944095, 717.9446214065316, 4665.836695715634, 4680.789364478606, 4739.194336962724, 4743.1225223333795, 4797.850371955329, 94870.0, 96211.0, 120150.79849201396, 163083.0, 166830.0, 112894.0, 116222.0, 142595.28702356628, 145062.82405763923, 147558.0, 79896.60051699821, 103265.0, 109554.3566846498, 111151.0, 111472.4426377863, 8846.646134154562, 8886.822263554823, 9824.36141650819, 10107.0, 10390.532426040998, 48657.27014094721, 63179.670794171034, 63788.362116378245, 63975.68012159909, 65353.67323163354, 91213.0, 92984.0, 94866.52566737123, 95838.0, 97385.0, 13338.799918001043, 13385.799213011618, 13689.520866769615, 14152.009359344747, 14205.147691138565, 15276.541703748906, 15344.539663810103, 15422.614434638775, 15423.84576154269, 15433.382664693287, 14042.2978851055, 14080.718385632024, 14151.858481415054, 14175.645608859448, 14756.63108422298, 13809.861901380858, 14015.421144589456, 14219.431222750974, 14525.418983240552, 14915.701685966003, 13958.58124256274, 13988.860111399163, 14106.647333816327, 14334.784978225127, 14542.054766440147, 10820.18848586375, 11382.487788049722, 11383.715407114889, 11453.370064646191, 11572.710682233012, 11368.488418021043, 11607.6517704469, 11632.418379081182, 11647.184697071123, 11732.94133529327], "value": 7950.141083092149, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1607.0000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 117.0, 108.0, 115.0, 131.0, 116.0, 115.0, 113.0, 116.0, 116.0], "value": 115.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 142.0, 134.0, 150.0, 107.0, 121.0, 142.0, 140.0, 199.0, 140.0], "value": 142.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [279.0, 230.0, 203.0, 228.0, 228.0, 199.0, 191.0, 246.0, 225.0, 283.0], "value": 231.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 82.0, 75.0, 141.0, 60.0, 59.0, 59.0, 64.0, 136.0, 59.0], "value": 80.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 70.0, 143.0, 70.0, 72.0, 88.0, 112.0, 68.0, 72.0, 115.0], "value": 88.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 90.0, 91.0, 90.0, 93.0, 89.0, 94.0, 90.0, 95.0, 128.0], "value": 95.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 146.0, 96.0, 103.0, 97.0, 97.0, 96.0, 147.0, 96.0, 101.0], "value": 108.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 92.0, 90.0, 90.0, 95.0, 89.0, 89.0, 91.0, 91.0, 90.0], "value": 90.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 60.0, 58.0, 67.0, 88.0, 89.0, 88.0, 58.0, 56.0, 56.0], "value": 67.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 69.0, 78.0, 71.0, 68.0, 78.0, 74.0, 69.0, 71.0, 71.0], "value": 71.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 84.0, 88.0, 71.0, 96.0, 77.0, 102.0, 109.0, 104.0, 107.0], "value": 92.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 137.0, 186.0, 144.0, 143.0, 153.0, 171.0, 163.0, 197.0, 147.0], "value": 157.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [186.0, 187.0, 189.0, 191.0, 184.0, 187.0, 186.0, 188.0, 194.0, 262.0], "value": 195.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 71.0, 69.0, 69.0, 69.0, 70.0, 68.0, 69.0, 72.0, 70.0], "value": 69.9, "unit": "score"}]}]} 05:07:00 INFO - Return code: 0 05:07:00 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:07:00 ERROR - # TBPL SUCCESS # 05:07:00 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:07:00 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:07:00 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:07:00 INFO - 2016-07-08 05:07:00.333 screenresolution[1679:10854] starting screenresolution argv=screenresolution get 05:07:00 INFO - 2016-07-08 05:07:00.337 screenresolution[1679:10854] Display 0: 1600x1200x32@60 05:07:00 INFO - 2016-07-08 05:07:00.343 screenresolution[1680:10857] starting screenresolution argv=screenresolution list 05:07:00 INFO - Available Modes on Display 0 05:07:00 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:07:00 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:07:00 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:07:00 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:07:00 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:07:00 INFO - Intel Iris: 05:07:00 INFO - Chipset Model: Intel Iris 05:07:00 INFO - Type: GPU 05:07:00 INFO - Bus: Built-In 05:07:00 INFO - VRAM (Dynamic, Max): 1536 MB 05:07:00 INFO - Vendor: Intel (0x8086) 05:07:00 INFO - Device ID: 0x0a2e 05:07:00 INFO - Revision ID: 0x0009 05:07:00 INFO - Displays: 05:07:00 INFO - Display: 05:07:00 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:07:00 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:07:00 INFO - Display Serial Number: 1600x1200 60 05:07:00 INFO - Main Display: Yes 05:07:00 INFO - Mirror: Off 05:07:00 INFO - Online: Yes 05:07:00 INFO - Rotation: Supported 05:07:00 INFO - Return code: 0 05:07:00 INFO - Running post-action listener: _resource_record_post_action 05:07:00 INFO - ##### 05:07:00 INFO - ##### Finished run-tests step (success) 05:07:00 INFO - ##### 05:07:00 INFO - Running post-run listener: _resource_record_post_run 05:07:00 INFO - Total resource usage - Wall time: 1209s; CPU: 54.0%; Read bytes: 31628800; Write bytes: 709876736; Read time: 193; Write time: 1969 05:07:00 INFO - TinderboxPrint: CPU usage
54.1% 05:07:00 INFO - TinderboxPrint: I/O read bytes / time
31,628,800 / 193 05:07:00 INFO - TinderboxPrint: I/O write bytes / time
709,876,736 / 1,969 05:07:00 INFO - TinderboxPrint: CPU idle
2,220.3 (45.9%) 05:07:00 INFO - TinderboxPrint: CPU system
975.1 (20.2%) 05:07:00 INFO - TinderboxPrint: CPU user
1,642.2 (33.9%) 05:07:00 INFO - TinderboxPrint: Swap in / out
434,847,744 / 0 05:07:00 INFO - install - Wall time: 35s; CPU: 55.0%; Read bytes: 407978496; Write bytes: 404613120; Read time: 30640; Write time: 809 05:07:00 INFO - run-tests - Wall time: 1175s; CPU: 54.0%; Read bytes: 29175296; Write bytes: 296685056; Read time: 172; Write time: 1116 05:07:01 INFO - Running post-run listener: _upload_blobber_files 05:07:01 INFO - Blob upload gear active. 05:07:01 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:07:01 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 05:07:01 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', 'Autoland', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:07:01 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 Autoland -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:07:01 INFO - (blobuploader) - INFO - Open directory for files ... 05:07:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:07:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:07:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:07:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:07:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:07:02 INFO - (blobuploader) - INFO - Done attempting. 05:07:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:07:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:07:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:07:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:07:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:07:03 INFO - (blobuploader) - INFO - Done attempting. 05:07:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:07:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:07:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:07:05 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:07:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:07:05 INFO - (blobuploader) - INFO - Done attempting. 05:07:05 INFO - (blobuploader) - INFO - Iteration through files over. 05:07:05 INFO - Return code: 0 05:07:05 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:07:05 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:07:05 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/dfb914f81ac74332f41d8710b0fc560e72273add8c275d050bde4ab2a35425bfcf4cddbbe94e4e566a8ac2811803811b6cc9241d965d41261149009a1a0be2b4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/5040331183cef8ba521b70d8c739aac7d2ef57b49226f9eb68be2dc215b82c09d2c1d7f3b0ecc8a328f2288f0b2073e751d5bbce537b4b98bad8f8c09ba574c5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/d3049ddf339065ba435cfb7625427863984c79aa91f92fa8a9b6e18c10cecf9121517237fa44623e1e3edfea56350acbd41b484d328bbb72295315eef89481a2"} 05:07:05 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:07:05 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:07:05 INFO - Contents: 05:07:05 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/dfb914f81ac74332f41d8710b0fc560e72273add8c275d050bde4ab2a35425bfcf4cddbbe94e4e566a8ac2811803811b6cc9241d965d41261149009a1a0be2b4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/5040331183cef8ba521b70d8c739aac7d2ef57b49226f9eb68be2dc215b82c09d2c1d7f3b0ecc8a328f2288f0b2073e751d5bbce537b4b98bad8f8c09ba574c5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/d3049ddf339065ba435cfb7625427863984c79aa91f92fa8a9b6e18c10cecf9121517237fa44623e1e3edfea56350acbd41b484d328bbb72295315eef89481a2"} 05:07:05 INFO - Running post-run listener: copy_logs_to_upload_dir 05:07:05 INFO - Copying logs to upload dir... 05:07:05 INFO - mkdir: /builds/slave/test/build/upload/logs 05:07:05 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1279.292787 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 19 secs) (at 2016-07-08 05:07:05.833737) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-08 05:07:05.837013) ========= 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.ARfqb1Dj0Z/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.eqpPbgH9V5/Listeners TMPDIR=/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/dfb914f81ac74332f41d8710b0fc560e72273add8c275d050bde4ab2a35425bfcf4cddbbe94e4e566a8ac2811803811b6cc9241d965d41261149009a1a0be2b4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/5040331183cef8ba521b70d8c739aac7d2ef57b49226f9eb68be2dc215b82c09d2c1d7f3b0ecc8a328f2288f0b2073e751d5bbce537b4b98bad8f8c09ba574c5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/d3049ddf339065ba435cfb7625427863984c79aa91f92fa8a9b6e18c10cecf9121517237fa44623e1e3edfea56350acbd41b484d328bbb72295315eef89481a2"} build_url:https://queue.taskcluster.net/v1/task/NAgq4EkmTwe9cFxA6wZ0Ug/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011025 build_url: 'https://queue.taskcluster.net/v1/task/NAgq4EkmTwe9cFxA6wZ0Ug/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/dfb914f81ac74332f41d8710b0fc560e72273add8c275d050bde4ab2a35425bfcf4cddbbe94e4e566a8ac2811803811b6cc9241d965d41261149009a1a0be2b4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/5040331183cef8ba521b70d8c739aac7d2ef57b49226f9eb68be2dc215b82c09d2c1d7f3b0ecc8a328f2288f0b2073e751d5bbce537b4b98bad8f8c09ba574c5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/d3049ddf339065ba435cfb7625427863984c79aa91f92fa8a9b6e18c10cecf9121517237fa44623e1e3edfea56350acbd41b484d328bbb72295315eef89481a2"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-08 05:07:05.871376) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 05:07:05.871904) ========= 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.ARfqb1Dj0Z/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.eqpPbgH9V5/Listeners TMPDIR=/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/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.004993 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 05:07:05.920643) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-08 05:07:05.921003) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-08 05:07:05.921351) ========= ========= Total master_lag: 0.55 =========