builder: mozilla-aurora_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0154 starttime: 1461753632.45 results: success (0) buildid: 20160425062348 builduid: abe90fc74b164da98c10377025c22763 revision: 8551b253f4061db31e4be7829c2f70c2610caf42 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-27 03:40:32.454880) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-27 03:40:32.455360) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-27 03:40:32.455654) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-27 03:40:32.475681) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-27 03:40:32.476030) ========= 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.dNPGw2J1yA/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.1REvZbGWT7/Listeners TMPDIR=/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/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-04-27 03:40:32-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 110M=0s 2016-04-27 03:40:32 (110 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.136616 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-27 03:40:32.632434) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-27 03:40:32.633016) ========= 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.dNPGw2J1yA/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.1REvZbGWT7/Listeners TMPDIR=/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/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.025951 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-27 03:40:32.683040) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-27 03:40:32.683419) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 8551b253f4061db31e4be7829c2f70c2610caf42 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 8551b253f4061db31e4be7829c2f70c2610caf42 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.dNPGw2J1yA/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.1REvZbGWT7/Listeners TMPDIR=/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/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-04-27 03:40:32,762 truncating revision to first 12 chars 2016-04-27 03:40:32,762 Setting DEBUG logging. 2016-04-27 03:40:32,762 attempt 1/10 2016-04-27 03:40:32,762 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/8551b253f406?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-27 03:40:33,454 unpacking tar archive at: mozilla-aurora-8551b253f406/testing/mozharness/ program finished with exit code 0 elapsedTime=0.936898 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-27 03:40:33.637464) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-27 03:40:33.637790) ========= script_repo_revision: 8551b253f4061db31e4be7829c2f70c2610caf42 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-27 03:40:33.638290) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-27 03:40:33.638557) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-27 03:40:33.653744) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2016-04-27 03:40:33.654117) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 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', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.dNPGw2J1yA/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.1REvZbGWT7/Listeners TMPDIR=/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 03:40:33 INFO - MultiFileLogger online at 20160427 03:40:33 in /builds/slave/test 03:40:33 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 03:40:33 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:40:33 INFO - {'append_to_log': False, 03:40:33 INFO - 'base_work_dir': '/builds/slave/test', 03:40:33 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 03:40:33 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:40:33 INFO - 'branch': 'Mozilla-Aurora', 03:40:33 INFO - 'buildbot_json_path': 'buildprops.json', 03:40:33 INFO - 'config_files': ('talos/mac_config.py',), 03:40:33 INFO - 'default_actions': ('clobber', 03:40:33 INFO - 'read-buildbot-config', 03:40:33 INFO - 'download-and-extract', 03:40:33 INFO - 'populate-webroot', 03:40:33 INFO - 'create-virtualenv', 03:40:33 INFO - 'install', 03:40:33 INFO - 'run-tests'), 03:40:33 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:40:33 INFO - 'download_minidump_stackwalk': True, 03:40:33 INFO - 'download_symbols': 'ondemand', 03:40:33 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:40:33 INFO - 'tooltool.py': '/tools/tooltool.py', 03:40:33 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:40:33 INFO - '/tools/misc-python/virtualenv.py')}, 03:40:33 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:40:33 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:40:33 INFO - 'installer_path': 'installer.exe', 03:40:33 INFO - 'log_level': 'info', 03:40:33 INFO - 'log_name': 'talos', 03:40:33 INFO - 'log_to_console': True, 03:40:33 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 03:40:33 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 03:40:33 INFO - 'opt_config_files': (), 03:40:33 INFO - 'pip_index': False, 03:40:33 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:40:33 INFO - 'cmd': ('bash', 03:40:33 INFO - '-c', 03:40:33 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:40:33 INFO - 'enabled': True, 03:40:33 INFO - 'halt_on_failure': False, 03:40:33 INFO - 'name': 'check_screen_resolution'},), 03:40:33 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:40:33 INFO - 'cmd': ('bash', 03:40:33 INFO - '-c', 03:40:33 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:40:33 INFO - 'enabled': True, 03:40:33 INFO - 'halt_on_failure': False, 03:40:33 INFO - 'name': 'check_screen_resolution'},), 03:40:33 INFO - 'run_cmd_checks_enabled': True, 03:40:33 INFO - 'sps_profile': False, 03:40:33 INFO - 'sps_profile_interval': 0, 03:40:33 INFO - 'suite': 'dromaeojs-e10s', 03:40:33 INFO - 'system_bits': '32', 03:40:33 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:40:33 INFO - 'title': 't-yosemite-r7-0154', 03:40:33 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:40:33 INFO - 'use_talos_json': True, 03:40:33 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:40:33 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:40:33 INFO - 'work_dir': 'build'} 03:40:33 INFO - ##### 03:40:33 INFO - ##### Running clobber step. 03:40:33 INFO - ##### 03:40:33 INFO - Running pre-action listener: _resource_record_pre_action 03:40:33 INFO - Running main action method: clobber 03:40:33 INFO - rmtree: /builds/slave/test/build 03:40:33 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:40:35 INFO - Running post-action listener: _resource_record_post_action 03:40:35 INFO - ##### 03:40:35 INFO - ##### Running read-buildbot-config step. 03:40:35 INFO - ##### 03:40:35 INFO - Running pre-action listener: _resource_record_pre_action 03:40:35 INFO - Running main action method: read_buildbot_config 03:40:35 INFO - Using buildbot properties: 03:40:35 INFO - { 03:40:35 INFO - "project": "", 03:40:35 INFO - "product": "firefox", 03:40:35 INFO - "script_repo_revision": "production", 03:40:35 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs-e10s", 03:40:35 INFO - "repository": "", 03:40:35 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs-e10s", 03:40:35 INFO - "buildid": "20160425062348", 03:40:35 INFO - "pgo_build": "False", 03:40:35 INFO - "basedir": "/builds/slave/test", 03:40:35 INFO - "buildnumber": 300, 03:40:35 INFO - "slavename": "t-yosemite-r7-0154", 03:40:35 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 03:40:35 INFO - "platform": "yosemite_r7", 03:40:35 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 03:40:35 INFO - "branch": "mozilla-aurora", 03:40:35 INFO - "repo_path": "releases/mozilla-aurora", 03:40:35 INFO - "revision": "8551b253f4061db31e4be7829c2f70c2610caf42", 03:40:35 INFO - "stage_platform": "macosx64", 03:40:35 INFO - "builduid": "abe90fc74b164da98c10377025c22763", 03:40:35 INFO - "slavebuilddir": "test" 03:40:35 INFO - } 03:40:35 INFO - Found installer url https://queue.taskcluster.net/v1/task/SQDTyWLnRTi58-v24Lw8jQ/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg. 03:40:35 INFO - Running post-action listener: _resource_record_post_action 03:40:35 INFO - ##### 03:40:35 INFO - ##### Running download-and-extract step. 03:40:35 INFO - ##### 03:40:35 INFO - Running pre-action listener: _resource_record_pre_action 03:40:35 INFO - Running main action method: download_and_extract 03:40:35 INFO - mkdir: /builds/slave/test/build/tests 03:40: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')]} 03:40:35 INFO - https://queue.taskcluster.net/v1/task/SQDTyWLnRTi58-v24Lw8jQ/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json matches https://queue.taskcluster.net 03:40:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SQDTyWLnRTi58-v24Lw8jQ/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json 03:40:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SQDTyWLnRTi58-v24Lw8jQ/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json 03:40:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SQDTyWLnRTi58-v24Lw8jQ/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-47.0a2.en-US.mac.test_packages.json 03:40:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SQDTyWLnRTi58-v24Lw8jQ/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-47.0a2.en-US.mac.test_packages.json'}, attempt #1 03:40:36 INFO - Downloaded 1277 bytes. 03:40:36 INFO - Reading from file /builds/slave/test/build/firefox-47.0a2.en-US.mac.test_packages.json 03:40:36 INFO - Using the following test package requirements: 03:40:36 INFO - {u'common': [u'firefox-47.0a2.en-US.mac.common.tests.zip'], 03:40:36 INFO - u'cppunittest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 03:40:36 INFO - u'firefox-47.0a2.en-US.mac.cppunittest.tests.zip'], 03:40:36 INFO - u'gtest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 03:40:36 INFO - u'firefox-47.0a2.en-US.mac.gtest.tests.zip'], 03:40:36 INFO - u'jittest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 03:40:36 INFO - u'jsshell-mac.zip'], 03:40:36 INFO - u'mochitest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 03:40:36 INFO - u'firefox-47.0a2.en-US.mac.mochitest.tests.zip'], 03:40:36 INFO - u'mozbase': [u'firefox-47.0a2.en-US.mac.common.tests.zip'], 03:40:36 INFO - u'reftest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 03:40:36 INFO - u'firefox-47.0a2.en-US.mac.reftest.tests.zip'], 03:40:36 INFO - u'talos': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 03:40:36 INFO - u'firefox-47.0a2.en-US.mac.talos.tests.zip'], 03:40:36 INFO - u'web-platform': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 03:40:36 INFO - u'firefox-47.0a2.en-US.mac.web-platform.tests.zip'], 03:40:36 INFO - u'webapprt': [u'firefox-47.0a2.en-US.mac.common.tests.zip'], 03:40:36 INFO - u'xpcshell': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 03:40:36 INFO - u'firefox-47.0a2.en-US.mac.xpcshell.tests.zip']} 03:40:36 INFO - Downloading packages: [u'firefox-47.0a2.en-US.mac.common.tests.zip'] for test suite category: common 03:40:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:40:36 INFO - https://queue.taskcluster.net/v1/task/SQDTyWLnRTi58-v24Lw8jQ/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 03:40:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SQDTyWLnRTi58-v24Lw8jQ/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 03:40:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SQDTyWLnRTi58-v24Lw8jQ/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 03:40:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SQDTyWLnRTi58-v24Lw8jQ/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip 03:40:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SQDTyWLnRTi58-v24Lw8jQ/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip'}, attempt #1 03:40:38 INFO - Downloaded 17919011 bytes. 03:40:38 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:40:38 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 03:40:42 INFO - Return code: 0 03:40:42 INFO - Downloading packages: [u'firefox-47.0a2.en-US.mac.common.tests.zip', u'firefox-47.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 03:40:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:40:42 INFO - https://queue.taskcluster.net/v1/task/SQDTyWLnRTi58-v24Lw8jQ/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 03:40:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SQDTyWLnRTi58-v24Lw8jQ/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 03:40:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SQDTyWLnRTi58-v24Lw8jQ/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 03:40:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SQDTyWLnRTi58-v24Lw8jQ/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip 03:40:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SQDTyWLnRTi58-v24Lw8jQ/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip'}, attempt #1 03:40:43 INFO - Downloaded 17919011 bytes. 03:40:43 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:40:43 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 03:40:46 INFO - Return code: 0 03:40:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:40:46 INFO - https://queue.taskcluster.net/v1/task/SQDTyWLnRTi58-v24Lw8jQ/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 03:40:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SQDTyWLnRTi58-v24Lw8jQ/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip 03:40:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SQDTyWLnRTi58-v24Lw8jQ/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip 03:40:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SQDTyWLnRTi58-v24Lw8jQ/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-47.0a2.en-US.mac.talos.tests.zip 03:40:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SQDTyWLnRTi58-v24Lw8jQ/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.talos.tests.zip'}, attempt #1 03:40:47 INFO - Downloaded 10845194 bytes. 03:40:47 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:40:47 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a2.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 03:40:48 INFO - Return code: 0 03:40: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')]} 03:40:48 INFO - https://queue.taskcluster.net/v1/task/SQDTyWLnRTi58-v24Lw8jQ/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg matches https://queue.taskcluster.net 03:40:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SQDTyWLnRTi58-v24Lw8jQ/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 03:40:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SQDTyWLnRTi58-v24Lw8jQ/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 03:40:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SQDTyWLnRTi58-v24Lw8jQ/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a2.en-US.mac.dmg 03:40:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SQDTyWLnRTi58-v24Lw8jQ/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-47.0a2.en-US.mac.dmg'}, attempt #1 03:40:51 INFO - Downloaded 115767664 bytes. 03:40:51 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/SQDTyWLnRTi58-v24Lw8jQ/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 03:40:51 INFO - mkdir: /builds/slave/test/properties 03:40:51 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:40:51 INFO - Writing to file /builds/slave/test/properties/build_url 03:40:51 INFO - Contents: 03:40:51 INFO - build_url:https://queue.taskcluster.net/v1/task/SQDTyWLnRTi58-v24Lw8jQ/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 03:40:52 INFO - Running post-action listener: _resource_record_post_action 03:40:52 INFO - Running post-action listener: set_extra_try_arguments 03:40:52 INFO - ##### 03:40:52 INFO - ##### Running populate-webroot step. 03:40:52 INFO - ##### 03:40:52 INFO - Running pre-action listener: _resource_record_pre_action 03:40:52 INFO - Running main action method: populate_webroot 03:40:52 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:40:52 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:40:52 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:40:52 INFO - '--tppagecycles', 03:40:52 INFO - '7'], 03:40:52 INFO - 'tests': ['tsvgm']}}, 03:40:52 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 03:40:52 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 03:40:52 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:40:52 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 03:40:52 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 03:40:52 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:40:52 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:40:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:40:52 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:40:52 INFO - 'talos_options': ['--e10s'], 03:40:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:40:52 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:40:52 INFO - 'tests': ['damp', 'tps']}, 03:40:52 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:40:52 INFO - 'talos_options': ['--e10s'], 03:40:52 INFO - 'tests': ['damp', 'tps']}, 03:40:52 INFO - 'g3': {'tests': ['dromaeo_dom']}, 03:40:52 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:40:52 INFO - 'other': {'tests': ['a11yr', 03:40:52 INFO - 'ts_paint', 03:40:52 INFO - 'tpaint', 03:40:52 INFO - 'sessionrestore', 03:40:52 INFO - 'sessionrestore_no_auto_restore', 03:40:52 INFO - 'tabpaint']}, 03:40:52 INFO - 'other-e10s': {'talos_options': ['--e10s'], 03:40:52 INFO - 'tests': ['a11yr', 03:40:52 INFO - 'ts_paint', 03:40:52 INFO - 'tpaint', 03:40:52 INFO - 'sessionrestore', 03:40:52 INFO - 'sessionrestore_no_auto_restore', 03:40:52 INFO - 'tabpaint']}, 03:40:52 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 03:40:52 INFO - 'tests': ['a11yr', 03:40:52 INFO - 'ts_paint', 03:40:52 INFO - 'tpaint', 03:40:52 INFO - 'sessionrestore', 03:40:52 INFO - 'sessionrestore_no_auto_restore', 03:40:52 INFO - 'tabpaint']}, 03:40:52 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 03:40:52 INFO - 'tests': ['a11yr', 03:40:52 INFO - 'ts_paint', 03:40:52 INFO - 'tpaint', 03:40:52 INFO - 'sessionrestore', 03:40:52 INFO - 'sessionrestore_no_auto_restore', 03:40:52 INFO - 'tabpaint']}, 03:40:52 INFO - 'other_l64': {'tests': ['a11yr', 03:40:52 INFO - 'ts_paint', 03:40:52 INFO - 'tpaint', 03:40:52 INFO - 'sessionrestore', 03:40:52 INFO - 'sessionrestore_no_auto_restore', 03:40:52 INFO - 'tabpaint']}, 03:40:52 INFO - 'other_nol64': {'tests': ['a11yr', 03:40:52 INFO - 'ts_paint', 03:40:52 INFO - 'tpaint', 03:40:52 INFO - 'sessionrestore', 03:40:52 INFO - 'sessionrestore_no_auto_restore', 03:40:52 INFO - 'tabpaint']}, 03:40:52 INFO - 'svgr': {'tests': ['tsvgx', 03:40:52 INFO - 'tsvgr_opacity', 03:40:52 INFO - 'tart', 03:40:52 INFO - 'tscrollx', 03:40:52 INFO - 'cart']}, 03:40:52 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 03:40:52 INFO - 'tests': ['tsvgx', 03:40:52 INFO - 'tsvgr_opacity', 03:40:52 INFO - 'tart', 03:40:52 INFO - 'tscrollx', 03:40:52 INFO - 'cart']}, 03:40:52 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:40:52 INFO - 'tests': ['tp5o']}, 03:40:52 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:40:52 INFO - 'talos_options': ['--e10s'], 03:40:52 INFO - 'tests': ['tp5o']}, 03:40:52 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:40:52 INFO - 'talos_options': ['--xperf_path', 03:40:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:40:52 INFO - 'tests': ['tp5n']}, 03:40:52 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:40:52 INFO - 'talos_options': ['--e10s', 03:40:52 INFO - '--xperf_path', 03:40:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:40:52 INFO - 'tests': ['tp5n']}}, 03:40:52 INFO - 'talos.zip': {'path': '', 03:40:52 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:40:52 INFO - Running post-action listener: _resource_record_post_action 03:40:52 INFO - ##### 03:40:52 INFO - ##### Running create-virtualenv step. 03:40:52 INFO - ##### 03:40:52 INFO - Running pre-action listener: _resource_record_pre_action 03:40:52 INFO - Running main action method: create_virtualenv 03:40:52 INFO - Creating virtualenv /builds/slave/test/build/venv 03:40:52 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 03:40:52 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:40:52 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:40:52 INFO - Using real prefix '/tools/python27' 03:40:52 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:40:53 INFO - Installing distribute.............................................................................................................................................................................................done. 03:40:56 INFO - Installing pip.................done. 03:40:56 INFO - Return code: 0 03:40:56 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:40:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:40:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:40:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:40:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:40:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:40:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:40:56 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 0x10bd7da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bd844c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd999d7ee80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bc21d30>, '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 0x10ba85db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bc18b20>, '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.dNPGw2J1yA/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.1REvZbGWT7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:40:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 03:40:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 03:40:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dNPGw2J1yA/Render', 03:40:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:40:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:40:56 INFO - 'HOME': '/Users/cltbld', 03:40:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:40:56 INFO - 'LOGNAME': 'cltbld', 03:40:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:40:56 INFO - 'MOZ_NO_REMOTE': '1', 03:40:56 INFO - 'NO_EM_RESTART': '1', 03:40:56 INFO - 'PAGER': '/bin/cat', 03:40:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:40:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:40:56 INFO - 'PWD': '/builds/slave/test', 03:40:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:40:56 INFO - 'SHELL': '/bin/bash', 03:40:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1REvZbGWT7/Listeners', 03:40:56 INFO - 'TMPDIR': '/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/', 03:40:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:40:56 INFO - 'USER': 'cltbld', 03:40:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:40:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:40:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:40:56 INFO - 'XPC_FLAGS': '0x0', 03:40:56 INFO - 'XPC_SERVICE_NAME': '0', 03:40:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:40:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:40:56 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 03:40:56 INFO - Cleaning up... 03:40:56 INFO - Return code: 0 03:40:56 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 03:40:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:40:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:40:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:40:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:40:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:40:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:40:56 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>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10bd7da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bd844c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd999d7ee80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bc21d30>, '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 0x10ba85db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bc18b20>, '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.dNPGw2J1yA/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.1REvZbGWT7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:40:56 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>=0.7.1'] in /builds/slave/test/build 03:40:56 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>=0.7.1 03:40:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dNPGw2J1yA/Render', 03:40:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:40:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:40:56 INFO - 'HOME': '/Users/cltbld', 03:40:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:40:56 INFO - 'LOGNAME': 'cltbld', 03:40:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:40:56 INFO - 'MOZ_NO_REMOTE': '1', 03:40:56 INFO - 'NO_EM_RESTART': '1', 03:40:56 INFO - 'PAGER': '/bin/cat', 03:40:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:40:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:40:56 INFO - 'PWD': '/builds/slave/test', 03:40:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:40:56 INFO - 'SHELL': '/bin/bash', 03:40:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1REvZbGWT7/Listeners', 03:40:56 INFO - 'TMPDIR': '/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/', 03:40:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:40:56 INFO - 'USER': 'cltbld', 03:40:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:40:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:40:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:40:56 INFO - 'XPC_FLAGS': '0x0', 03:40:56 INFO - 'XPC_SERVICE_NAME': '0', 03:40:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:40:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:40:56 INFO - Downloading/unpacking psutil>=0.7.1 03:40:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:40:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:40:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:40:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:40:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:40:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:40:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:40:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:40:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:40:59 INFO - Installing collected packages: psutil 03:40:59 INFO - Running setup.py install for psutil 03:40:59 INFO - building 'psutil._psutil_osx' extension 03:40:59 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 03:41:00 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 03:41:00 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 03:41:00 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 03:41:00 INFO - building 'psutil._psutil_posix' extension 03:41:00 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 03:41:00 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 03:41:00 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 03:41:00 INFO - ^ 03:41:00 INFO - 1 warning generated. 03:41:00 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 03:41:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:41:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:41:01 INFO - Successfully installed psutil 03:41:01 INFO - Cleaning up... 03:41:01 INFO - Return code: 0 03:41:01 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 03:41:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:41:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:41:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:41:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:41:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:41:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:41:01 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.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10bd7da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bd844c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd999d7ee80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bc21d30>, '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 0x10ba85db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bc18b20>, '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.dNPGw2J1yA/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.1REvZbGWT7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:41:01 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.0.0'] in /builds/slave/test/build 03:41:01 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.0.0 03:41:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dNPGw2J1yA/Render', 03:41:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:41:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:41:01 INFO - 'HOME': '/Users/cltbld', 03:41:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:41:01 INFO - 'LOGNAME': 'cltbld', 03:41:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:41:01 INFO - 'MOZ_NO_REMOTE': '1', 03:41:01 INFO - 'NO_EM_RESTART': '1', 03:41:01 INFO - 'PAGER': '/bin/cat', 03:41:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:41:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:41:01 INFO - 'PWD': '/builds/slave/test', 03:41:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:41:01 INFO - 'SHELL': '/bin/bash', 03:41:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1REvZbGWT7/Listeners', 03:41:01 INFO - 'TMPDIR': '/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/', 03:41:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:41:01 INFO - 'USER': 'cltbld', 03:41:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:41:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:41:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:41:01 INFO - 'XPC_FLAGS': '0x0', 03:41:01 INFO - 'XPC_SERVICE_NAME': '0', 03:41:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:41:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:41:01 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 03:41:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:41:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:41:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:41:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:41:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:41:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:41:03 INFO - Downloading mozsystemmonitor-0.0.tar.gz 03:41:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:41:03 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 03:41:03 INFO - Installing collected packages: mozsystemmonitor 03:41:03 INFO - Running setup.py install for mozsystemmonitor 03:41:04 INFO - Successfully installed mozsystemmonitor 03:41:04 INFO - Cleaning up... 03:41:04 INFO - Return code: 0 03:41:04 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:41:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:41:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:41:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:41:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:41:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:41:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:41:04 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 0x10bd7da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bd844c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd999d7ee80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bc21d30>, '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 0x10ba85db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bc18b20>, '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.dNPGw2J1yA/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.1REvZbGWT7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:41:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:41:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:41:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dNPGw2J1yA/Render', 03:41:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:41:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:41:04 INFO - 'HOME': '/Users/cltbld', 03:41:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:41:04 INFO - 'LOGNAME': 'cltbld', 03:41:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:41:04 INFO - 'MOZ_NO_REMOTE': '1', 03:41:04 INFO - 'NO_EM_RESTART': '1', 03:41:04 INFO - 'PAGER': '/bin/cat', 03:41:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:41:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:41:04 INFO - 'PWD': '/builds/slave/test', 03:41:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:41:04 INFO - 'SHELL': '/bin/bash', 03:41:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1REvZbGWT7/Listeners', 03:41:04 INFO - 'TMPDIR': '/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/', 03:41:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:41:04 INFO - 'USER': 'cltbld', 03:41:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:41:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:41:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:41:04 INFO - 'XPC_FLAGS': '0x0', 03:41:04 INFO - 'XPC_SERVICE_NAME': '0', 03:41:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:41:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:41:04 INFO - Downloading/unpacking blobuploader==1.2.4 03:41:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:41:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:41:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:41:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:41:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:41:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:41:06 INFO - Downloading blobuploader-1.2.4.tar.gz 03:41:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:41:06 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:41:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:41:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:41:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:41:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:41:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:41:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:41:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:41:07 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:41:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:41:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:41:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:41:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:41:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:41:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:41:07 INFO - Downloading docopt-0.6.1.tar.gz 03:41:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:41:08 INFO - Installing collected packages: blobuploader, requests, docopt 03:41:08 INFO - Running setup.py install for blobuploader 03:41:08 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:41:08 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:41:08 INFO - Running setup.py install for requests 03:41:08 INFO - Running setup.py install for docopt 03:41:08 INFO - Successfully installed blobuploader requests docopt 03:41:08 INFO - Cleaning up... 03:41:08 INFO - Return code: 0 03:41:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:41: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')]} 03:41:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:41:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:41: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')]} 03:41:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:41:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:41:08 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 0x10bd7da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bd844c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd999d7ee80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bc21d30>, '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 0x10ba85db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bc18b20>, '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.dNPGw2J1yA/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.1REvZbGWT7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:41:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:41:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:41:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dNPGw2J1yA/Render', 03:41:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:41:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:41:08 INFO - 'HOME': '/Users/cltbld', 03:41:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:41:08 INFO - 'LOGNAME': 'cltbld', 03:41:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:41:08 INFO - 'MOZ_NO_REMOTE': '1', 03:41:08 INFO - 'NO_EM_RESTART': '1', 03:41:08 INFO - 'PAGER': '/bin/cat', 03:41:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:41:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:41:08 INFO - 'PWD': '/builds/slave/test', 03:41:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:41:08 INFO - 'SHELL': '/bin/bash', 03:41:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1REvZbGWT7/Listeners', 03:41:08 INFO - 'TMPDIR': '/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/', 03:41:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:41:08 INFO - 'USER': 'cltbld', 03:41:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:41:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:41:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:41:08 INFO - 'XPC_FLAGS': '0x0', 03:41:08 INFO - 'XPC_SERVICE_NAME': '0', 03:41:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:41:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:41:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:41:09 INFO - Running setup.py (path:/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/pip-LglSE8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:41:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:41:09 INFO - Running setup.py (path:/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/pip-xCcCPA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:41:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:41:09 INFO - Running setup.py (path:/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/pip-nqhaLa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:41:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:41:09 INFO - Running setup.py (path:/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/pip-vopO4d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:41:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:41:09 INFO - Running setup.py (path:/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/pip-HMbScP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:41:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:41:09 INFO - Running setup.py (path:/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/pip-gbx4nZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:41:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:41:09 INFO - Running setup.py (path:/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/pip-8kPDou-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:41:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:41:09 INFO - Running setup.py (path:/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/pip-C4s7Pd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:41:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:41:10 INFO - Running setup.py (path:/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/pip-FJFymx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:41:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:41:10 INFO - Running setup.py (path:/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/pip-H3FOgH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:41:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:41:10 INFO - Running setup.py (path:/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/pip-0WKoAY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:41:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:41:10 INFO - Running setup.py (path:/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/pip-uAlEUV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:41:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:41:10 INFO - Running setup.py (path:/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/pip-XGMvO0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:41:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:41:10 INFO - Running setup.py (path:/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/pip-20j3Z3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:41:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:41:10 INFO - Running setup.py (path:/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/pip-us0l05-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:41:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:41:10 INFO - Running setup.py (path:/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/pip-i8BBFl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:41:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:41:10 INFO - Running setup.py (path:/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/pip-2OMEer-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:41:10 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:41:10 INFO - Running setup.py install for manifestparser 03:41:11 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:41:11 INFO - Running setup.py install for mozcrash 03:41:11 INFO - Running setup.py install for mozdebug 03:41:11 INFO - Running setup.py install for mozdevice 03:41:11 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:41:11 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:41:11 INFO - Running setup.py install for mozfile 03:41:11 INFO - Running setup.py install for mozhttpd 03:41:11 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:41:11 INFO - Running setup.py install for mozinfo 03:41:12 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:41:12 INFO - Running setup.py install for mozInstall 03:41:12 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:41:12 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:41:12 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:41:12 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:41:12 INFO - Running setup.py install for mozleak 03:41:12 INFO - Running setup.py install for mozlog 03:41:12 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:41:12 INFO - Running setup.py install for moznetwork 03:41:12 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:41:12 INFO - Running setup.py install for mozprocess 03:41:12 INFO - Running setup.py install for mozprofile 03:41:12 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:41:12 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:41:12 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:41:12 INFO - Running setup.py install for mozrunner 03:41:13 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:41:13 INFO - Running setup.py install for mozscreenshot 03:41:13 INFO - Running setup.py install for moztest 03:41:13 INFO - Running setup.py install for mozversion 03:41:13 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:41:13 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:41:13 INFO - Cleaning up... 03:41:13 INFO - Return code: 0 03:41:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:41:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:41:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:41:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:41:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:41:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:41:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:41:13 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 0x10bd7da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bd844c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd999d7ee80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bc21d30>, '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 0x10ba85db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bc18b20>, '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.dNPGw2J1yA/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.1REvZbGWT7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:41:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:41:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:41:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dNPGw2J1yA/Render', 03:41:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:41:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:41:13 INFO - 'HOME': '/Users/cltbld', 03:41:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:41:13 INFO - 'LOGNAME': 'cltbld', 03:41:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:41:13 INFO - 'MOZ_NO_REMOTE': '1', 03:41:13 INFO - 'NO_EM_RESTART': '1', 03:41:13 INFO - 'PAGER': '/bin/cat', 03:41:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:41:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:41:13 INFO - 'PWD': '/builds/slave/test', 03:41:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:41:13 INFO - 'SHELL': '/bin/bash', 03:41:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1REvZbGWT7/Listeners', 03:41:13 INFO - 'TMPDIR': '/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/', 03:41:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:41:13 INFO - 'USER': 'cltbld', 03:41:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:41:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:41:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:41:13 INFO - 'XPC_FLAGS': '0x0', 03:41:13 INFO - 'XPC_SERVICE_NAME': '0', 03:41:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:41:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:41:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:41:13 INFO - Running setup.py (path:/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/pip-uwLkRp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:41:13 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 03:41:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:41:13 INFO - Running setup.py (path:/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/pip-FdfScx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:41:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:41:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:41:14 INFO - Running setup.py (path:/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/pip-dxH0d6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:41:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:41:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:41:14 INFO - Running setup.py (path:/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/pip-cLmH8I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:41:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:41:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:41:14 INFO - Running setup.py (path:/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/pip-G6Yu6i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:41:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 03:41:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:41:14 INFO - Running setup.py (path:/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/pip-dQZMb6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:41:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 03:41:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:41:14 INFO - Running setup.py (path:/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/pip-7lDhji-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:41:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 03:41:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:41:14 INFO - Running setup.py (path:/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/pip-3TM07y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:41:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 03:41:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:41:14 INFO - Running setup.py (path:/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/pip-6WCRJg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:41:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 03:41:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:41:14 INFO - Running setup.py (path:/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/pip-ExuE9T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:41:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:41:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:41:14 INFO - Running setup.py (path:/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/pip-EKwOdt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:41:15 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 03:41:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:41:15 INFO - Running setup.py (path:/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/pip-pivix4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:41:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 03:41:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:41:15 INFO - Running setup.py (path:/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/pip-owhArc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:41:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 03:41:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:41:15 INFO - Running setup.py (path:/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/pip-_LDYyH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:41:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 03:41:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:41:15 INFO - Running setup.py (path:/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/pip-JPA00_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:41:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 03:41:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:41:15 INFO - Running setup.py (path:/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/pip-QHg3x1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:41:15 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 03:41:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:41:15 INFO - Running setup.py (path:/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/pip-TADns2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:41:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 03:41:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:41:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:41:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:41:15 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:41:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:41:15 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:41:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:41:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:41:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:41:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:41:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:41:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:41:18 INFO - Downloading blessings-1.6.tar.gz 03:41:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:41:18 INFO - Installing collected packages: blessings 03:41:18 INFO - Running setup.py install for blessings 03:41:18 INFO - Successfully installed blessings 03:41:18 INFO - Cleaning up... 03:41:18 INFO - Return code: 0 03:41:18 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:41:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:41:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:41:18 INFO - Reading from file tmpfile_stdout 03:41:18 INFO - Current package versions: 03:41:18 INFO - blessings == 1.6 03:41:18 INFO - blobuploader == 1.2.4 03:41:18 INFO - docopt == 0.6.1 03:41:18 INFO - manifestparser == 1.1 03:41:18 INFO - mozInstall == 1.12 03:41:18 INFO - mozcrash == 0.17 03:41:18 INFO - mozdebug == 0.1 03:41:18 INFO - mozdevice == 0.48 03:41:18 INFO - mozfile == 1.2 03:41:18 INFO - mozhttpd == 0.7 03:41:18 INFO - mozinfo == 0.9 03:41:18 INFO - mozleak == 0.1 03:41:18 INFO - mozlog == 3.1 03:41:18 INFO - moznetwork == 0.27 03:41:18 INFO - mozprocess == 0.22 03:41:18 INFO - mozprofile == 0.28 03:41:18 INFO - mozrunner == 6.11 03:41:18 INFO - mozscreenshot == 0.1 03:41:18 INFO - mozsystemmonitor == 0.0 03:41:18 INFO - moztest == 0.7 03:41:18 INFO - mozversion == 1.4 03:41:18 INFO - psutil == 3.1.1 03:41:18 INFO - requests == 1.2.3 03:41:18 INFO - wsgiref == 0.1.2 03:41:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:41:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:41:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:41:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:41:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:41:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:41:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:41:18 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 0x10bd7da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bd844c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd999d7ee80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bc21d30>, '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 0x10ba85db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bc18b20>, '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.dNPGw2J1yA/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.1REvZbGWT7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:41:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 03:41:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:41:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dNPGw2J1yA/Render', 03:41:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:41:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:41:18 INFO - 'HOME': '/Users/cltbld', 03:41:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:41:18 INFO - 'LOGNAME': 'cltbld', 03:41:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:41:18 INFO - 'MOZ_NO_REMOTE': '1', 03:41:18 INFO - 'NO_EM_RESTART': '1', 03:41:18 INFO - 'PAGER': '/bin/cat', 03:41:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:41:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:41:18 INFO - 'PWD': '/builds/slave/test', 03:41:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:41:18 INFO - 'SHELL': '/bin/bash', 03:41:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1REvZbGWT7/Listeners', 03:41:18 INFO - 'TMPDIR': '/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/', 03:41:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:41:18 INFO - 'USER': 'cltbld', 03:41:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:41:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:41:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:41:18 INFO - 'XPC_FLAGS': '0x0', 03:41:18 INFO - 'XPC_SERVICE_NAME': '0', 03:41:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:41:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:41:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:41:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 03:41:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 03:41:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:41:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 03:41:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 03:41:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 03:41:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 03:41:19 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 03:41:19 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:41:19 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:41:19 INFO - Cleaning up... 03:41:19 INFO - Return code: 0 03:41:19 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:41:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:41:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:41:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:41:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:41:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:41:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:41:19 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 0x10bd7da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bd844c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd999d7ee80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bc21d30>, '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 0x10ba85db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bc18b20>, '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.dNPGw2J1yA/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.1REvZbGWT7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:41:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 03:41:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 03:41:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dNPGw2J1yA/Render', 03:41:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:41:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:41:19 INFO - 'HOME': '/Users/cltbld', 03:41:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:41:19 INFO - 'LOGNAME': 'cltbld', 03:41:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:41:19 INFO - 'MOZ_NO_REMOTE': '1', 03:41:19 INFO - 'NO_EM_RESTART': '1', 03:41:19 INFO - 'PAGER': '/bin/cat', 03:41:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:41:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:41:19 INFO - 'PWD': '/builds/slave/test', 03:41:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:41:19 INFO - 'SHELL': '/bin/bash', 03:41:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1REvZbGWT7/Listeners', 03:41:19 INFO - 'TMPDIR': '/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/', 03:41:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:41:19 INFO - 'USER': 'cltbld', 03:41:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:41:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:41:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:41:19 INFO - 'XPC_FLAGS': '0x0', 03:41:19 INFO - 'XPC_SERVICE_NAME': '0', 03:41:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:41:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:41:19 INFO - Downloading/unpacking jsonschema 03:41:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:41:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:41:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:41:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:41:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:41:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:41:21 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:41:21 INFO - Downloading/unpacking functools32 (from jsonschema) 03:41:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:41:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:41:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:41:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:41:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:41:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:41:22 INFO - Downloading functools32-3.2.3-2.tar.gz 03:41:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:41:22 INFO - warning: no files found matching '*.txt' 03:41:22 INFO - no previously-included directories found matching 'build' 03:41:22 INFO - no previously-included directories found matching 'dist' 03:41:22 INFO - no previously-included directories found matching '.git*' 03:41:22 INFO - Installing collected packages: jsonschema, functools32 03:41:22 INFO - Running setup.py install for functools32 03:41:22 INFO - warning: no files found matching '*.txt' 03:41:22 INFO - no previously-included directories found matching 'build' 03:41:22 INFO - no previously-included directories found matching 'dist' 03:41:22 INFO - no previously-included directories found matching '.git*' 03:41:22 INFO - Successfully installed jsonschema functools32 03:41:22 INFO - Cleaning up... 03:41:22 INFO - Return code: 0 03:41:22 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 03:41:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:41:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:41:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:41:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:41:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:41:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:41:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10bd7da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bd844c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd999d7ee80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bc21d30>, '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 0x10ba85db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bc18b20>, '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.dNPGw2J1yA/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.1REvZbGWT7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:41:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 03:41:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 03:41:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dNPGw2J1yA/Render', 03:41:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:41:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:41:22 INFO - 'HOME': '/Users/cltbld', 03:41:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:41:22 INFO - 'LOGNAME': 'cltbld', 03:41:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:41:22 INFO - 'MOZ_NO_REMOTE': '1', 03:41:22 INFO - 'NO_EM_RESTART': '1', 03:41:22 INFO - 'PAGER': '/bin/cat', 03:41:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:41:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:41:22 INFO - 'PWD': '/builds/slave/test', 03:41:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:41:22 INFO - 'SHELL': '/bin/bash', 03:41:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1REvZbGWT7/Listeners', 03:41:22 INFO - 'TMPDIR': '/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/', 03:41:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:41:22 INFO - 'USER': 'cltbld', 03:41:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:41:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:41:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:41:22 INFO - 'XPC_FLAGS': '0x0', 03:41:22 INFO - 'XPC_SERVICE_NAME': '0', 03:41:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:41:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:41:22 INFO - Downloading/unpacking flake8 03:41:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:41:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:41:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:41:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:41:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:41:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:41:25 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 03:41:25 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 03:41:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:41:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:41:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:41:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:41:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:41:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:41:25 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 03:41:25 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 03:41:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:41:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:41:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:41:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:41:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:41:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:41:26 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 03:41:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:41:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:41:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:41:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:41:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:41:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:41:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 03:41:26 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:41:26 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:41:26 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:41:26 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:41:26 INFO - no previously-included directories found matching 'docs/_build' 03:41:26 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 03:41:26 INFO - Running setup.py install for pep8 03:41:26 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:41:26 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:41:26 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:41:26 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:41:26 INFO - no previously-included directories found matching 'docs/_build' 03:41:26 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 03:41:26 INFO - Successfully installed flake8 mccabe pyflakes pep8 03:41:26 INFO - Cleaning up... 03:41:26 INFO - Return code: 0 03:41:26 INFO - Running post-action listener: _resource_record_post_action 03:41:26 INFO - Running post-action listener: _start_resource_monitoring 03:41:26 INFO - Starting resource monitoring. 03:41:26 INFO - ##### 03:41:26 INFO - ##### Running install step. 03:41:26 INFO - ##### 03:41:26 INFO - Running pre-action listener: _resource_record_pre_action 03:41:26 INFO - Running main action method: install 03:41:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:41:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:41:27 INFO - Reading from file tmpfile_stdout 03:41:27 INFO - Detecting whether we're running mozinstall >=1.0... 03:41:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:41:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:41:27 INFO - Reading from file tmpfile_stdout 03:41:27 INFO - Output received: 03:41:27 INFO - Usage: mozinstall [options] installer 03:41:27 INFO - Options: 03:41:27 INFO - -h, --help show this help message and exit 03:41:27 INFO - -d DEST, --destination=DEST 03:41:27 INFO - Directory to install application into. [default: 03:41:27 INFO - "/builds/slave/test"] 03:41:27 INFO - --app=APP Application being installed. [default: firefox] 03:41:27 INFO - mkdir: /builds/slave/test/build/application 03:41:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 03:41:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 03:41:59 INFO - Reading from file tmpfile_stdout 03:41:59 INFO - Output received: 03:41:59 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 03:41:59 INFO - Running post-action listener: _resource_record_post_action 03:41:59 INFO - ##### 03:41:59 INFO - ##### Running run-tests step. 03:41:59 INFO - ##### 03:41:59 INFO - Running pre-action listener: _resource_record_pre_action 03:41:59 INFO - Running main action method: run_tests 03:41:59 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:41:59 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:41:59 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:41:59 INFO - 2016-04-27 03:41:59.812 screenresolution[1638:7339] starting screenresolution argv=screenresolution get 03:41:59 INFO - 2016-04-27 03:41:59.814 screenresolution[1638:7339] Display 0: 1600x1200x32@60 03:41:59 INFO - 2016-04-27 03:41:59.819 screenresolution[1639:7341] starting screenresolution argv=screenresolution list 03:41:59 INFO - Available Modes on Display 0 03:41:59 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:41:59 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:41:59 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:41:59 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:42:00 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:42:00 INFO - Intel Iris: 03:42:00 INFO - Chipset Model: Intel Iris 03:42:00 INFO - Type: GPU 03:42:00 INFO - Bus: Built-In 03:42:00 INFO - VRAM (Dynamic, Max): 1536 MB 03:42:00 INFO - Vendor: Intel (0x8086) 03:42:00 INFO - Device ID: 0x0a2e 03:42:00 INFO - Revision ID: 0x0009 03:42:00 INFO - Displays: 03:42:00 INFO - Display: 03:42:00 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:42:00 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:42:00 INFO - Display Serial Number: 1600x1200 60 03:42:00 INFO - Main Display: Yes 03:42:00 INFO - Mirror: Off 03:42:00 INFO - Online: Yes 03:42:00 INFO - Rotation: Supported 03:42:00 INFO - Return code: 0 03:42:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:42:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:42:00 INFO - Python 2.7.3 03:42:00 INFO - Return code: 0 03:42:00 INFO - grabbing minidump binary from tooltool 03:42: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')]} 03:42:00 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: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bc21d30>, '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 0x10ba85db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bc18b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:42:00 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 03:42:00 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 03:42:00 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:42:00 INFO - Return code: 0 03:42:00 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 03:42:00 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:42:00 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:42:00 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 03:42:00 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:42:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 03:42:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 03:42:01 INFO - Return code: 0 03:42:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/SQDTyWLnRTi58-v24Lw8jQ/artifacts/public/build/firefox-47.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0154', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 03:42:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/SQDTyWLnRTi58-v24Lw8jQ/artifacts/public/build/firefox-47.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0154 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 03:42:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dNPGw2J1yA/Render', 03:42:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:42:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:42:01 INFO - 'HOME': '/Users/cltbld', 03:42:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:42:01 INFO - 'LOGNAME': 'cltbld', 03:42:01 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:42:01 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 03:42:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:42:01 INFO - 'MOZ_NO_REMOTE': '1', 03:42:01 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:42:01 INFO - 'NO_EM_RESTART': '1', 03:42:01 INFO - 'PAGER': '/bin/cat', 03:42:01 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:42:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:42:01 INFO - 'PWD': '/builds/slave/test', 03:42:01 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:42:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:42:01 INFO - 'SHELL': '/bin/bash', 03:42:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1REvZbGWT7/Listeners', 03:42:01 INFO - 'TMPDIR': '/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/', 03:42:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:42:01 INFO - 'USER': 'cltbld', 03:42:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:42:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:42:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:42:01 INFO - 'XPC_FLAGS': '0x0', 03:42:01 INFO - 'XPC_SERVICE_NAME': '0', 03:42:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:42:01 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/SQDTyWLnRTi58-v24Lw8jQ/artifacts/public/build/firefox-47.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0154', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 03:42:01 INFO - mozversion application_buildid: 20160425062348 03:42:01 INFO - mozversion application_changeset: 8551b253f4061db31e4be7829c2f70c2610caf42 03:42:01 INFO - mozversion application_display_name: FirefoxDeveloperEdition 03:42:01 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:42:01 INFO - mozversion application_name: Firefox 03:42:01 INFO - mozversion application_remotingname: firefox-dev 03:42:01 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:42:01 INFO - mozversion application_vendor: Mozilla 03:42:01 INFO - mozversion application_version: 47.0a2 03:42:01 INFO - mozversion platform_buildid: 20160425062348 03:42:01 INFO - mozversion platform_changeset: 8551b253f4061db31e4be7829c2f70c2610caf42 03:42:01 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:42:01 INFO - mozversion platform_version: 47.0a2 03:42:01 INFO - using testdate: 1461753721 03:42:01 INFO - actual date: 1461753721 03:42:01 INFO - starting webserver on 'localhost:49272' 03:42:01 INFO - SUITE-START | Running 2 tests 03:42:01 INFO - TEST-START | dromaeo_css 03:42:01 INFO - operating with platform_type : mac_ 03:42:01 INFO - Initialising browser for dromaeo_css test... 03:42:01 INFO - TEST-INFO | started process 1657 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/tmpua7vDQ/profile http://localhost:49272/getInfo.html) 03:42:04 INFO - PROCESS | 1657 | __metrics Screen width/height:1600/1200 03:42:04 INFO - PROCESS | 1657 | colorDepth:24 03:42:04 INFO - PROCESS | 1657 | Browser inner width/height: 1024/689 03:42:04 INFO - PROCESS | 1657 | __metrics 03:42:04 ERROR - PROCESS | 1657 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 03:42:05 INFO - TEST-INFO | 1657: exit 0 03:42:05 INFO - Browser initialized. 03:42:05 INFO - Running cycle 1/1 for dromaeo_css test... 03:42:05 INFO - TEST-INFO | started process 1660 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/tmpua7vDQ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:42:16 INFO - PROCESS | 1660 | RSS: Main: 218079232 03:42:16 INFO - PROCESS | 1660 | 03:43:06 INFO - PROCESS | 1660 | 1461753786587 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 03:45:17 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49272/tests/dromaeo/cssquery-ext.html) 03:45:18 INFO - PROCESS | 1660 | RSS: Main: 230146048 03:45:18 INFO - PROCESS | 1660 | 03:48:20 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-ext.html (next: http://localhost:49272/tests/dromaeo/cssquery-jquery.html) 03:48:21 INFO - PROCESS | 1660 | RSS: Main: 240521216 03:48:21 INFO - PROCESS | 1660 | 03:51:23 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49272/tests/dromaeo/cssquery-mootools.html) 03:51:23 INFO - PROCESS | 1660 | RSS: Main: 242397184 03:51:23 INFO - PROCESS | 1660 | 03:54:25 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49272/tests/dromaeo/cssquery-prototype.html) 03:54:25 INFO - PROCESS | 1660 | RSS: Main: 244957184 03:54:25 INFO - PROCESS | 1660 | 03:57:28 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49272/tests/dromaeo/cssquery-yui.html) 03:57:29 INFO - PROCESS | 1660 | RSS: Main: 247185408 03:57:29 INFO - PROCESS | 1660 | 04:00:31 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-yui.html (next: http://localhost:49272/tests/dromaeo/cssquery-dojo.html) 04:00:31 INFO - PROCESS | 1660 | RSS: Main: 248082432 04:00:31 INFO - PROCESS | 1660 | 04:00:31 INFO - PROCESS | 1660 | __start_tp_report 04:00:31 INFO - PROCESS | 1660 | _x_x_mozilla_page_load 04:00:31 INFO - PROCESS | 1660 | _x_x_mozilla_page_load_details 04:00:31 INFO - PROCESS | 1660 | |i|pagename|runs| 04:00:31 INFO - PROCESS | 1660 | |0;dojo.html;3454.5163677085206;3514.9297014059725;3527.7354198435123;3559.8398072086784;3598.7660802047867;5857.6778277194735;5868.442497962692;5876.147958546008;5877.735501902414;5893.616914900534;5830.038043722791;5841.7371218295175;5843.561732870031;5888.234529511168;5915.467607915287;5211.635185537005;5268;5274.55166310864;5292.814751483699;5294.841154765363;5158.123119069748;5286.973565132169;5288.471152884719;5313.495217954288;5315;5281.471852814707;5288.894222115556;5292.338457692788;5294.993951149269;5318.734063296839;5244.527992480676;5272.18281166416;5318.787248510055;5327.067763141474;5365.061114304981;5179.533841954205;5253.001929633358;5266.420693723688;5291.841244762663;5336.039512887679;5621.831345059655;5788.305403351583;5797.304323481209;5866.384029676865;5879.206307148523;5050.595952323805;6166.8766624667705;6197.907031394533;6226.564140510166;6232.501399887998;5217.947820521784;6196.41134092265;6255.562110652256;6269.310375858652;6273.62358258506;5679.432056794329;5919.881602367928;5973.462388385066;5979.730912108966;5981.641101533922;6309.810705678837;6345.07996340528;6354.3010268870385;6356.968215158895;6365.077063825812;6135.509159267248;6163.445289923929;6167.753289868355;6170.938290617037;6174.8147555573405;6122.4591445891365;6180.47465965398;6229.7508099676415;6243.875122497616;6267.9373206267355;6134.846628834315;6153.077038444269;6176;6185.907211391833;6200;5629.155626656035;5907.320658124285;6137.478314343241;6186.412290832363;6196.597221180609;4640.211164102111;4721.079389519011;4962.280469331927;4997.275395067695;5010.198368261061;4430.667699922518;4445.644348452116;4448.1770872388715;4468;4468.687191896601;5784.132380143013;5893.587448878623;5906.8818623627285;5925;5946.791862284799;6137.193127861533;6192.133101365813;6221.875562488815;6281.685915704288;6316.494680425647;5906.173135760997;5915.674637894957;5918;5920.4967577755515;5948.256467941507;5469.453054694499;5494.983428065821;5505.504504594605;5506.862328441821;5524.861878452991;6200.3179650238435;6312.210973628296;6340.461060809791;6373.203349581302;6385.680715964276;5164.509371609691;6255.24937007562;6301.40136687014;6304.5586808922935;6305.842353941005;6212.844678883064;6386.840328991812;6388.4569811566535;6392.3927226913365;6401.519886008661;5147.6654017488745;6182.505399567934;6210.347913469021;6261.68691565429;6275.184226050585;4939.9259011114145;6170.568060235741;6229.750809967551;6263.906041409291;6265.27949285838;6057.515398768176;6065.6663883486835;6107.816765497042;6185.288691800501;6192.907106393318;4898.975505122594;6146.6004709693725;6156.076588511759;6213.813585592439;6265.154204182377;5997.880042399041;6004.849878753066;6061.302950160788;6104.145419641342;6115.296740874678;6007.309159446545;6130.693465326626;6169.784057557964;6224.62652240867;6244.313125556095;5892.94107058924;6092.268927728701;6125.111858780363;6126.203593532812;6150.846228844314 04:00:31 INFO - PROCESS | 1660 | |1;ext.html;574.9712514374278;577.6591810831609;590.126612613332;683.7060064172407;683.7538486144987;31785.841070794642;38128.85613431602;38248.42627360588;38747;38927.80536097322;39240.60759392412;39638.801805991;39699.80150099246;40124.59875401245;40485.98785030368;9406.482643454607;9648.565814538328;9656.986016468276;9684.903150968506;9685.128338449538;9500.42997420157;9701.854472182922;9722.465264410455;9866.161376283024;9878.753031174207;9668.709938701815;9749.707508774749;9767.267454940873;9789.167920726746;9860.161886239679;9674;9717.805643887154;9727.90272097277;9732.90267097327;9820.410775353466;9348.439093654402;9453.33826632136;9457.479838608873;9483.193928516084;9531.189848862856;33644.32711345759;38522.61477385218;38954.61045389538;39012;39094.022649433995;2569.2677586887835;2915.7958942874006;3314.4034073866696;3376.8649254030056;3512.788088109598;22326.441838953993;26994.865025674746;27027.189184324503;27731.474768887703;28171.436571268663;2773.3759904021636;2808.677002144759;2818.549032154866;2895.811772234798;2915.723006314418;438109;440057;442327;443987.9999999968;445021;45811;46245.76877115593;46820;69303.96044059344;69787.30212697909;45211.773941130086;45449.772751136035;45576.8605784858;45699.31451028237;45934.62196134121;14041.71916561663;16586.419475318547;16710.248038838283;16974.32102715902;17006.064666443217;13502;13545.864541354658;13546;13594.388252528463;13599.320033998261;14543.636409089646;15108.54674359771;15213.771793423108;15258.313375898111;15345.769813452807;5550.8057217997175;6200.596961197508;6515.869682606416;6642.6014439133805;6697.799066028027;1004.4927311707687;1074.7796701676139;1096.3969816600838;1104.5250542266901;1148.1962626161721;29730.108096757132;29776;30137.69862301349;30211.395772084434;30274.243143921136;1117.2179474367974;1169.1465230381868;1197.0423661071109;1232.5562797392931;1236.33238051453;13722.382492787849;13726.382312795948;14673.633159170893;15027.023243489139;15391.461298854487;249715;252691.73654131612;253077;253468;253589;57314.42685573174;57578.136327955115;57631.847363052504;57837.13244301339;57865.71067144637;1517.355124072265;1522.3758259113931;1546.1727975533036;1556.6653169568597;1557.244736302892;29141.271468213465;29437.85281073581;29642;30037.5494367589;30049.3990120192;50328;50550.494495054576;50632.24051639155;50667.49332506628;50672.49327506678;430793.84603076783;442955;443409;444300.6709798711;446022;34079.82960085283;34512;34552.48171277383;34915;43405.34891976686;42705;46863.531364685914;47521.762391187825;48587.5141248583;49238;30532;35801;36207.45688814722;36407.271854562234;36677;36038.91883243507;36273.81863090667;36280.63719362773;36501.81749091238;36632.45051324179;34619.48070778991;36826;38611;39140.82577522679;40087;25188.496230075663;31390.843045784626;32163.195920102185;32313.676863232005;32450.675493244766;24845.254642360756;25030.749692502843;25133.748662513142;25550.74449255558;25616.871915640302 04:00:31 INFO - PROCESS | 1660 | |2;jquery.html;363.5510144970959;369.9704023678106;377.75068454819814;379.19988823582236;379.3285883985346;19347;19684.409467715974;19916.302929397472;20456.97715114242;20470.488237794063;21257.25599604014;21490.032948517313;21759.45601359963;21868.01593928273;21922;5729.3411257705275;5909.674967876765;5995.790147344844;6001.579889407722;6004.8498787530225;5780.0751879699255;5892.793752218673;5959.0763431668165;6063.454289113979;6075.301340345851;5913.970430147843;6002.579819412643;6048.727807248684;6904.413124884366;6907.963805429175;6792.490563207779;6829.248782633907;6842.281560436158;6865.176178858519;6884.9655751721175;5486.396496385394;5757.481826635623;5769.249997500298;5779.826605201851;6054.303755068136;11252.943735281271;13913.930430347784;17209.48371548843;25269;25423.11019114322;2220.544788318391;2393.533261014103;2626.6060090986316;2648.1658277642673;2812.9718702812916;9873.2101431886;9969.501524923724;10026.897041325448;10050.497475126214;10178.541965611565;1721.8278172182806;1757.323430479262;1770.283035370677;1803.7564928734585;1954.921803127873;88615.11384886134;99345;104117;109686;113086;11541.76916461666;11602;11819.054475641928;11848.163534652143;11872.881271187178;11926.165168438127;14408.927955360155;14474.927625361806;14553.78169327461;14652.487162949246;8901.955490222637;8902.065283145306;8904.59929303183;8915.42049766763;8953.149450802293;9090.727278181665;9101.635934562675;9125.954370228106;9140.588673509708;9172.724818255463;4068.4710987571425;4587.6788624795945;4599.793009314589;4629.375034370317;4630.976845115752;1708.9829101708824;1932.3140285198551;1970.1232951336804;2026.2604149485333;2026.6757318828916;857.3184318466834;869.6608322754131;899.5861903524452;1021.2646894236286;1055.984160237597;16078.839211607969;17291.39480118215;17664.293428262725;20365.287214947406;21362.78637213639;774.3882332957013;963.2486660404895;1015.8780946286493;1037.3205550364523;1078.1105587890022;10044.397336159855;11049.668509944715;11648.592299269654;11651.359175245274;11655.358955257372;538990;646812;655304;667418.3258167356;668844;96192.51903740436;106006;111187;112047;113469;1033.379972016799;1070.1385384765183;1079.5411949921252;1082.3938594387325;1082.9025387715144;18197.346012276426;18617;18954.52613684669;18973.525661858563;19217.135228915013;33326;46777.53222467732;50571.2414313793;51159.23261151011;51840.481595185076;57540;66752.66494669982;68851;68959;70112;8010.639521221442;8131.902193203841;8243.752687419386;8383.868177796163;8453.873191902003;13212.867871321549;13386.995975302087;13496.73006539844;13588.320583970959;13634.250116243305;5579.386267510652;8772.649094036167;9005.954970225106;11796.52813887435;12111.212771169845;11707.941460292644;11745.354005529778;11750.94124529372;11834.763304733684;11913.404329783303;9971.45157016371;10418.791624167323;11593.130515211562;12096.395180241128;12163.331016794162;8505.87241191395;8567.828643427221;8592.613332400182;8598.78503037429;8604.526751028754;8764.21122099014;10404.791904162026;10929.797722250705;11147.386893720923;11889.82165267539 04:00:31 INFO - PROCESS | 1660 | |3;mootools.html;1476.335648957969;1646.3826065225537;1740.0516718388476;1927.6819324811406;1940.8544359173065;8208.548529830858;8759.211670949613;8908.777280567989;9095.77260568486;9099.681511147102;8834.160754728307;8853;8918.598663060162;8938.284937205008;8977.95511022444;2494.7006359236916;2529.140092368594;2532.683414573178;2537.3402915241986;2537.949241015179;2475.4677744284977;2544.7836933860644;2546.197947646495;2554.7317531659187;2561.8462892226526;2512.5979843225086;2524.6213068039756;2537.568613335737;2555.2845203343095;2561.974380256192;2515.4717509323063;2526.090607381341;2536.7970562355154;2543.2370288913253;2544.0841297133015;2514.7610976957158;2519.5842685956795;2523.8611876346795;2540.961885571718;2552.872356382192;8996.370254082216;9081.228095611881;9084.954575227148;9085.091490850928;9096;5535.750891209865;5606.24315717377;5680.573956953203;5697.430256974311;5785;3603.531540899666;3683;3699.2601479704167;3738.5793398508663;3749.531308586427;1043.801677681238;1061.0609610494769;1062.4581463453617;1062.4634559547378;1062.8512008318842;9863.358881672668;10070.949645251727;12240.265584064895;12252.81620775689;12258.693532661666;4214.072903961123;4917.655764096479;4955.893745158365;5030.4215015272985;5053.519915608012;10279.794404111875;10361.792764144675;10394.324368916148;10418.947905260426;10454.215933804995;4855.417349918032;5598.936202121584;5604.187392828098;5608.85977850557;5615.775368985276;4500.987277862455;4697.224957881911;4817.590504807131;4932.753362331869;5077.720725360066;3981.482407287034;4064.3903414488063;4071.063655359284;4075.1034772350035;4119.6910231732145;1345.5626921250437;1347.5485712286297;1347.9797803032961;1358.7554240236852;1362.128237927727;1387.3548799808138;1411.2520364206987;1445.8771004464527;1452.1432354910653;1456.686812335353;8302.086770455246;8447.408681392366;8450.366222533334;8479.236868681848;8499.66001359951;532.1643489378921;538.8383484954498;543.8314122621999;544.5208216769217;545.2067242162644;6194.132821405007;6218.875622487525;6305.558610897285;6364.172657554488;6368.872622547523;10507.054365107177;10938.398388088572;10961.83557246642;11066.170037247239;11138.832917506244;10407.21945854064;10728.89271107279;10769.246152769387;10779.353238805697;10802.973717496825;8478.872816907751;8513.318934485227;8525.31797456202;8528.786780330542;8693.739187824376;8019.91980080215;8053.35573154158;8163.387745919199;8269.627866746132;8462.407631465738;9486.478243696663;9603.423794572349;9640;9696.903030969883;9808.313418060667;9836.704898853046;9939.353941993748;10081.596736130472;10217.948910255402;10241.948790256001;7449.8825176221835;7637.618119093912;7689.192634773492;7701.3068823806125;7730.690772369042;8405.70580029696;8414.663413463393;8436.156384361515;8436.409451338348;8533.06136325016;7378.667959941923;7488.850222995618;7549.1695913448375;7621;7658.310752032344;7301.342879140902;7335.486515943832;7351.485396022227;7484;7495.62521873915;7938.722144724907;7979.281864632211;7986.480878742863;8000.4399692021;8061.758147255592;7166.247544007804;7191.173015103121;7239.457040721862;7269.890951635624;7286.4170866329505;7334.413246940126;7352.485326027127;7390;7409.222031686595;7412.8146796328365 04:00:31 INFO - PROCESS | 1660 | |4;prototype.html;304.70595874980637;336.1512181741104;339.6111452387017;343.38705410841624;346.0863320833001;6901.723931042752;6923.065386172865;6931.861362772742;6934.618595977219;6944.618046007474;5722.227499287595;6740.32596740327;6910.274421185779;6918.169819621652;6928.96535517323;4825.758712064383;4914.557689807916;5025.497450254982;5060.418051924039;5100.795968161269;5009.6242781791325;5028.396592408916;5044.545990860822;5088.516590923857;5093.898122037557;5015.974920125394;5032.798688052473;5054.317667114948;5065.341505604266;5073.644844860862;4109.198706252282;5053.039922414748;5067.467915868818;5068.670536415139;5069.822556210552;3567.357875582394;3889;3899.966508875122;4340.197063543254;4365.236083685374;6393.3926277004075;6651.700673469705;6663.433608143314;6665.866682666319;6688.765893193763;5923.526117910556;5927.466528012456;5930.614510056833;5951.047832346804;5960.254968128984;7361.595112268823;7373.446991475661;7396.4822462427655;7407.629618519052;7426.1459932107955;4730.361401210827;4736.360591320162;4750.976245118787;4753.857384278477;4763.214069678499;7307.159676637149;7351.750202465593;7383.741569045112;7837.1379148293645;7904.565248911307;4652.13935421948;4722.173619616553;4828.493008234155;4834.250691142878;4856.368672072678;4913.31213630092;4917.9016419672125;4929.408470983505;4934.7285899275885;4937.679050861682;5886.175935369051;5888.205092312569;5900.849334379841;5907.438793314628;5920.674362910081;7382.298681625237;7389.445791565654;7392.704291828374;7402.555846649218;7406.296401841816;1640.9015459072493;1677.698014357403;1706.7695861058846;1706.8890522116023;1707.9752148710922;879.9780005499914;1081.0648788797632;1082.7996820588216;1085.8099832529276;1094.8084085285043;5409.918851217156;6750.6624668767345;6766.49251306154;6807.387335139762;6814.352636499525;7636.770896873103;7647.273509016634;7666.041744781903;7667.616619169019;7681.731139410205;6779;6797.422219111332;6807.591544507345;6816.07982922309;6845.075914751545;3730.086128898383;4043.555208927016;4064.166845796605;4073;4087.2234275487563;7814.765557033298;7834.804129896685;8013.078495972921;8058.476199047043;8082.353411727047;8019.799505012421;8023.919760802317;8041.6381262843315;8048.919510804934;8066.677332906618;5773.769049237983;7988.041435027718;8032.59837008159;8033.799155021171;8034.638441270157;7426.777196684108;7685.579042601563;7685.654145563575;7704.30661240491;7709.498882572615;7539.982102416104;7560.659770310459;7569.848603028019;7577;7590.886136707843;6831.28271531482;8059.919400805917;8074.959625201836;8078.192180781874;8080.959595202222;3957.4261732049267;4106.850081977052;4741.739204343657;4795.95204047955;4850.5149485051215;7438.070241219848;7701.653425595974;7709.730159444617;7731.188225236269;7800.219978002381;7340;7389.667464963982;7399.371053460516;7400.592967386845;7446.627668616439;6015.879682406415;6794.966025169842;7355.448341374311;7476.140243872024;7476.21499742541;7078.884083644237;7293.161286451914;7313.597752123685;7321;7333.559986400833;7372.7050917964825;7442.627868606656;7443.92556074454;7479.364254038468;7490.662920168496;7226.494145409771;7285.708571657075;7293.088363954505;7294.161171465349;7299.452541059336 04:00:31 INFO - PROCESS | 1660 | |5;yui.html;744.8473063022079;747.6000339818198;757.0877093102812;761.253971108314;776.6776787633132;15235.46675866345;15365.539033828974;15572.844271557282;15580.922095389522;15648.530544083667;14388.424463021493;14419.855801441983;14423;14442.927785361058;14477.63805904853;805.8227190018216;965.9275554333453;969.9466529340901;992.910638042576;994.607130183577;965.835807912653;971.9271054670893;985.1429256546814;988.5946761827652;989.1196834817018;1033.8139134955704;1036.9792604147913;1037.7094413564214;1038.2265212416723;1045.1012129568564;1002.5939494504737;1027.2809033676456;1030.855680204768;1034.1674951663908;1038.948052597367;753.8040109571496;766.6435107674902;779.030107516146;780.157429975625;780.5316809914063;15073.246337683073;15104.244787760677;15133.319000644888;15133.924330378388;15148.394064237416;13293.268870212134;13297.401616927262;13302.467901283937;13342.93328533361;13445.529406470825;10256.282060255786;10329.84505232422;10347.482625868677;10426.957304269588;10485.528151233213;3554.253606742587;3565.0552603560077;3574.6939100015975;3654.634536546351;3832.827522761482;80864.19135808626;81380.77928831072;82350.9999999994;82881;83310;9815.312928094965;9894.158996485236;9941.155001824925;10084.899151008396;10188.286819922534;19088.522786930436;22998.54002919932;23325.41686457852;23336.64995025076;23375.883120584287;7549.886751698729;7648.617569121521;7657.923420765721;7711.383089352838;7891.921080789233;4146.979265103655;4194.895127621834;4224;4297.871063868089;4311.353297005411;3224.2423030587793;3666.3217304798163;3706.425504046877;3720.5907350191455;3726.2361215950664;650.443870490733;666.6999850067489;668.3183153183822;670.872534218497;671.7279501801778;596.472122171881;597.4772074434869;601.0953514959957;612.6232367094206;624.5534442873368;6978.371946524837;8515;8565.186307300797;8701.912980870236;8797;531.6995897318003;548.5556699073763;581.2966310763939;585.096026638844;591.6834493545932;3931.5478719947;3980.681545476413;4012.337964235868;4022.7787471688753;4230.069384735353;95746.52126739321;96419;97015;97932;98331.01668983362;80958.19041809624;81412.37175256462;82114;82379;83722;70743.6462817693;71965.28034719691;72425.63787181031;72690.63654681799;73369;7970;8101.594920254081;8115.7159499419595;8195.344372450309;8214.63034163476;38498;46037.61887143391;48016;53451.86192552254;53572.732136339066;68351.31648683648;71728.28271717216;72613.63693181501;73488.53022939619;74169.6291518539;8460.661573537236;9628.855567166358;10096.293259471766;10473.31923424975;10629.574817007233;10926.836097458385;11026.173037022416;11417.828732568853;11464;11685.591004314809;9336.579853906454;10184.490775461345;10437.060664540228;10484.370937743759;10877.945610271898;8742.475451472932;10576.894231057591;10591.735206619896;10625.628103016357;11584.826227606762;7657.1959944205055;8609.354298427768;8627.094155113622;10286.2799604027;10706.357618542912;9029.548522573976;9145.085491450802;9169.954150229207;9200.861987070066;9372.81254374895;9103.089691030844;9129.181484086255;9222.031686672803;9270.351075424656;9290.349675522648 04:00:31 INFO - PROCESS | 1660 | __end_tp_report 04:00:31 INFO - PROCESS | 1660 | __start_cc_report 04:00:31 INFO - PROCESS | 1660 | _x_x_mozilla_cycle_collect,367 04:00:31 INFO - PROCESS | 1660 | __end_cc_report 04:00:31 INFO - PROCESS | 1660 | __startTimestamp1461754831618__endTimestamp 04:00:31 INFO - PROCESS | 1660 | 04:00:31 INFO - PROCESS | 1660 | ------- Summary: start ------- 04:00:31 INFO - PROCESS | 1660 | Number of tests: 6 04:00:31 INFO - PROCESS | 1660 | 04:00:31 INFO - PROCESS | 1660 | [#0] dojo.html Cycles:165 Average:5764.67 Median:5979.73 stddev:627.49 (10.5%) stddev-sans-first:602.68 04:00:31 INFO - PROCESS | 1660 | Values: 3454.5 3514.9 3527.7 3559.8 3598.8 5857.7 5868.4 5876.1 5877.7 5893.6 5830.0 5841.7 5843.6 5888.2 5915.5 5211.6 5268.0 5274.6 5292.8 5294.8 5158.1 5287.0 5288.5 5313.5 5315.0 5281.5 5288.9 5292.3 5295.0 5318.7 5244.5 5272.2 5318.8 5327.1 5365.1 5179.5 5253.0 5266.4 5291.8 5336.0 5621.8 5788.3 5797.3 5866.4 5879.2 5050.6 6166.9 6197.9 6226.6 6232.5 5217.9 6196.4 6255.6 6269.3 6273.6 5679.4 5919.9 5973.5 5979.7 5981.6 6309.8 6345.1 6354.3 6357.0 6365.1 6135.5 6163.4 6167.8 6170.9 6174.8 6122.5 6180.5 6229.8 6243.9 6267.9 6134.8 6153.1 6176.0 6185.9 6200.0 5629.2 5907.3 6137.5 6186.4 6196.6 4640.2 4721.1 4962.3 4997.3 5010.2 4430.7 4445.6 4448.2 4468.0 4468.7 5784.1 5893.6 5906.9 5925.0 5946.8 6137.2 6192.1 6221.9 6281.7 6316.5 5906.2 5915.7 5918.0 5920.5 5948.3 5469.5 5495.0 5505.5 5506.9 5524.9 6200.3 6312.2 6340.5 6373.2 6385.7 5164.5 6255.2 6301.4 6304.6 6305.8 6212.8 6386.8 6388.5 6392.4 6401.5 5147.7 6182.5 6210.3 6261.7 6275.2 4939.9 6170.6 6229.8 6263.9 6265.3 6057.5 6065.7 6107.8 6185.3 6192.9 4899.0 6146.6 6156.1 6213.8 6265.2 5997.9 6004.8 6061.3 6104.1 6115.3 6007.3 6130.7 6169.8 6224.6 6244.3 5892.9 6092.3 6125.1 6126.2 6150.8 04:00:31 INFO - PROCESS | 1660 | 04:00:31 INFO - PROCESS | 1660 | [#1] ext.html Cycles:180 Average:53313.54 Median:36654.73 stddev:103066.30 (281.2%) stddev-sans-first:103279.37 04:00:31 INFO - PROCESS | 1660 | Values: 575.0 577.7 590.1 683.7 683.8 31785.8 38128.9 38248.4 38747.0 38927.8 39240.6 39638.8 39699.8 40124.6 40486.0 9406.5 9648.6 9657.0 9684.9 9685.1 9500.4 9701.9 9722.5 9866.2 9878.8 9668.7 9749.7 9767.3 9789.2 9860.2 9674.0 9717.8 9727.9 9732.9 9820.4 9348.4 9453.3 9457.5 9483.2 9531.2 33644.3 38522.6 38954.6 39012.0 39094.0 2569.3 2915.8 3314.4 3376.9 3512.8 22326.4 26994.9 27027.2 27731.5 28171.4 2773.4 2808.7 2818.5 2895.8 2915.7 438109.0 440057.0 442327.0 443988.0 445021.0 45811.0 46245.8 46820.0 69304.0 69787.3 45211.8 45449.8 45576.9 45699.3 45934.6 14041.7 16586.4 16710.2 16974.3 17006.1 13502.0 13545.9 13546.0 13594.4 13599.3 14543.6 15108.5 15213.8 15258.3 15345.8 5550.8 6200.6 6515.9 6642.6 6697.8 1004.5 1074.8 1096.4 1104.5 1148.2 29730.1 29776.0 30137.7 30211.4 30274.2 1117.2 1169.1 1197.0 1232.6 1236.3 13722.4 13726.4 14673.6 15027.0 15391.5 249715.0 252691.7 253077.0 253468.0 253589.0 57314.4 57578.1 57631.8 57837.1 57865.7 1517.4 1522.4 1546.2 1556.7 1557.2 29141.3 29437.9 29642.0 30037.5 30049.4 50328.0 50550.5 50632.2 50667.5 50672.5 430793.8 442955.0 443409.0 444300.7 446022.0 34079.8 34512.0 34552.5 34915.0 43405.3 42705.0 46863.5 47521.8 48587.5 49238.0 30532.0 35801.0 36207.5 36407.3 36677.0 36038.9 36273.8 36280.6 36501.8 36632.5 34619.5 36826.0 38611.0 39140.8 40087.0 25188.5 31390.8 32163.2 32313.7 32450.7 24845.3 25030.7 25133.7 25550.7 25616.9 04:00:31 INFO - PROCESS | 1660 | 04:00:31 INFO - PROCESS | 1660 | [#2] jquery.html Cycles:180 Average:34455.39 Median:25346.06 stddev:105197.73 (415.0%) stddev-sans-first:105461.69 04:00:31 INFO - PROCESS | 1660 | Values: 363.6 370.0 377.8 379.2 379.3 19347.0 19684.4 19916.3 20457.0 20470.5 21257.3 21490.0 21759.5 21868.0 21922.0 5729.3 5909.7 5995.8 6001.6 6004.8 5780.1 5892.8 5959.1 6063.5 6075.3 5914.0 6002.6 6048.7 6904.4 6908.0 6792.5 6829.2 6842.3 6865.2 6885.0 5486.4 5757.5 5769.2 5779.8 6054.3 11252.9 13913.9 17209.5 25269.0 25423.1 2220.5 2393.5 2626.6 2648.2 2813.0 9873.2 9969.5 10026.9 10050.5 10178.5 1721.8 1757.3 1770.3 1803.8 1954.9 88615.1 99345.0 104117.0 109686.0 113086.0 11541.8 11602.0 11819.1 11848.2 11872.9 11926.2 14408.9 14474.9 14553.8 14652.5 8902.0 8902.1 8904.6 8915.4 8953.1 9090.7 9101.6 9126.0 9140.6 9172.7 4068.5 4587.7 4599.8 4629.4 4631.0 1709.0 1932.3 1970.1 2026.3 2026.7 857.3 869.7 899.6 1021.3 1056.0 16078.8 17291.4 17664.3 20365.3 21362.8 774.4 963.2 1015.9 1037.3 1078.1 10044.4 11049.7 11648.6 11651.4 11655.4 538990.0 646812.0 655304.0 667418.3 668844.0 96192.5 106006.0 111187.0 112047.0 113469.0 1033.4 1070.1 1079.5 1082.4 1082.9 18197.3 18617.0 18954.5 18973.5 19217.1 33326.0 46777.5 50571.2 51159.2 51840.5 57540.0 66752.7 68851.0 68959.0 70112.0 8010.6 8131.9 8243.8 8383.9 8453.9 13212.9 13387.0 13496.7 13588.3 13634.3 5579.4 8772.6 9006.0 11796.5 12111.2 11707.9 11745.4 11750.9 11834.8 11913.4 9971.5 10418.8 11593.1 12096.4 12163.3 8505.9 8567.8 8592.6 8598.8 8604.5 8764.2 10404.8 10929.8 11147.4 11889.8 04:00:31 INFO - PROCESS | 1660 | 04:00:31 INFO - PROCESS | 1660 | [#3] mootools.html Cycles:180 Average:6173.23 Median:544.18 stddev:3237.24 (594.9%) stddev-sans-first:3227.06 04:00:31 INFO - PROCESS | 1660 | Values: 1476.3 1646.4 1740.1 1927.7 1940.9 8208.5 8759.2 8908.8 9095.8 9099.7 8834.2 8853.0 8918.6 8938.3 8978.0 2494.7 2529.1 2532.7 2537.3 2537.9 2475.5 2544.8 2546.2 2554.7 2561.8 2512.6 2524.6 2537.6 2555.3 2562.0 2515.5 2526.1 2536.8 2543.2 2544.1 2514.8 2519.6 2523.9 2541.0 2552.9 8996.4 9081.2 9085.0 9085.1 9096.0 5535.8 5606.2 5680.6 5697.4 5785.0 3603.5 3683.0 3699.3 3738.6 3749.5 1043.8 1061.1 1062.5 1062.5 1062.9 9863.4 10070.9 12240.3 12252.8 12258.7 4214.1 4917.7 4955.9 5030.4 5053.5 10279.8 10361.8 10394.3 10418.9 10454.2 4855.4 5598.9 5604.2 5608.9 5615.8 4501.0 4697.2 4817.6 4932.8 5077.7 3981.5 4064.4 4071.1 4075.1 4119.7 1345.6 1347.5 1348.0 1358.8 1362.1 1387.4 1411.3 1445.9 1452.1 1456.7 8302.1 8447.4 8450.4 8479.2 8499.7 532.2 538.8 543.8 544.5 545.2 6194.1 6218.9 6305.6 6364.2 6368.9 10507.1 10938.4 10961.8 11066.2 11138.8 10407.2 10728.9 10769.2 10779.4 10803.0 8478.9 8513.3 8525.3 8528.8 8693.7 8019.9 8053.4 8163.4 8269.6 8462.4 9486.5 9603.4 9640.0 9696.9 9808.3 9836.7 9939.4 10081.6 10217.9 10241.9 7449.9 7637.6 7689.2 7701.3 7730.7 8405.7 8414.7 8436.2 8436.4 8533.1 7378.7 7488.9 7549.2 7621.0 7658.3 7301.3 7335.5 7351.5 7484.0 7495.6 7938.7 7979.3 7986.5 8000.4 8061.8 7166.2 7191.2 7239.5 7269.9 7286.4 7334.4 7352.5 7390.0 7409.2 7412.8 04:00:31 INFO - PROCESS | 1660 | 04:00:31 INFO - PROCESS | 1660 | [#4] prototype.html Cycles:180 Average:6000.72 Median:6810.97 stddev:1963.33 (28.8%) stddev-sans-first:1921.73 04:00:31 INFO - PROCESS | 1660 | Values: 304.7 336.2 339.6 343.4 346.1 6901.7 6923.1 6931.9 6934.6 6944.6 5722.2 6740.3 6910.3 6918.2 6929.0 4825.8 4914.6 5025.5 5060.4 5100.8 5009.6 5028.4 5044.5 5088.5 5093.9 5016.0 5032.8 5054.3 5065.3 5073.6 4109.2 5053.0 5067.5 5068.7 5069.8 3567.4 3889.0 3900.0 4340.2 4365.2 6393.4 6651.7 6663.4 6665.9 6688.8 5923.5 5927.5 5930.6 5951.0 5960.3 7361.6 7373.4 7396.5 7407.6 7426.1 4730.4 4736.4 4751.0 4753.9 4763.2 7307.2 7351.8 7383.7 7837.1 7904.6 4652.1 4722.2 4828.5 4834.3 4856.4 4913.3 4917.9 4929.4 4934.7 4937.7 5886.2 5888.2 5900.8 5907.4 5920.7 7382.3 7389.4 7392.7 7402.6 7406.3 1640.9 1677.7 1706.8 1706.9 1708.0 880.0 1081.1 1082.8 1085.8 1094.8 5409.9 6750.7 6766.5 6807.4 6814.4 7636.8 7647.3 7666.0 7667.6 7681.7 6779.0 6797.4 6807.6 6816.1 6845.1 3730.1 4043.6 4064.2 4073.0 4087.2 7814.8 7834.8 8013.1 8058.5 8082.4 8019.8 8023.9 8041.6 8048.9 8066.7 5773.8 7988.0 8032.6 8033.8 8034.6 7426.8 7685.6 7685.7 7704.3 7709.5 7540.0 7560.7 7569.8 7577.0 7590.9 6831.3 8059.9 8075.0 8078.2 8081.0 3957.4 4106.9 4741.7 4796.0 4850.5 7438.1 7701.7 7709.7 7731.2 7800.2 7340.0 7389.7 7399.4 7400.6 7446.6 6015.9 6795.0 7355.4 7476.1 7476.2 7078.9 7293.2 7313.6 7321.0 7333.6 7372.7 7442.6 7443.9 7479.4 7490.7 7226.5 7285.7 7293.1 7294.2 7299.5 04:00:31 INFO - PROCESS | 1660 | 04:00:31 INFO - PROCESS | 1660 | [#5] yui.html Cycles:180 Average:18642.93 Median:596.97 stddev:26781.87 (4486.3%) stddev-sans-first:26823.28 04:00:31 INFO - PROCESS | 1660 | Values: 744.8 747.6 757.1 761.3 776.7 15235.5 15365.5 15572.8 15580.9 15648.5 14388.4 14419.9 14423.0 14442.9 14477.6 805.8 965.9 969.9 992.9 994.6 965.8 971.9 985.1 988.6 989.1 1033.8 1037.0 1037.7 1038.2 1045.1 1002.6 1027.3 1030.9 1034.2 1038.9 753.8 766.6 779.0 780.2 780.5 15073.2 15104.2 15133.3 15133.9 15148.4 13293.3 13297.4 13302.5 13342.9 13445.5 10256.3 10329.8 10347.5 10427.0 10485.5 3554.3 3565.1 3574.7 3654.6 3832.8 80864.2 81380.8 82351.0 82881.0 83310.0 9815.3 9894.2 9941.2 10084.9 10188.3 19088.5 22998.5 23325.4 23336.6 23375.9 7549.9 7648.6 7657.9 7711.4 7891.9 4147.0 4194.9 4224.0 4297.9 4311.4 3224.2 3666.3 3706.4 3720.6 3726.2 650.4 666.7 668.3 670.9 671.7 596.5 597.5 601.1 612.6 624.6 6978.4 8515.0 8565.2 8701.9 8797.0 531.7 548.6 581.3 585.1 591.7 3931.5 3980.7 4012.3 4022.8 4230.1 95746.5 96419.0 97015.0 97932.0 98331.0 80958.2 81412.4 82114.0 82379.0 83722.0 70743.6 71965.3 72425.6 72690.6 73369.0 7970.0 8101.6 8115.7 8195.3 8214.6 38498.0 46037.6 48016.0 53451.9 53572.7 68351.3 71728.3 72613.6 73488.5 74169.6 8460.7 9628.9 10096.3 10473.3 10629.6 10926.8 11026.2 11417.8 11464.0 11685.6 9336.6 10184.5 10437.1 10484.4 10877.9 8742.5 10576.9 10591.7 10625.6 11584.8 7657.2 8609.4 8627.1 10286.3 10706.4 9029.5 9145.1 9170.0 9200.9 9372.8 9103.1 9129.2 9222.0 9270.4 9290.3 04:00:31 INFO - PROCESS | 1660 | -------- Summary: end -------- 04:00:31 INFO - PROCESS | 1660 | 04:00:32 INFO - TEST-INFO | 1660: exit 0 04:00:32 INFO - TEST-OK | dromaeo_css | took 1110553ms 04:00:32 INFO - TEST-START | kraken 04:00:32 INFO - operating with platform_type : mac_ 04:00:32 INFO - Initialising browser for kraken test... 04:00:32 INFO - TEST-INFO | started process 1676 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/tmp84JqTD/profile http://localhost:49272/getInfo.html) 04:00:34 INFO - PROCESS | 1676 | __metrics Screen width/height:1600/1200 04:00:34 INFO - PROCESS | 1676 | colorDepth:24 04:00:34 INFO - PROCESS | 1676 | Browser inner width/height: 1024/689 04:00:34 INFO - PROCESS | 1676 | __metrics 04:00:34 ERROR - PROCESS | 1676 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 04:00:35 INFO - TEST-INFO | 1676: exit 0 04:00:35 INFO - Browser initialized. 04:00:35 INFO - Running cycle 1/1 for kraken test... 04:00:35 INFO - TEST-INFO | started process 1679 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/tmp84JqTD/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:00:47 INFO - PROCESS | 1679 | RSS: Main: 217862144 04:00:47 INFO - PROCESS | 1679 | 04:00:50 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-beat-detection) 04:00:50 INFO - PROCESS | 1679 | RSS: Main: 230326272 04:00:50 INFO - PROCESS | 1679 | 04:00:53 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-dft) 04:00:54 INFO - PROCESS | 1679 | RSS: Main: 240029696 04:00:54 INFO - PROCESS | 1679 | 04:00:57 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-fft) 04:00:57 INFO - PROCESS | 1679 | RSS: Main: 243220480 04:00:57 INFO - PROCESS | 1679 | 04:00:59 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-oscillator) 04:01:00 INFO - PROCESS | 1679 | RSS: Main: 243666944 04:01:00 INFO - PROCESS | 1679 | 04:01:02 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:01:03 INFO - PROCESS | 1679 | RSS: Main: 243912704 04:01:03 INFO - PROCESS | 1679 | 04:01:06 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-darkroom) 04:01:06 INFO - PROCESS | 1679 | RSS: Main: 243888128 04:01:06 INFO - PROCESS | 1679 | 04:01:09 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-desaturate) 04:01:10 INFO - PROCESS | 1679 | RSS: Main: 243752960 04:01:10 INFO - PROCESS | 1679 | 04:01:12 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49272/tests/kraken/driver.html?testName=json-parse-financial) 04:01:13 INFO - PROCESS | 1679 | RSS: Main: 244682752 04:01:13 INFO - PROCESS | 1679 | 04:01:15 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49272/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:01:15 INFO - PROCESS | 1679 | RSS: Main: 244736000 04:01:15 INFO - PROCESS | 1679 | 04:01:17 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:01:18 INFO - PROCESS | 1679 | RSS: Main: 245338112 04:01:18 INFO - PROCESS | 1679 | 04:01:20 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:01:20 INFO - PROCESS | 1679 | RSS: Main: 244858880 04:01:20 INFO - PROCESS | 1679 | 04:01:23 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:01:24 INFO - PROCESS | 1679 | RSS: Main: 244805632 04:01:24 INFO - PROCESS | 1679 | 04:01:26 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:01:27 INFO - PROCESS | 1679 | RSS: Main: 244985856 04:01:27 INFO - PROCESS | 1679 | 04:01:29 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49272/tests/kraken/driver.html?testName=ai-astar) 04:01:29 INFO - PROCESS | 1679 | RSS: Main: 246751232 04:01:29 INFO - PROCESS | 1679 | 04:01:29 INFO - PROCESS | 1679 | __start_tp_report 04:01:29 INFO - PROCESS | 1679 | _x_x_mozilla_page_load 04:01:29 INFO - PROCESS | 1679 | _x_x_mozilla_page_load_details 04:01:29 INFO - PROCESS | 1679 | |i|pagename|runs| 04:01:29 INFO - PROCESS | 1679 | |0;ai-astar;116;123;122;112;114;128;125;102;168;167 04:01:29 INFO - PROCESS | 1679 | |1;audio-beat-detection;146;117;154;147;125;170;142;108;191;153 04:01:29 INFO - PROCESS | 1679 | |2;audio-dft;192;193;195;202;200;193;195;196;202;199 04:01:29 INFO - PROCESS | 1679 | |3;audio-fft;72;75;76;113;50;70;82;86;156;47 04:01:29 INFO - PROCESS | 1679 | |4;audio-oscillator;120;77;125;80;79;82;121;79;79;119 04:01:29 INFO - PROCESS | 1679 | |5;imaging-gaussian-blur;87;86;89;88;103;85;76;129;134;91 04:01:29 INFO - PROCESS | 1679 | |6;imaging-darkroom;93;95;94;94;95;94;93;96;94;94 04:01:29 INFO - PROCESS | 1679 | |7;imaging-desaturate;115;91;94;90;92;92;85;80;81;148 04:01:29 INFO - PROCESS | 1679 | |8;json-parse-financial;54;59;61;57;59;60;61;72;78;81 04:01:29 INFO - PROCESS | 1679 | |9;json-stringify-tinderbox;75;60;73;68;69;73;69;91;59;66 04:01:29 INFO - PROCESS | 1679 | |10;stanford-crypto-aes;105;108;109;106;82;83;82;81;84;89 04:01:29 INFO - PROCESS | 1679 | |11;stanford-crypto-ccm;118;122;122;123;137;134;138;119;118;122 04:01:29 INFO - PROCESS | 1679 | |12;stanford-crypto-pbkdf2;126;140;147;174;170;131;136;135;138;141 04:01:29 INFO - PROCESS | 1679 | |13;stanford-crypto-sha256-iterative;72;87;100;77;64;65;83;96;96;98 04:01:29 INFO - PROCESS | 1679 | __end_tp_report 04:01:29 INFO - PROCESS | 1679 | __start_cc_report 04:01:29 INFO - PROCESS | 1679 | _x_x_mozilla_cycle_collect,929 04:01:29 INFO - PROCESS | 1679 | __end_cc_report 04:01:29 INFO - PROCESS | 1679 | __startTimestamp1461754889277__endTimestamp 04:01:29 INFO - PROCESS | 1679 | 04:01:29 INFO - PROCESS | 1679 | ------- Summary: start ------- 04:01:29 INFO - PROCESS | 1679 | Number of tests: 14 04:01:29 INFO - PROCESS | 1679 | 04:01:29 INFO - PROCESS | 1679 | [#0] ai-astar Cycles:10 Average:127.70 Median:124.00 stddev:22.27 (18.0%) stddev-sans-first:23.21 04:01:29 INFO - PROCESS | 1679 | Values: 116.0 123.0 122.0 112.0 114.0 128.0 125.0 102.0 168.0 167.0 04:01:29 INFO - PROCESS | 1679 | 04:01:29 INFO - PROCESS | 1679 | [#1] audio-beat-detection Cycles:10 Average:145.30 Median:150.00 stddev:24.61 (16.4%) stddev-sans-first:26.10 04:01:29 INFO - PROCESS | 1679 | Values: 146.0 117.0 154.0 147.0 125.0 170.0 142.0 108.0 191.0 153.0 04:01:29 INFO - PROCESS | 1679 | 04:01:29 INFO - PROCESS | 1679 | [#2] audio-dft Cycles:10 Average:196.70 Median:197.50 stddev:3.77 (1.9%) stddev-sans-first:3.60 04:01:29 INFO - PROCESS | 1679 | Values: 192.0 193.0 195.0 202.0 200.0 193.0 195.0 196.0 202.0 199.0 04:01:29 INFO - PROCESS | 1679 | 04:01:29 INFO - PROCESS | 1679 | [#3] audio-fft Cycles:10 Average:82.70 Median:73.50 stddev:31.67 (43.1%) stddev-sans-first:33.35 04:01:29 INFO - PROCESS | 1679 | Values: 72.0 75.0 76.0 113.0 50.0 70.0 82.0 86.0 156.0 47.0 04:01:29 INFO - PROCESS | 1679 | 04:01:29 INFO - PROCESS | 1679 | [#4] audio-oscillator Cycles:10 Average:96.10 Median:79.00 stddev:21.73 (27.5%) stddev-sans-first:21.26 04:01:29 INFO - PROCESS | 1679 | Values: 120.0 77.0 125.0 80.0 79.0 82.0 121.0 79.0 79.0 119.0 04:01:29 INFO - PROCESS | 1679 | 04:01:29 INFO - PROCESS | 1679 | [#5] imaging-gaussian-blur Cycles:10 Average:96.80 Median:86.50 stddev:19.48 (22.5%) stddev-sans-first:20.34 04:01:29 INFO - PROCESS | 1679 | Values: 87.0 86.0 89.0 88.0 103.0 85.0 76.0 129.0 134.0 91.0 04:01:29 INFO - PROCESS | 1679 | 04:01:29 INFO - PROCESS | 1679 | [#6] imaging-darkroom Cycles:10 Average:94.20 Median:94.00 stddev:0.92 (1.0%) stddev-sans-first:0.87 04:01:29 INFO - PROCESS | 1679 | Values: 93.0 95.0 94.0 94.0 95.0 94.0 93.0 96.0 94.0 94.0 04:01:29 INFO - PROCESS | 1679 | 04:01:29 INFO - PROCESS | 1679 | [#7] imaging-desaturate Cycles:10 Average:96.80 Median:90.50 stddev:20.43 (22.6%) stddev-sans-first:20.58 04:01:29 INFO - PROCESS | 1679 | Values: 115.0 91.0 94.0 90.0 92.0 92.0 85.0 80.0 81.0 148.0 04:01:29 INFO - PROCESS | 1679 | 04:01:29 INFO - PROCESS | 1679 | [#8] json-parse-financial Cycles:10 Average:64.20 Median:61.00 stddev:9.32 (15.3%) stddev-sans-first:9.12 04:01:29 INFO - PROCESS | 1679 | Values: 54.0 59.0 61.0 57.0 59.0 60.0 61.0 72.0 78.0 81.0 04:01:29 INFO - PROCESS | 1679 | 04:01:29 INFO - PROCESS | 1679 | [#9] json-stringify-tinderbox Cycles:10 Average:70.30 Median:71.00 stddev:8.98 (12.7%) stddev-sans-first:9.36 04:01:29 INFO - PROCESS | 1679 | Values: 75.0 60.0 73.0 68.0 69.0 73.0 69.0 91.0 59.0 66.0 04:01:29 INFO - PROCESS | 1679 | 04:01:29 INFO - PROCESS | 1679 | [#10] stanford-crypto-aes Cycles:10 Average:92.90 Median:82.00 stddev:12.37 (15.1%) stddev-sans-first:12.32 04:01:29 INFO - PROCESS | 1679 | Values: 105.0 108.0 109.0 106.0 82.0 83.0 82.0 81.0 84.0 89.0 04:01:29 INFO - PROCESS | 1679 | 04:01:29 INFO - PROCESS | 1679 | [#11] stanford-crypto-ccm Cycles:10 Average:125.30 Median:122.50 stddev:7.87 (6.4%) stddev-sans-first:7.90 04:01:29 INFO - PROCESS | 1679 | Values: 118.0 122.0 122.0 123.0 137.0 134.0 138.0 119.0 118.0 122.0 04:01:29 INFO - PROCESS | 1679 | 04:01:29 INFO - PROCESS | 1679 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:143.80 Median:140.50 stddev:15.93 (11.3%) stddev-sans-first:15.54 04:01:29 INFO - PROCESS | 1679 | Values: 126.0 140.0 147.0 174.0 170.0 131.0 136.0 135.0 138.0 141.0 04:01:29 INFO - PROCESS | 1679 | 04:01:29 INFO - PROCESS | 1679 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:83.80 Median:85.00 stddev:13.76 (16.2%) stddev-sans-first:13.91 04:01:29 INFO - PROCESS | 1679 | Values: 72.0 87.0 100.0 77.0 64.0 65.0 83.0 96.0 96.0 98.0 04:01:29 INFO - PROCESS | 1679 | -------- Summary: end -------- 04:01:29 INFO - PROCESS | 1679 | 04:01:29 INFO - TEST-INFO | 1679: exit 0 04:01:30 INFO - TEST-OK | kraken | took 57887ms 04:01:30 INFO - SUITE-END | took 1168s 04:01:30 INFO - Completed test suite (00:19:28) 04:01:30 INFO - javascript benchmark 04:01:30 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3454.5163677085206, 3514.9297014059725, 3527.7354198435123, 3559.8398072086784, 3598.7660802047867, 5857.6778277194735, 5868.442497962692, 5876.147958546008, 5877.735501902414, 5893.616914900534, 5830.038043722791, 5841.7371218295175, 5843.561732870031, 5888.234529511168, 5915.467607915287, 5211.635185537005, 5268.0, 5274.55166310864, 5292.814751483699, 5294.841154765363, 5158.123119069748, 5286.973565132169, 5288.471152884719, 5313.495217954288, 5315.0, 5281.471852814707, 5288.894222115556, 5292.338457692788, 5294.993951149269, 5318.734063296839, 5244.527992480676, 5272.18281166416, 5318.787248510055, 5327.067763141474, 5365.061114304981, 5179.533841954205, 5253.001929633358, 5266.420693723688, 5291.841244762663, 5336.039512887679, 5621.831345059655, 5788.305403351583, 5797.304323481209, 5866.384029676865, 5879.206307148523, 5050.595952323805, 6166.8766624667705, 6197.907031394533, 6226.564140510166, 6232.501399887998, 5217.947820521784, 6196.41134092265, 6255.562110652256, 6269.310375858652, 6273.62358258506, 5679.432056794329, 5919.881602367928, 5973.462388385066, 5979.730912108966, 5981.641101533922, 6309.810705678837, 6345.07996340528, 6354.3010268870385, 6356.968215158895, 6365.077063825812, 6135.509159267248, 6163.445289923929, 6167.753289868355, 6170.938290617037, 6174.8147555573405, 6122.4591445891365, 6180.47465965398, 6229.7508099676415, 6243.875122497616, 6267.9373206267355, 6134.846628834315, 6153.077038444269, 6176.0, 6185.907211391833, 6200.0, 5629.155626656035, 5907.320658124285, 6137.478314343241, 6186.412290832363, 6196.597221180609, 4640.211164102111, 4721.079389519011, 4962.280469331927, 4997.275395067695, 5010.198368261061, 4430.667699922518, 4445.644348452116, 4448.1770872388715, 4468.0, 4468.687191896601, 5784.132380143013, 5893.587448878623, 5906.8818623627285, 5925.0, 5946.791862284799, 6137.193127861533, 6192.133101365813, 6221.875562488815, 6281.685915704288, 6316.494680425647, 5906.173135760997, 5915.674637894957, 5918.0, 5920.4967577755515, 5948.256467941507, 5469.453054694499, 5494.983428065821, 5505.504504594605, 5506.862328441821, 5524.861878452991, 6200.3179650238435, 6312.210973628296, 6340.461060809791, 6373.203349581302, 6385.680715964276, 5164.509371609691, 6255.24937007562, 6301.40136687014, 6304.5586808922935, 6305.842353941005, 6212.844678883064, 6386.840328991812, 6388.4569811566535, 6392.3927226913365, 6401.519886008661, 5147.6654017488745, 6182.505399567934, 6210.347913469021, 6261.68691565429, 6275.184226050585, 4939.9259011114145, 6170.568060235741, 6229.750809967551, 6263.906041409291, 6265.27949285838, 6057.515398768176, 6065.6663883486835, 6107.816765497042, 6185.288691800501, 6192.907106393318, 4898.975505122594, 6146.6004709693725, 6156.076588511759, 6213.813585592439, 6265.154204182377, 5997.880042399041, 6004.849878753066, 6061.302950160788, 6104.145419641342, 6115.296740874678, 6007.309159446545, 6130.693465326626, 6169.784057557964, 6224.62652240867, 6244.313125556095, 5892.94107058924, 6092.268927728701, 6125.111858780363, 6126.203593532812, 6150.846228844314], "unit": "score", "name": "dojo.html", "value": 5728.938050815658}, {"lowerIsBetter": false, "replicates": [574.9712514374278, 577.6591810831609, 590.126612613332, 683.7060064172407, 683.7538486144987, 31785.841070794642, 38128.85613431602, 38248.42627360588, 38747.0, 38927.80536097322, 39240.60759392412, 39638.801805991, 39699.80150099246, 40124.59875401245, 40485.98785030368, 9406.482643454607, 9648.565814538328, 9656.986016468276, 9684.903150968506, 9685.128338449538, 9500.42997420157, 9701.854472182922, 9722.465264410455, 9866.161376283024, 9878.753031174207, 9668.709938701815, 9749.707508774749, 9767.267454940873, 9789.167920726746, 9860.161886239679, 9674.0, 9717.805643887154, 9727.90272097277, 9732.90267097327, 9820.410775353466, 9348.439093654402, 9453.33826632136, 9457.479838608873, 9483.193928516084, 9531.189848862856, 33644.32711345759, 38522.61477385218, 38954.61045389538, 39012.0, 39094.022649433995, 2569.2677586887835, 2915.7958942874006, 3314.4034073866696, 3376.8649254030056, 3512.788088109598, 22326.441838953993, 26994.865025674746, 27027.189184324503, 27731.474768887703, 28171.436571268663, 2773.3759904021636, 2808.677002144759, 2818.549032154866, 2895.811772234798, 2915.723006314418, 438109.0, 440057.0, 442327.0, 443987.9999999968, 445021.0, 45811.0, 46245.76877115593, 46820.0, 69303.96044059344, 69787.30212697909, 45211.773941130086, 45449.772751136035, 45576.8605784858, 45699.31451028237, 45934.62196134121, 14041.71916561663, 16586.419475318547, 16710.248038838283, 16974.32102715902, 17006.064666443217, 13502.0, 13545.864541354658, 13546.0, 13594.388252528463, 13599.320033998261, 14543.636409089646, 15108.54674359771, 15213.771793423108, 15258.313375898111, 15345.769813452807, 5550.8057217997175, 6200.596961197508, 6515.869682606416, 6642.6014439133805, 6697.799066028027, 1004.4927311707687, 1074.7796701676139, 1096.3969816600838, 1104.5250542266901, 1148.1962626161721, 29730.108096757132, 29776.0, 30137.69862301349, 30211.395772084434, 30274.243143921136, 1117.2179474367974, 1169.1465230381868, 1197.0423661071109, 1232.5562797392931, 1236.33238051453, 13722.382492787849, 13726.382312795948, 14673.633159170893, 15027.023243489139, 15391.461298854487, 249715.0, 252691.73654131612, 253077.0, 253468.0, 253589.0, 57314.42685573174, 57578.136327955115, 57631.847363052504, 57837.13244301339, 57865.71067144637, 1517.355124072265, 1522.3758259113931, 1546.1727975533036, 1556.6653169568597, 1557.244736302892, 29141.271468213465, 29437.85281073581, 29642.0, 30037.5494367589, 30049.3990120192, 50328.0, 50550.494495054576, 50632.24051639155, 50667.49332506628, 50672.49327506678, 430793.84603076783, 442955.0, 443409.0, 444300.6709798711, 446022.0, 34079.82960085283, 34512.0, 34552.48171277383, 34915.0, 43405.34891976686, 42705.0, 46863.531364685914, 47521.762391187825, 48587.5141248583, 49238.0, 30532.0, 35801.0, 36207.45688814722, 36407.271854562234, 36677.0, 36038.91883243507, 36273.81863090667, 36280.63719362773, 36501.81749091238, 36632.45051324179, 34619.48070778991, 36826.0, 38611.0, 39140.82577522679, 40087.0, 25188.496230075663, 31390.843045784626, 32163.195920102185, 32313.676863232005, 32450.675493244766, 24845.254642360756, 25030.749692502843, 25133.748662513142, 25550.74449255558, 25616.871915640302], "unit": "score", "name": "ext.html", "value": 18886.233510585913}, {"lowerIsBetter": false, "replicates": [363.5510144970959, 369.9704023678106, 377.75068454819814, 379.19988823582236, 379.3285883985346, 19347.0, 19684.409467715974, 19916.302929397472, 20456.97715114242, 20470.488237794063, 21257.25599604014, 21490.032948517313, 21759.45601359963, 21868.01593928273, 21922.0, 5729.3411257705275, 5909.674967876765, 5995.790147344844, 6001.579889407722, 6004.8498787530225, 5780.0751879699255, 5892.793752218673, 5959.0763431668165, 6063.454289113979, 6075.301340345851, 5913.970430147843, 6002.579819412643, 6048.727807248684, 6904.413124884366, 6907.963805429175, 6792.490563207779, 6829.248782633907, 6842.281560436158, 6865.176178858519, 6884.9655751721175, 5486.396496385394, 5757.481826635623, 5769.249997500298, 5779.826605201851, 6054.303755068136, 11252.943735281271, 13913.930430347784, 17209.48371548843, 25269.0, 25423.11019114322, 2220.544788318391, 2393.533261014103, 2626.6060090986316, 2648.1658277642673, 2812.9718702812916, 9873.2101431886, 9969.501524923724, 10026.897041325448, 10050.497475126214, 10178.541965611565, 1721.8278172182806, 1757.323430479262, 1770.283035370677, 1803.7564928734585, 1954.921803127873, 88615.11384886134, 99345.0, 104117.0, 109686.0, 113086.0, 11541.76916461666, 11602.0, 11819.054475641928, 11848.163534652143, 11872.881271187178, 11926.165168438127, 14408.927955360155, 14474.927625361806, 14553.78169327461, 14652.487162949246, 8901.955490222637, 8902.065283145306, 8904.59929303183, 8915.42049766763, 8953.149450802293, 9090.727278181665, 9101.635934562675, 9125.954370228106, 9140.588673509708, 9172.724818255463, 4068.4710987571425, 4587.6788624795945, 4599.793009314589, 4629.375034370317, 4630.976845115752, 1708.9829101708824, 1932.3140285198551, 1970.1232951336804, 2026.2604149485333, 2026.6757318828916, 857.3184318466834, 869.6608322754131, 899.5861903524452, 1021.2646894236286, 1055.984160237597, 16078.839211607969, 17291.39480118215, 17664.293428262725, 20365.287214947406, 21362.78637213639, 774.3882332957013, 963.2486660404895, 1015.8780946286493, 1037.3205550364523, 1078.1105587890022, 10044.397336159855, 11049.668509944715, 11648.592299269654, 11651.359175245274, 11655.358955257372, 538990.0, 646812.0, 655304.0, 667418.3258167356, 668844.0, 96192.51903740436, 106006.0, 111187.0, 112047.0, 113469.0, 1033.379972016799, 1070.1385384765183, 1079.5411949921252, 1082.3938594387325, 1082.9025387715144, 18197.346012276426, 18617.0, 18954.52613684669, 18973.525661858563, 19217.135228915013, 33326.0, 46777.53222467732, 50571.2414313793, 51159.23261151011, 51840.481595185076, 57540.0, 66752.66494669982, 68851.0, 68959.0, 70112.0, 8010.639521221442, 8131.902193203841, 8243.752687419386, 8383.868177796163, 8453.873191902003, 13212.867871321549, 13386.995975302087, 13496.73006539844, 13588.320583970959, 13634.250116243305, 5579.386267510652, 8772.649094036167, 9005.954970225106, 11796.52813887435, 12111.212771169845, 11707.941460292644, 11745.354005529778, 11750.94124529372, 11834.763304733684, 11913.404329783303, 9971.45157016371, 10418.791624167323, 11593.130515211562, 12096.395180241128, 12163.331016794162, 8505.87241191395, 8567.828643427221, 8592.613332400182, 8598.78503037429, 8604.526751028754, 8764.21122099014, 10404.791904162026, 10929.797722250705, 11147.386893720923, 11889.82165267539], "unit": "score", "name": "jquery.html", "value": 9490.72315036499}, {"lowerIsBetter": false, "replicates": [1476.335648957969, 1646.3826065225537, 1740.0516718388476, 1927.6819324811406, 1940.8544359173065, 8208.548529830858, 8759.211670949613, 8908.777280567989, 9095.77260568486, 9099.681511147102, 8834.160754728307, 8853.0, 8918.598663060162, 8938.284937205008, 8977.95511022444, 2494.7006359236916, 2529.140092368594, 2532.683414573178, 2537.3402915241986, 2537.949241015179, 2475.4677744284977, 2544.7836933860644, 2546.197947646495, 2554.7317531659187, 2561.8462892226526, 2512.5979843225086, 2524.6213068039756, 2537.568613335737, 2555.2845203343095, 2561.974380256192, 2515.4717509323063, 2526.090607381341, 2536.7970562355154, 2543.2370288913253, 2544.0841297133015, 2514.7610976957158, 2519.5842685956795, 2523.8611876346795, 2540.961885571718, 2552.872356382192, 8996.370254082216, 9081.228095611881, 9084.954575227148, 9085.091490850928, 9096.0, 5535.750891209865, 5606.24315717377, 5680.573956953203, 5697.430256974311, 5785.0, 3603.531540899666, 3683.0, 3699.2601479704167, 3738.5793398508663, 3749.531308586427, 1043.801677681238, 1061.0609610494769, 1062.4581463453617, 1062.4634559547378, 1062.8512008318842, 9863.358881672668, 10070.949645251727, 12240.265584064895, 12252.81620775689, 12258.693532661666, 4214.072903961123, 4917.655764096479, 4955.893745158365, 5030.4215015272985, 5053.519915608012, 10279.794404111875, 10361.792764144675, 10394.324368916148, 10418.947905260426, 10454.215933804995, 4855.417349918032, 5598.936202121584, 5604.187392828098, 5608.85977850557, 5615.775368985276, 4500.987277862455, 4697.224957881911, 4817.590504807131, 4932.753362331869, 5077.720725360066, 3981.482407287034, 4064.3903414488063, 4071.063655359284, 4075.1034772350035, 4119.6910231732145, 1345.5626921250437, 1347.5485712286297, 1347.9797803032961, 1358.7554240236852, 1362.128237927727, 1387.3548799808138, 1411.2520364206987, 1445.8771004464527, 1452.1432354910653, 1456.686812335353, 8302.086770455246, 8447.408681392366, 8450.366222533334, 8479.236868681848, 8499.66001359951, 532.1643489378921, 538.8383484954498, 543.8314122621999, 544.5208216769217, 545.2067242162644, 6194.132821405007, 6218.875622487525, 6305.558610897285, 6364.172657554488, 6368.872622547523, 10507.054365107177, 10938.398388088572, 10961.83557246642, 11066.170037247239, 11138.832917506244, 10407.21945854064, 10728.89271107279, 10769.246152769387, 10779.353238805697, 10802.973717496825, 8478.872816907751, 8513.318934485227, 8525.31797456202, 8528.786780330542, 8693.739187824376, 8019.91980080215, 8053.35573154158, 8163.387745919199, 8269.627866746132, 8462.407631465738, 9486.478243696663, 9603.423794572349, 9640.0, 9696.903030969883, 9808.313418060667, 9836.704898853046, 9939.353941993748, 10081.596736130472, 10217.948910255402, 10241.948790256001, 7449.8825176221835, 7637.618119093912, 7689.192634773492, 7701.3068823806125, 7730.690772369042, 8405.70580029696, 8414.663413463393, 8436.156384361515, 8436.409451338348, 8533.06136325016, 7378.667959941923, 7488.850222995618, 7549.1695913448375, 7621.0, 7658.310752032344, 7301.342879140902, 7335.486515943832, 7351.485396022227, 7484.0, 7495.62521873915, 7938.722144724907, 7979.281864632211, 7986.480878742863, 8000.4399692021, 8061.758147255592, 7166.247544007804, 7191.173015103121, 7239.457040721862, 7269.890951635624, 7286.4170866329505, 7334.413246940126, 7352.485326027127, 7390.0, 7409.222031686595, 7412.8146796328365], "unit": "score", "name": "mootools.html", "value": 4971.101201547717}, {"lowerIsBetter": false, "replicates": [304.70595874980637, 336.1512181741104, 339.6111452387017, 343.38705410841624, 346.0863320833001, 6901.723931042752, 6923.065386172865, 6931.861362772742, 6934.618595977219, 6944.618046007474, 5722.227499287595, 6740.32596740327, 6910.274421185779, 6918.169819621652, 6928.96535517323, 4825.758712064383, 4914.557689807916, 5025.497450254982, 5060.418051924039, 5100.795968161269, 5009.6242781791325, 5028.396592408916, 5044.545990860822, 5088.516590923857, 5093.898122037557, 5015.974920125394, 5032.798688052473, 5054.317667114948, 5065.341505604266, 5073.644844860862, 4109.198706252282, 5053.039922414748, 5067.467915868818, 5068.670536415139, 5069.822556210552, 3567.357875582394, 3889.0, 3899.966508875122, 4340.197063543254, 4365.236083685374, 6393.3926277004075, 6651.700673469705, 6663.433608143314, 6665.866682666319, 6688.765893193763, 5923.526117910556, 5927.466528012456, 5930.614510056833, 5951.047832346804, 5960.254968128984, 7361.595112268823, 7373.446991475661, 7396.4822462427655, 7407.629618519052, 7426.1459932107955, 4730.361401210827, 4736.360591320162, 4750.976245118787, 4753.857384278477, 4763.214069678499, 7307.159676637149, 7351.750202465593, 7383.741569045112, 7837.1379148293645, 7904.565248911307, 4652.13935421948, 4722.173619616553, 4828.493008234155, 4834.250691142878, 4856.368672072678, 4913.31213630092, 4917.9016419672125, 4929.408470983505, 4934.7285899275885, 4937.679050861682, 5886.175935369051, 5888.205092312569, 5900.849334379841, 5907.438793314628, 5920.674362910081, 7382.298681625237, 7389.445791565654, 7392.704291828374, 7402.555846649218, 7406.296401841816, 1640.9015459072493, 1677.698014357403, 1706.7695861058846, 1706.8890522116023, 1707.9752148710922, 879.9780005499914, 1081.0648788797632, 1082.7996820588216, 1085.8099832529276, 1094.8084085285043, 5409.918851217156, 6750.6624668767345, 6766.49251306154, 6807.387335139762, 6814.352636499525, 7636.770896873103, 7647.273509016634, 7666.041744781903, 7667.616619169019, 7681.731139410205, 6779.0, 6797.422219111332, 6807.591544507345, 6816.07982922309, 6845.075914751545, 3730.086128898383, 4043.555208927016, 4064.166845796605, 4073.0, 4087.2234275487563, 7814.765557033298, 7834.804129896685, 8013.078495972921, 8058.476199047043, 8082.353411727047, 8019.799505012421, 8023.919760802317, 8041.6381262843315, 8048.919510804934, 8066.677332906618, 5773.769049237983, 7988.041435027718, 8032.59837008159, 8033.799155021171, 8034.638441270157, 7426.777196684108, 7685.579042601563, 7685.654145563575, 7704.30661240491, 7709.498882572615, 7539.982102416104, 7560.659770310459, 7569.848603028019, 7577.0, 7590.886136707843, 6831.28271531482, 8059.919400805917, 8074.959625201836, 8078.192180781874, 8080.959595202222, 3957.4261732049267, 4106.850081977052, 4741.739204343657, 4795.95204047955, 4850.5149485051215, 7438.070241219848, 7701.653425595974, 7709.730159444617, 7731.188225236269, 7800.219978002381, 7340.0, 7389.667464963982, 7399.371053460516, 7400.592967386845, 7446.627668616439, 6015.879682406415, 6794.966025169842, 7355.448341374311, 7476.140243872024, 7476.21499742541, 7078.884083644237, 7293.161286451914, 7313.597752123685, 7321.0, 7333.559986400833, 7372.7050917964825, 7442.627868606656, 7443.92556074454, 7479.364254038468, 7490.662920168496, 7226.494145409771, 7285.708571657075, 7293.088363954505, 7294.161171465349, 7299.452541059336], "unit": "score", "name": "prototype.html", "value": 5336.744114309337}, {"lowerIsBetter": false, "replicates": [744.8473063022079, 747.6000339818198, 757.0877093102812, 761.253971108314, 776.6776787633132, 15235.46675866345, 15365.539033828974, 15572.844271557282, 15580.922095389522, 15648.530544083667, 14388.424463021493, 14419.855801441983, 14423.0, 14442.927785361058, 14477.63805904853, 805.8227190018216, 965.9275554333453, 969.9466529340901, 992.910638042576, 994.607130183577, 965.835807912653, 971.9271054670893, 985.1429256546814, 988.5946761827652, 989.1196834817018, 1033.8139134955704, 1036.9792604147913, 1037.7094413564214, 1038.2265212416723, 1045.1012129568564, 1002.5939494504737, 1027.2809033676456, 1030.855680204768, 1034.1674951663908, 1038.948052597367, 753.8040109571496, 766.6435107674902, 779.030107516146, 780.157429975625, 780.5316809914063, 15073.246337683073, 15104.244787760677, 15133.319000644888, 15133.924330378388, 15148.394064237416, 13293.268870212134, 13297.401616927262, 13302.467901283937, 13342.93328533361, 13445.529406470825, 10256.282060255786, 10329.84505232422, 10347.482625868677, 10426.957304269588, 10485.528151233213, 3554.253606742587, 3565.0552603560077, 3574.6939100015975, 3654.634536546351, 3832.827522761482, 80864.19135808626, 81380.77928831072, 82350.9999999994, 82881.0, 83310.0, 9815.312928094965, 9894.158996485236, 9941.155001824925, 10084.899151008396, 10188.286819922534, 19088.522786930436, 22998.54002919932, 23325.41686457852, 23336.64995025076, 23375.883120584287, 7549.886751698729, 7648.617569121521, 7657.923420765721, 7711.383089352838, 7891.921080789233, 4146.979265103655, 4194.895127621834, 4224.0, 4297.871063868089, 4311.353297005411, 3224.2423030587793, 3666.3217304798163, 3706.425504046877, 3720.5907350191455, 3726.2361215950664, 650.443870490733, 666.6999850067489, 668.3183153183822, 670.872534218497, 671.7279501801778, 596.472122171881, 597.4772074434869, 601.0953514959957, 612.6232367094206, 624.5534442873368, 6978.371946524837, 8515.0, 8565.186307300797, 8701.912980870236, 8797.0, 531.6995897318003, 548.5556699073763, 581.2966310763939, 585.096026638844, 591.6834493545932, 3931.5478719947, 3980.681545476413, 4012.337964235868, 4022.7787471688753, 4230.069384735353, 95746.52126739321, 96419.0, 97015.0, 97932.0, 98331.01668983362, 80958.19041809624, 81412.37175256462, 82114.0, 82379.0, 83722.0, 70743.6462817693, 71965.28034719691, 72425.63787181031, 72690.63654681799, 73369.0, 7970.0, 8101.594920254081, 8115.7159499419595, 8195.344372450309, 8214.63034163476, 38498.0, 46037.61887143391, 48016.0, 53451.86192552254, 53572.732136339066, 68351.31648683648, 71728.28271717216, 72613.63693181501, 73488.53022939619, 74169.6291518539, 8460.661573537236, 9628.855567166358, 10096.293259471766, 10473.31923424975, 10629.574817007233, 10926.836097458385, 11026.173037022416, 11417.828732568853, 11464.0, 11685.591004314809, 9336.579853906454, 10184.490775461345, 10437.060664540228, 10484.370937743759, 10877.945610271898, 8742.475451472932, 10576.894231057591, 10591.735206619896, 10625.628103016357, 11584.826227606762, 7657.1959944205055, 8609.354298427768, 8627.094155113622, 10286.2799604027, 10706.357618542912, 9029.548522573976, 9145.085491450802, 9169.954150229207, 9200.861987070066, 9372.81254374895, 9103.089691030844, 9129.181484086255, 9222.031686672803, 9270.351075424656, 9290.349675522648], "unit": "score", "name": "yui.html", "value": 6985.328598429037}], "name": "dromaeo_css", "value": 7584.222819143459}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [116.0, 123.0, 122.0, 112.0, 114.0, 128.0, 125.0, 102.0, 168.0, 167.0], "unit": "score", "name": "ai-astar", "value": 127.7}, {"lowerIsBetter": true, "replicates": [146.0, 117.0, 154.0, 147.0, 125.0, 170.0, 142.0, 108.0, 191.0, 153.0], "unit": "score", "name": "audio-beat-detection", "value": 145.3}, {"lowerIsBetter": true, "replicates": [192.0, 193.0, 195.0, 202.0, 200.0, 193.0, 195.0, 196.0, 202.0, 199.0], "unit": "score", "name": "audio-dft", "value": 196.7}, {"lowerIsBetter": true, "replicates": [72.0, 75.0, 76.0, 113.0, 50.0, 70.0, 82.0, 86.0, 156.0, 47.0], "unit": "score", "name": "audio-fft", "value": 82.7}, {"lowerIsBetter": true, "replicates": [120.0, 77.0, 125.0, 80.0, 79.0, 82.0, 121.0, 79.0, 79.0, 119.0], "unit": "score", "name": "audio-oscillator", "value": 96.1}, {"lowerIsBetter": true, "replicates": [87.0, 86.0, 89.0, 88.0, 103.0, 85.0, 76.0, 129.0, 134.0, 91.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 96.8}, {"lowerIsBetter": true, "replicates": [93.0, 95.0, 94.0, 94.0, 95.0, 94.0, 93.0, 96.0, 94.0, 94.0], "unit": "score", "name": "imaging-darkroom", "value": 94.2}, {"lowerIsBetter": true, "replicates": [115.0, 91.0, 94.0, 90.0, 92.0, 92.0, 85.0, 80.0, 81.0, 148.0], "unit": "score", "name": "imaging-desaturate", "value": 96.8}, {"lowerIsBetter": true, "replicates": [54.0, 59.0, 61.0, 57.0, 59.0, 60.0, 61.0, 72.0, 78.0, 81.0], "unit": "score", "name": "json-parse-financial", "value": 64.2}, {"lowerIsBetter": true, "replicates": [75.0, 60.0, 73.0, 68.0, 69.0, 73.0, 69.0, 91.0, 59.0, 66.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 70.3}, {"lowerIsBetter": true, "replicates": [105.0, 108.0, 109.0, 106.0, 82.0, 83.0, 82.0, 81.0, 84.0, 89.0], "unit": "score", "name": "stanford-crypto-aes", "value": 92.9}, {"lowerIsBetter": true, "replicates": [118.0, 122.0, 122.0, 123.0, 137.0, 134.0, 138.0, 119.0, 118.0, 122.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 125.3}, {"lowerIsBetter": true, "replicates": [126.0, 140.0, 147.0, 174.0, 170.0, 131.0, 136.0, 135.0, 138.0, 141.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 143.8}, {"lowerIsBetter": true, "replicates": [72.0, 87.0, 100.0, 77.0, 64.0, 65.0, 83.0, 96.0, 96.0, 98.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 83.8}], "name": "kraken", "value": 1516.6}]} 04:01:30 INFO - Return code: 0 04:01:30 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 04:01:30 ERROR - # TBPL SUCCESS # 04:01:30 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:01:30 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:01:30 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:01:30 INFO - 2016-04-27 04:01:30.546 screenresolution[1684:10242] starting screenresolution argv=screenresolution get 04:01:30 INFO - 2016-04-27 04:01:30.548 screenresolution[1684:10242] Display 0: 1600x1200x32@60 04:01:30 INFO - 2016-04-27 04:01:30.554 screenresolution[1685:10245] starting screenresolution argv=screenresolution list 04:01:30 INFO - Available Modes on Display 0 04:01:30 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:01:30 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:01:30 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:01:30 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:01:30 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:01:30 INFO - Intel Iris: 04:01:30 INFO - Chipset Model: Intel Iris 04:01:30 INFO - Type: GPU 04:01:30 INFO - Bus: Built-In 04:01:30 INFO - VRAM (Dynamic, Max): 1536 MB 04:01:30 INFO - Vendor: Intel (0x8086) 04:01:30 INFO - Device ID: 0x0a2e 04:01:30 INFO - Revision ID: 0x0009 04:01:30 INFO - Displays: 04:01:30 INFO - Display: 04:01:30 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:01:30 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:01:30 INFO - Display Serial Number: 1600x1200 60 04:01:30 INFO - Main Display: Yes 04:01:30 INFO - Mirror: Off 04:01:30 INFO - Online: Yes 04:01:30 INFO - Rotation: Supported 04:01:30 INFO - Return code: 0 04:01:30 INFO - Running post-action listener: _resource_record_post_action 04:01:30 INFO - Running post-run listener: _resource_record_post_run 04:01:31 INFO - Total resource usage - Wall time: 1203s; CPU: 53.0%; Read bytes: 37979648; Write bytes: 666599936; Read time: 400; Write time: 1969 04:01:31 INFO - install - Wall time: 33s; CPU: 54.0%; Read bytes: 353542656; Write bytes: 354199040; Read time: 28265; Write time: 598 04:01:31 INFO - run-tests - Wall time: 1171s; CPU: 53.0%; Read bytes: 37008896; Write bytes: 302058496; Read time: 384; Write time: 1337 04:01:31 INFO - Running post-run listener: _upload_blobber_files 04:01:31 INFO - Blob upload gear active. 04:01:31 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:01:31 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 04:01:31 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', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:01:31 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 Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:01:32 INFO - (blobuploader) - INFO - Open directory for files ... 04:01:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:01:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:01:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:01:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:01:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:01:32 INFO - (blobuploader) - INFO - Done attempting. 04:01:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:01:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:01:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:01:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:01:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:01:33 INFO - (blobuploader) - INFO - Done attempting. 04:01:33 INFO - (blobuploader) - INFO - Iteration through files over. 04:01:33 INFO - Return code: 0 04:01:33 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:01:33 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:01:33 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c5f2df15330cc311b4d60d6792fc5d1cb271aa16185502fbab0da6d5c26a487d95525135e5ac1a4e1abe1899f9b1779a15578f278ae4b9621c346f6a76aa1f44", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/fc6b5a08a5c7e0d86a91b89e7a7a318fc7480f72d25c84314a60cfd8f8851733d81ae6649e05e96c8bb7eff8a9456dd9926806f2ec595cf80ff10dfe2be205de"} 04:01:33 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:01:33 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:01:33 INFO - Contents: 04:01:33 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c5f2df15330cc311b4d60d6792fc5d1cb271aa16185502fbab0da6d5c26a487d95525135e5ac1a4e1abe1899f9b1779a15578f278ae4b9621c346f6a76aa1f44", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/fc6b5a08a5c7e0d86a91b89e7a7a318fc7480f72d25c84314a60cfd8f8851733d81ae6649e05e96c8bb7eff8a9456dd9926806f2ec595cf80ff10dfe2be205de"} 04:01:33 INFO - Running post-run listener: copy_logs_to_upload_dir 04:01:33 INFO - Copying logs to upload dir... 04:01:33 INFO - mkdir: /builds/slave/test/build/upload/logs 04:01:33 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1260.178611 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2016-04-27 04:01:33.868063) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-27 04:01:33.871353) ========= 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.dNPGw2J1yA/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.1REvZbGWT7/Listeners TMPDIR=/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/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/Mozilla-Aurora/sha512/c5f2df15330cc311b4d60d6792fc5d1cb271aa16185502fbab0da6d5c26a487d95525135e5ac1a4e1abe1899f9b1779a15578f278ae4b9621c346f6a76aa1f44", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/fc6b5a08a5c7e0d86a91b89e7a7a318fc7480f72d25c84314a60cfd8f8851733d81ae6649e05e96c8bb7eff8a9456dd9926806f2ec595cf80ff10dfe2be205de"} build_url:https://queue.taskcluster.net/v1/task/SQDTyWLnRTi58-v24Lw8jQ/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011139 build_url: 'https://queue.taskcluster.net/v1/task/SQDTyWLnRTi58-v24Lw8jQ/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c5f2df15330cc311b4d60d6792fc5d1cb271aa16185502fbab0da6d5c26a487d95525135e5ac1a4e1abe1899f9b1779a15578f278ae4b9621c346f6a76aa1f44", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/fc6b5a08a5c7e0d86a91b89e7a7a318fc7480f72d25c84314a60cfd8f8851733d81ae6649e05e96c8bb7eff8a9456dd9926806f2ec595cf80ff10dfe2be205de"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-27 04:01:33.899732) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-27 04:01:33.900083) ========= 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.dNPGw2J1yA/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.1REvZbGWT7/Listeners TMPDIR=/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/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.005162 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-27 04:01:33.949204) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-27 04:01:33.949531) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-27 04:01:33.949995) ========= ========= Total master_lag: 0.16 =========