builder: mozilla-aurora_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0078 starttime: 1461136652.83 results: success (0) buildid: 20160419222814 builduid: 759a823f561844ddb3a6b97f737698ab revision: 8210de2a2b4fdb1701d3dadf65184bda51d6fbe7 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-20 00:17:32.832760) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-20 00:17:32.833478) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-20 00:17:32.833975) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-20 00:17:32.854642) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 00:17:32.855220) ========= 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.J3hKxV99GU/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.q5WcXm0Zwg/Listeners TMPDIR=/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/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-20 00:17:32-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 88.4M=0s 2016-04-20 00:17:32 (88.4 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.101922 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 00:17:32.974722) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 00:17:32.975040) ========= 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.J3hKxV99GU/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.q5WcXm0Zwg/Listeners TMPDIR=/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/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.020836 ========= master_lag: 0.14 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 00:17:33.133974) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-20 00:17:33.134329) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 8210de2a2b4fdb1701d3dadf65184bda51d6fbe7 --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 8210de2a2b4fdb1701d3dadf65184bda51d6fbe7 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.J3hKxV99GU/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.q5WcXm0Zwg/Listeners TMPDIR=/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/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-20 00:17:33,206 truncating revision to first 12 chars 2016-04-20 00:17:33,206 Setting DEBUG logging. 2016-04-20 00:17:33,206 attempt 1/10 2016-04-20 00:17:33,207 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/8210de2a2b4f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-20 00:17:34,436 unpacking tar archive at: mozilla-aurora-8210de2a2b4f/testing/mozharness/ program finished with exit code 0 elapsedTime=1.473134 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-20 00:17:34.625702) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-20 00:17:34.626236) ========= script_repo_revision: 8210de2a2b4fdb1701d3dadf65184bda51d6fbe7 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-20 00:17:34.626954) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-20 00:17:34.627461) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-20 00:17:34.641770) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2016-04-20 00:17:34.642127) ========= /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.J3hKxV99GU/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.q5WcXm0Zwg/Listeners TMPDIR=/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/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 00:17:34 INFO - MultiFileLogger online at 20160420 00:17:34 in /builds/slave/test 00:17:34 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 00:17:34 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 00:17:34 INFO - {'append_to_log': False, 00:17:34 INFO - 'base_work_dir': '/builds/slave/test', 00:17:34 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 00:17:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 00:17:34 INFO - 'branch': 'Mozilla-Aurora', 00:17:34 INFO - 'buildbot_json_path': 'buildprops.json', 00:17:34 INFO - 'config_files': ('talos/mac_config.py',), 00:17:34 INFO - 'default_actions': ('clobber', 00:17:34 INFO - 'read-buildbot-config', 00:17:34 INFO - 'download-and-extract', 00:17:34 INFO - 'populate-webroot', 00:17:34 INFO - 'create-virtualenv', 00:17:34 INFO - 'install', 00:17:34 INFO - 'run-tests'), 00:17:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 00:17:34 INFO - 'download_minidump_stackwalk': True, 00:17:34 INFO - 'download_symbols': 'ondemand', 00:17:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 00:17:34 INFO - 'tooltool.py': '/tools/tooltool.py', 00:17:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 00:17:34 INFO - '/tools/misc-python/virtualenv.py')}, 00:17:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 00:17:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 00:17:34 INFO - 'installer_path': 'installer.exe', 00:17:34 INFO - 'log_level': 'info', 00:17:34 INFO - 'log_name': 'talos', 00:17:34 INFO - 'log_to_console': True, 00:17:34 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 00:17:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 00:17:34 INFO - 'opt_config_files': (), 00:17:34 INFO - 'pip_index': False, 00:17:34 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 00:17:34 INFO - 'cmd': ('bash', 00:17:34 INFO - '-c', 00:17:34 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 00:17:34 INFO - 'enabled': True, 00:17:34 INFO - 'halt_on_failure': False, 00:17:34 INFO - 'name': 'check_screen_resolution'},), 00:17:34 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 00:17:34 INFO - 'cmd': ('bash', 00:17:34 INFO - '-c', 00:17:34 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 00:17:34 INFO - 'enabled': True, 00:17:34 INFO - 'halt_on_failure': False, 00:17:34 INFO - 'name': 'check_screen_resolution'},), 00:17:34 INFO - 'run_cmd_checks_enabled': True, 00:17:34 INFO - 'sps_profile': False, 00:17:34 INFO - 'sps_profile_interval': 0, 00:17:34 INFO - 'suite': 'dromaeojs-e10s', 00:17:34 INFO - 'system_bits': '32', 00:17:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 00:17:34 INFO - 'title': 't-yosemite-r7-0078', 00:17:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 00:17:34 INFO - 'use_talos_json': True, 00:17:34 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 00:17:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 00:17:34 INFO - 'work_dir': 'build'} 00:17:34 INFO - ##### 00:17:34 INFO - ##### Running clobber step. 00:17:34 INFO - ##### 00:17:34 INFO - Running pre-action listener: _resource_record_pre_action 00:17:34 INFO - Running main action method: clobber 00:17:34 INFO - rmtree: /builds/slave/test/build 00:17:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 00:17:36 INFO - Running post-action listener: _resource_record_post_action 00:17:36 INFO - ##### 00:17:36 INFO - ##### Running read-buildbot-config step. 00:17:36 INFO - ##### 00:17:36 INFO - Running pre-action listener: _resource_record_pre_action 00:17:36 INFO - Running main action method: read_buildbot_config 00:17:36 INFO - Using buildbot properties: 00:17:36 INFO - { 00:17:36 INFO - "project": "", 00:17:36 INFO - "product": "firefox", 00:17:36 INFO - "script_repo_revision": "production", 00:17:36 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs-e10s", 00:17:36 INFO - "repository": "", 00:17:36 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs-e10s", 00:17:36 INFO - "buildid": "20160419222814", 00:17:36 INFO - "pgo_build": "False", 00:17:36 INFO - "basedir": "/builds/slave/test", 00:17:36 INFO - "buildnumber": 284, 00:17:36 INFO - "slavename": "t-yosemite-r7-0078", 00:17:36 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 00:17:36 INFO - "platform": "yosemite_r7", 00:17:36 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 00:17:36 INFO - "branch": "mozilla-aurora", 00:17:36 INFO - "repo_path": "releases/mozilla-aurora", 00:17:36 INFO - "revision": "8210de2a2b4fdb1701d3dadf65184bda51d6fbe7", 00:17:36 INFO - "stage_platform": "macosx64", 00:17:36 INFO - "builduid": "759a823f561844ddb3a6b97f737698ab", 00:17:36 INFO - "slavebuilddir": "test" 00:17:36 INFO - } 00:17:36 INFO - Found installer url https://queue.taskcluster.net/v1/task/F2UAd3ecR-KTlDpvL5mYEg/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg. 00:17:36 INFO - Running post-action listener: _resource_record_post_action 00:17:36 INFO - ##### 00:17:36 INFO - ##### Running download-and-extract step. 00:17:36 INFO - ##### 00:17:36 INFO - Running pre-action listener: _resource_record_pre_action 00:17:36 INFO - Running main action method: download_and_extract 00:17:36 INFO - mkdir: /builds/slave/test/build/tests 00:17: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')]} 00:17:36 INFO - https://queue.taskcluster.net/v1/task/F2UAd3ecR-KTlDpvL5mYEg/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json matches https://queue.taskcluster.net 00:17:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F2UAd3ecR-KTlDpvL5mYEg/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json 00:17:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F2UAd3ecR-KTlDpvL5mYEg/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json 00:17:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F2UAd3ecR-KTlDpvL5mYEg/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 00:17:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F2UAd3ecR-KTlDpvL5mYEg/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 00:17:42 INFO - Downloaded 1277 bytes. 00:17:42 INFO - Reading from file /builds/slave/test/build/firefox-47.0a2.en-US.mac.test_packages.json 00:17:42 INFO - Using the following test package requirements: 00:17:42 INFO - {u'common': [u'firefox-47.0a2.en-US.mac.common.tests.zip'], 00:17:42 INFO - u'cppunittest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 00:17:42 INFO - u'firefox-47.0a2.en-US.mac.cppunittest.tests.zip'], 00:17:42 INFO - u'gtest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 00:17:42 INFO - u'firefox-47.0a2.en-US.mac.gtest.tests.zip'], 00:17:42 INFO - u'jittest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 00:17:42 INFO - u'jsshell-mac.zip'], 00:17:42 INFO - u'mochitest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 00:17:42 INFO - u'firefox-47.0a2.en-US.mac.mochitest.tests.zip'], 00:17:42 INFO - u'mozbase': [u'firefox-47.0a2.en-US.mac.common.tests.zip'], 00:17:42 INFO - u'reftest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 00:17:42 INFO - u'firefox-47.0a2.en-US.mac.reftest.tests.zip'], 00:17:42 INFO - u'talos': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 00:17:42 INFO - u'firefox-47.0a2.en-US.mac.talos.tests.zip'], 00:17:42 INFO - u'web-platform': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 00:17:42 INFO - u'firefox-47.0a2.en-US.mac.web-platform.tests.zip'], 00:17:42 INFO - u'webapprt': [u'firefox-47.0a2.en-US.mac.common.tests.zip'], 00:17:42 INFO - u'xpcshell': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 00:17:42 INFO - u'firefox-47.0a2.en-US.mac.xpcshell.tests.zip']} 00:17:42 INFO - Downloading packages: [u'firefox-47.0a2.en-US.mac.common.tests.zip'] for test suite category: common 00:17: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')]} 00:17:42 INFO - https://queue.taskcluster.net/v1/task/F2UAd3ecR-KTlDpvL5mYEg/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 00:17:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F2UAd3ecR-KTlDpvL5mYEg/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 00:17:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F2UAd3ecR-KTlDpvL5mYEg/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 00:17:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F2UAd3ecR-KTlDpvL5mYEg/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 00:17:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F2UAd3ecR-KTlDpvL5mYEg/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 00:17:46 INFO - Downloaded 17911393 bytes. 00:17:46 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'] 00:17:46 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 00:17:50 INFO - Return code: 0 00:17:50 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 00:17:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:17:50 INFO - https://queue.taskcluster.net/v1/task/F2UAd3ecR-KTlDpvL5mYEg/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 00:17:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F2UAd3ecR-KTlDpvL5mYEg/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 00:17:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F2UAd3ecR-KTlDpvL5mYEg/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 00:17:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F2UAd3ecR-KTlDpvL5mYEg/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 00:17:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F2UAd3ecR-KTlDpvL5mYEg/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 00:17:51 INFO - Downloaded 17911393 bytes. 00:17:51 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'] 00:17:51 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 00:17:54 INFO - Return code: 0 00:17:54 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')]} 00:17:54 INFO - https://queue.taskcluster.net/v1/task/F2UAd3ecR-KTlDpvL5mYEg/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 00:17:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F2UAd3ecR-KTlDpvL5mYEg/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip 00:17:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F2UAd3ecR-KTlDpvL5mYEg/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip 00:17:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F2UAd3ecR-KTlDpvL5mYEg/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 00:17:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F2UAd3ecR-KTlDpvL5mYEg/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 00:17:55 INFO - Downloaded 10845168 bytes. 00:17:55 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'] 00:17:55 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 00:17:55 INFO - Return code: 0 00:17:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:17:55 INFO - https://queue.taskcluster.net/v1/task/F2UAd3ecR-KTlDpvL5mYEg/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg matches https://queue.taskcluster.net 00:17:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F2UAd3ecR-KTlDpvL5mYEg/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 00:17:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F2UAd3ecR-KTlDpvL5mYEg/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 00:17:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F2UAd3ecR-KTlDpvL5mYEg/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a2.en-US.mac.dmg 00:17:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F2UAd3ecR-KTlDpvL5mYEg/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 00:18:03 INFO - Downloaded 115251681 bytes. 00:18:03 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/F2UAd3ecR-KTlDpvL5mYEg/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 00:18:03 INFO - mkdir: /builds/slave/test/properties 00:18:03 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 00:18:03 INFO - Writing to file /builds/slave/test/properties/build_url 00:18:03 INFO - Contents: 00:18:03 INFO - build_url:https://queue.taskcluster.net/v1/task/F2UAd3ecR-KTlDpvL5mYEg/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 00:18:05 INFO - Running post-action listener: _resource_record_post_action 00:18:05 INFO - Running post-action listener: set_extra_try_arguments 00:18:05 INFO - ##### 00:18:05 INFO - ##### Running populate-webroot step. 00:18:05 INFO - ##### 00:18:05 INFO - Running pre-action listener: _resource_record_pre_action 00:18:05 INFO - Running main action method: populate_webroot 00:18:05 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 00:18:05 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 00:18:05 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 00:18:05 INFO - '--tppagecycles', 00:18:05 INFO - '7'], 00:18:05 INFO - 'tests': ['tsvgm']}}, 00:18:05 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 00:18:05 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 00:18:05 INFO - 'tests': ['tresize', 'tcanvasmark']}, 00:18:05 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 00:18:05 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 00:18:05 INFO - 'tests': ['dromaeo_css', 'kraken']}, 00:18:05 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:18:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:18:05 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:18:05 INFO - 'talos_options': ['--e10s'], 00:18:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:18:05 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:18:05 INFO - 'tests': ['damp', 'tps']}, 00:18:05 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:18:05 INFO - 'talos_options': ['--e10s'], 00:18:05 INFO - 'tests': ['damp', 'tps']}, 00:18:05 INFO - 'g3': {'tests': ['dromaeo_dom']}, 00:18:05 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 00:18:05 INFO - 'other': {'tests': ['a11yr', 00:18:05 INFO - 'ts_paint', 00:18:05 INFO - 'tpaint', 00:18:05 INFO - 'sessionrestore', 00:18:05 INFO - 'sessionrestore_no_auto_restore', 00:18:05 INFO - 'tabpaint']}, 00:18:05 INFO - 'other-e10s': {'talos_options': ['--e10s'], 00:18:05 INFO - 'tests': ['a11yr', 00:18:05 INFO - 'ts_paint', 00:18:05 INFO - 'tpaint', 00:18:05 INFO - 'sessionrestore', 00:18:05 INFO - 'sessionrestore_no_auto_restore', 00:18:05 INFO - 'tabpaint']}, 00:18:05 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 00:18:05 INFO - 'tests': ['a11yr', 00:18:05 INFO - 'ts_paint', 00:18:05 INFO - 'tpaint', 00:18:05 INFO - 'sessionrestore', 00:18:05 INFO - 'sessionrestore_no_auto_restore', 00:18:05 INFO - 'tabpaint']}, 00:18:05 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 00:18:05 INFO - 'tests': ['a11yr', 00:18:05 INFO - 'ts_paint', 00:18:05 INFO - 'tpaint', 00:18:05 INFO - 'sessionrestore', 00:18:05 INFO - 'sessionrestore_no_auto_restore', 00:18:05 INFO - 'tabpaint']}, 00:18:05 INFO - 'other_l64': {'tests': ['a11yr', 00:18:05 INFO - 'ts_paint', 00:18:05 INFO - 'tpaint', 00:18:05 INFO - 'sessionrestore', 00:18:05 INFO - 'sessionrestore_no_auto_restore', 00:18:05 INFO - 'tabpaint']}, 00:18:05 INFO - 'other_nol64': {'tests': ['a11yr', 00:18:05 INFO - 'ts_paint', 00:18:05 INFO - 'tpaint', 00:18:05 INFO - 'sessionrestore', 00:18:05 INFO - 'sessionrestore_no_auto_restore', 00:18:05 INFO - 'tabpaint']}, 00:18:05 INFO - 'svgr': {'tests': ['tsvgx', 00:18:05 INFO - 'tsvgr_opacity', 00:18:05 INFO - 'tart', 00:18:05 INFO - 'tscrollx', 00:18:05 INFO - 'cart']}, 00:18:05 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 00:18:05 INFO - 'tests': ['tsvgx', 00:18:05 INFO - 'tsvgr_opacity', 00:18:05 INFO - 'tart', 00:18:05 INFO - 'tscrollx', 00:18:05 INFO - 'cart']}, 00:18:05 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:18:05 INFO - 'tests': ['tp5o']}, 00:18:05 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:18:05 INFO - 'talos_options': ['--e10s'], 00:18:05 INFO - 'tests': ['tp5o']}, 00:18:05 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:18:05 INFO - 'talos_options': ['--xperf_path', 00:18:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:18:05 INFO - 'tests': ['tp5n']}, 00:18:05 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:18:05 INFO - 'talos_options': ['--e10s', 00:18:05 INFO - '--xperf_path', 00:18:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:18:05 INFO - 'tests': ['tp5n']}}, 00:18:05 INFO - 'talos.zip': {'path': '', 00:18:05 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 00:18:05 INFO - Running post-action listener: _resource_record_post_action 00:18:05 INFO - ##### 00:18:05 INFO - ##### Running create-virtualenv step. 00:18:05 INFO - ##### 00:18:05 INFO - Running pre-action listener: _resource_record_pre_action 00:18:05 INFO - Running main action method: create_virtualenv 00:18:05 INFO - Creating virtualenv /builds/slave/test/build/venv 00:18:05 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 00:18:05 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 00:18:05 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 00:18:05 INFO - Using real prefix '/tools/python27' 00:18:05 INFO - New python executable in /builds/slave/test/build/venv/bin/python 00:18:06 INFO - Installing distribute.............................................................................................................................................................................................done. 00:18:08 INFO - Installing pip.................done. 00:18:08 INFO - Return code: 0 00:18:08 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 00:18: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')]} 00:18:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:18:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:18: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')]} 00:18:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:18:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:18:08 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 0x109372a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1093794c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f92605c4e80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109216d30>, '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 0x10907adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10920db20>, '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.J3hKxV99GU/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.q5WcXm0Zwg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/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 00:18:08 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 00:18:08 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 00:18:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.J3hKxV99GU/Render', 00:18:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:18:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:18:08 INFO - 'HOME': '/Users/cltbld', 00:18:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:18:08 INFO - 'LOGNAME': 'cltbld', 00:18:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:18:08 INFO - 'MOZ_NO_REMOTE': '1', 00:18:08 INFO - 'NO_EM_RESTART': '1', 00:18:08 INFO - 'PAGER': '/bin/cat', 00:18:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:18:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:18:08 INFO - 'PWD': '/builds/slave/test', 00:18:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:18:08 INFO - 'SHELL': '/bin/bash', 00:18:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.q5WcXm0Zwg/Listeners', 00:18:08 INFO - 'TMPDIR': '/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/', 00:18:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:18:08 INFO - 'USER': 'cltbld', 00:18:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:18:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:18:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:18:08 INFO - 'XPC_FLAGS': '0x0', 00:18:08 INFO - 'XPC_SERVICE_NAME': '0', 00:18:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:18:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:18:09 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 00:18:09 INFO - Cleaning up... 00:18:09 INFO - Return code: 0 00:18:09 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 00:18:09 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')]} 00:18:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:18:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:18:09 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')]} 00:18:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:18:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:18:09 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 0x109372a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1093794c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f92605c4e80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109216d30>, '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 0x10907adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10920db20>, '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.J3hKxV99GU/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.q5WcXm0Zwg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/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 00:18:09 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 00:18:09 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 00:18:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.J3hKxV99GU/Render', 00:18:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:18:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:18:09 INFO - 'HOME': '/Users/cltbld', 00:18:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:18:09 INFO - 'LOGNAME': 'cltbld', 00:18:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:18:09 INFO - 'MOZ_NO_REMOTE': '1', 00:18:09 INFO - 'NO_EM_RESTART': '1', 00:18:09 INFO - 'PAGER': '/bin/cat', 00:18:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:18:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:18:09 INFO - 'PWD': '/builds/slave/test', 00:18:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:18:09 INFO - 'SHELL': '/bin/bash', 00:18:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.q5WcXm0Zwg/Listeners', 00:18:09 INFO - 'TMPDIR': '/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/', 00:18:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:18:09 INFO - 'USER': 'cltbld', 00:18:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:18:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:18:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:18:09 INFO - 'XPC_FLAGS': '0x0', 00:18:09 INFO - 'XPC_SERVICE_NAME': '0', 00:18:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:18:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:18:09 INFO - Downloading/unpacking psutil>=0.7.1 00:18:09 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 00:18:09 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 00:18:09 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 00:18:09 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 00:18:09 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 00:18:09 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 00:18:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 00:18:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:18:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:18:11 INFO - Installing collected packages: psutil 00:18:11 INFO - Running setup.py install for psutil 00:18:12 INFO - building 'psutil._psutil_osx' extension 00:18:12 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 00:18:12 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 00:18:12 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 00:18:12 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 00:18:12 INFO - building 'psutil._psutil_posix' extension 00:18:12 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 00:18:12 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 00:18:12 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 00:18:12 INFO - ^ 00:18:12 INFO - 1 warning generated. 00:18:12 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 00:18:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:18:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:18:12 INFO - Successfully installed psutil 00:18:12 INFO - Cleaning up... 00:18:12 INFO - Return code: 0 00:18:12 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 00:18:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:18:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:18:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:18:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:18:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:18:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:18:12 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 0x109372a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1093794c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f92605c4e80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109216d30>, '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 0x10907adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10920db20>, '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.J3hKxV99GU/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.q5WcXm0Zwg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/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 00:18:12 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 00:18:12 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 00:18:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.J3hKxV99GU/Render', 00:18:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:18:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:18:12 INFO - 'HOME': '/Users/cltbld', 00:18:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:18:12 INFO - 'LOGNAME': 'cltbld', 00:18:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:18:12 INFO - 'MOZ_NO_REMOTE': '1', 00:18:12 INFO - 'NO_EM_RESTART': '1', 00:18:12 INFO - 'PAGER': '/bin/cat', 00:18:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:18:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:18:12 INFO - 'PWD': '/builds/slave/test', 00:18:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:18:12 INFO - 'SHELL': '/bin/bash', 00:18:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.q5WcXm0Zwg/Listeners', 00:18:12 INFO - 'TMPDIR': '/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/', 00:18:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:18:12 INFO - 'USER': 'cltbld', 00:18:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:18:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:18:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:18:12 INFO - 'XPC_FLAGS': '0x0', 00:18:12 INFO - 'XPC_SERVICE_NAME': '0', 00:18:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:18:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:18:13 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 00:18:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:18:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:18:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:18:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:18:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:18:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:18:15 INFO - Downloading mozsystemmonitor-0.0.tar.gz 00:18:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 00:18:15 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 00:18:15 INFO - Installing collected packages: mozsystemmonitor 00:18:15 INFO - Running setup.py install for mozsystemmonitor 00:18:15 INFO - Successfully installed mozsystemmonitor 00:18:15 INFO - Cleaning up... 00:18:15 INFO - Return code: 0 00:18:15 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 00:18:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:18:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:18:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:18:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:18:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:18:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:18:15 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 0x109372a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1093794c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f92605c4e80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109216d30>, '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 0x10907adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10920db20>, '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.J3hKxV99GU/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.q5WcXm0Zwg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/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 00:18:15 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 00:18:15 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 00:18:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.J3hKxV99GU/Render', 00:18:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:18:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:18:15 INFO - 'HOME': '/Users/cltbld', 00:18:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:18:15 INFO - 'LOGNAME': 'cltbld', 00:18:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:18:15 INFO - 'MOZ_NO_REMOTE': '1', 00:18:15 INFO - 'NO_EM_RESTART': '1', 00:18:15 INFO - 'PAGER': '/bin/cat', 00:18:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:18:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:18:15 INFO - 'PWD': '/builds/slave/test', 00:18:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:18:15 INFO - 'SHELL': '/bin/bash', 00:18:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.q5WcXm0Zwg/Listeners', 00:18:15 INFO - 'TMPDIR': '/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/', 00:18:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:18:15 INFO - 'USER': 'cltbld', 00:18:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:18:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:18:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:18:15 INFO - 'XPC_FLAGS': '0x0', 00:18:15 INFO - 'XPC_SERVICE_NAME': '0', 00:18:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:18:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:18:16 INFO - Downloading/unpacking blobuploader==1.2.4 00:18:16 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 00:18:16 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 00:18:16 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 00:18:16 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 00:18:16 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 00:18:16 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 00:18:18 INFO - Downloading blobuploader-1.2.4.tar.gz 00:18:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 00:18:18 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 00:18:18 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 00:18:18 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 00:18:18 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 00:18:18 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 00:18:18 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 00:18:18 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 00:18:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 00:18:19 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 00:18: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 00:18: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 00:18: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 00:18: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 00:18: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 00:18: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 00:18:19 INFO - Downloading docopt-0.6.1.tar.gz 00:18:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 00:18:19 INFO - Installing collected packages: blobuploader, requests, docopt 00:18:19 INFO - Running setup.py install for blobuploader 00:18:19 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 00:18:19 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 00:18:19 INFO - Running setup.py install for requests 00:18:20 INFO - Running setup.py install for docopt 00:18:20 INFO - Successfully installed blobuploader requests docopt 00:18:20 INFO - Cleaning up... 00:18:20 INFO - Return code: 0 00:18:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:18:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:18:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:18:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:18:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:18:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:18:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:18:20 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 0x109372a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1093794c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f92605c4e80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109216d30>, '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 0x10907adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10920db20>, '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.J3hKxV99GU/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.q5WcXm0Zwg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/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 00:18:20 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 00:18:20 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 00:18:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.J3hKxV99GU/Render', 00:18:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:18:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:18:20 INFO - 'HOME': '/Users/cltbld', 00:18:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:18:20 INFO - 'LOGNAME': 'cltbld', 00:18:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:18:20 INFO - 'MOZ_NO_REMOTE': '1', 00:18:20 INFO - 'NO_EM_RESTART': '1', 00:18:20 INFO - 'PAGER': '/bin/cat', 00:18:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:18:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:18:20 INFO - 'PWD': '/builds/slave/test', 00:18:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:18:20 INFO - 'SHELL': '/bin/bash', 00:18:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.q5WcXm0Zwg/Listeners', 00:18:20 INFO - 'TMPDIR': '/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/', 00:18:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:18:20 INFO - 'USER': 'cltbld', 00:18:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:18:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:18:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:18:20 INFO - 'XPC_FLAGS': '0x0', 00:18:20 INFO - 'XPC_SERVICE_NAME': '0', 00:18:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:18:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:18:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 00:18:21 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-urKGhd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 00:18:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 00:18:21 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-qJ7Fq9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 00:18:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 00:18:21 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-SkD990-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 00:18:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 00:18:21 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-EQ1UKb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 00:18:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 00:18:21 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-2wTpGf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 00:18:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 00:18:21 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-LnVWMS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 00:18:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 00:18:21 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-7uGeGR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 00:18:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 00:18:21 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-kzqre2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 00:18:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 00:18:21 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-36BpMj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 00:18:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 00:18:21 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-p8Ej5y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 00:18:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 00:18:22 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-PSF84i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 00:18:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 00:18:22 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-lwNVZO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 00:18:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 00:18:22 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-ZScbyD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 00:18:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 00:18:22 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-cyDHEA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 00:18:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 00:18:22 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-isBDJC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 00:18:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 00:18:22 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-XC2zoa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 00:18:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 00:18:22 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-OVFGnk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 00:18:22 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 00:18:22 INFO - Running setup.py install for manifestparser 00:18:22 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 00:18:22 INFO - Running setup.py install for mozcrash 00:18:23 INFO - Running setup.py install for mozdebug 00:18:23 INFO - Running setup.py install for mozdevice 00:18:23 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 00:18:23 INFO - Installing dm script to /builds/slave/test/build/venv/bin 00:18:23 INFO - Running setup.py install for mozfile 00:18:23 INFO - Running setup.py install for mozhttpd 00:18:23 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 00:18:23 INFO - Running setup.py install for mozinfo 00:18:23 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 00:18:23 INFO - Running setup.py install for mozInstall 00:18:23 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 00:18:23 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 00:18:23 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 00:18:23 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 00:18:24 INFO - Running setup.py install for mozleak 00:18:24 INFO - Running setup.py install for mozlog 00:18:24 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 00:18:24 INFO - Running setup.py install for moznetwork 00:18:24 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 00:18:24 INFO - Running setup.py install for mozprocess 00:18:24 INFO - Running setup.py install for mozprofile 00:18:24 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 00:18:24 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 00:18:24 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 00:18:24 INFO - Running setup.py install for mozrunner 00:18:24 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 00:18:24 INFO - Running setup.py install for mozscreenshot 00:18:25 INFO - Running setup.py install for moztest 00:18:25 INFO - Running setup.py install for mozversion 00:18:25 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 00:18:25 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 00:18:25 INFO - Cleaning up... 00:18:25 INFO - Return code: 0 00:18:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:18:25 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')]} 00:18:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:18:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:18:25 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')]} 00:18:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:18:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:18:25 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 0x109372a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1093794c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f92605c4e80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109216d30>, '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 0x10907adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10920db20>, '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.J3hKxV99GU/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.q5WcXm0Zwg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/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 00:18:25 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 00:18:25 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 00:18:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.J3hKxV99GU/Render', 00:18:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:18:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:18:25 INFO - 'HOME': '/Users/cltbld', 00:18:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:18:25 INFO - 'LOGNAME': 'cltbld', 00:18:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:18:25 INFO - 'MOZ_NO_REMOTE': '1', 00:18:25 INFO - 'NO_EM_RESTART': '1', 00:18:25 INFO - 'PAGER': '/bin/cat', 00:18:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:18:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:18:25 INFO - 'PWD': '/builds/slave/test', 00:18:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:18:25 INFO - 'SHELL': '/bin/bash', 00:18:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.q5WcXm0Zwg/Listeners', 00:18:25 INFO - 'TMPDIR': '/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/', 00:18:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:18:25 INFO - 'USER': 'cltbld', 00:18:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:18:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:18:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:18:25 INFO - 'XPC_FLAGS': '0x0', 00:18:25 INFO - 'XPC_SERVICE_NAME': '0', 00:18:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:18:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:18:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 00:18:25 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-L0i_P3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 00:18:25 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)) 00:18:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 00:18:25 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-6vnKQp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 00:18:25 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)) 00:18:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 00:18:25 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-QEURpN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 00:18:25 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)) 00:18:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 00:18:26 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-aBAXOb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 00:18:26 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)) 00:18:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 00:18:26 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-7eHTko-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 00:18:26 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)) 00:18:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 00:18:26 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-tLvHTS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 00:18:26 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)) 00:18:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 00:18:26 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-i9R381-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 00:18:26 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)) 00:18:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 00:18:26 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-I5j7pE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 00:18:26 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)) 00:18:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 00:18:26 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-yy_r9c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 00:18:26 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)) 00:18:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 00:18:26 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-pLHjln-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 00:18:26 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)) 00:18:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 00:18:26 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-KG23mM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 00:18:26 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)) 00:18:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 00:18:26 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-FaBh1F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 00:18:26 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)) 00:18:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 00:18:26 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-OAms1b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 00:18:27 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)) 00:18:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 00:18:27 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-bVtmhd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 00:18:27 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)) 00:18:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 00:18:27 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-wm5tdA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 00:18:27 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)) 00:18:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 00:18:27 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-qtKOkd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 00:18:27 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)) 00:18:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 00:18:27 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-xuUPaI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 00:18:27 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)) 00:18:27 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)) 00:18:27 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)) 00:18:27 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)) 00:18:27 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)) 00:18:27 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)) 00:18:27 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 00:18:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:18:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:18:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:18:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:18:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:18:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:18:29 INFO - Downloading blessings-1.6.tar.gz 00:18:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 00:18:30 INFO - Installing collected packages: blessings 00:18:30 INFO - Running setup.py install for blessings 00:18:30 INFO - Successfully installed blessings 00:18:30 INFO - Cleaning up... 00:18:30 INFO - Return code: 0 00:18:30 INFO - Done creating virtualenv /builds/slave/test/build/venv. 00:18:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 00:18:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 00:18:30 INFO - Reading from file tmpfile_stdout 00:18:30 INFO - Current package versions: 00:18:30 INFO - blessings == 1.6 00:18:30 INFO - blobuploader == 1.2.4 00:18:30 INFO - docopt == 0.6.1 00:18:30 INFO - manifestparser == 1.1 00:18:30 INFO - mozInstall == 1.12 00:18:30 INFO - mozcrash == 0.17 00:18:30 INFO - mozdebug == 0.1 00:18:30 INFO - mozdevice == 0.48 00:18:30 INFO - mozfile == 1.2 00:18:30 INFO - mozhttpd == 0.7 00:18:30 INFO - mozinfo == 0.9 00:18:30 INFO - mozleak == 0.1 00:18:30 INFO - mozlog == 3.1 00:18:30 INFO - moznetwork == 0.27 00:18:30 INFO - mozprocess == 0.22 00:18:30 INFO - mozprofile == 0.28 00:18:30 INFO - mozrunner == 6.11 00:18:30 INFO - mozscreenshot == 0.1 00:18:30 INFO - mozsystemmonitor == 0.0 00:18:30 INFO - moztest == 0.7 00:18:30 INFO - mozversion == 1.4 00:18:30 INFO - psutil == 3.1.1 00:18:30 INFO - requests == 1.2.3 00:18:30 INFO - wsgiref == 0.1.2 00:18:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:18:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:18:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:18:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:18:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:18:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:18:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:18:30 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 0x109372a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1093794c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f92605c4e80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109216d30>, '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 0x10907adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10920db20>, '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.J3hKxV99GU/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.q5WcXm0Zwg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/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 00:18:30 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 00:18:30 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 00:18:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.J3hKxV99GU/Render', 00:18:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:18:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:18:30 INFO - 'HOME': '/Users/cltbld', 00:18:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:18:30 INFO - 'LOGNAME': 'cltbld', 00:18:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:18:30 INFO - 'MOZ_NO_REMOTE': '1', 00:18:30 INFO - 'NO_EM_RESTART': '1', 00:18:30 INFO - 'PAGER': '/bin/cat', 00:18:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:18:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:18:30 INFO - 'PWD': '/builds/slave/test', 00:18:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:18:30 INFO - 'SHELL': '/bin/bash', 00:18:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.q5WcXm0Zwg/Listeners', 00:18:30 INFO - 'TMPDIR': '/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/', 00:18:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:18:30 INFO - 'USER': 'cltbld', 00:18:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:18:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:18:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:18:30 INFO - 'XPC_FLAGS': '0x0', 00:18:30 INFO - 'XPC_SERVICE_NAME': '0', 00:18:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:18:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:18:31 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)) 00:18:31 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)) 00:18:31 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)) 00:18:31 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)) 00:18:31 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)) 00:18:31 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)) 00:18:31 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)) 00:18:31 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)) 00:18:31 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)) 00:18:31 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)) 00:18:31 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)) 00:18:31 INFO - Cleaning up... 00:18:31 INFO - Return code: 0 00:18:31 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 00:18:31 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')]} 00:18:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:18:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:18:31 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')]} 00:18:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:18:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:18:31 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 0x109372a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1093794c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f92605c4e80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109216d30>, '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 0x10907adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10920db20>, '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.J3hKxV99GU/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.q5WcXm0Zwg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/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 00:18:31 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 00:18:31 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 00:18:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.J3hKxV99GU/Render', 00:18:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:18:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:18:31 INFO - 'HOME': '/Users/cltbld', 00:18:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:18:31 INFO - 'LOGNAME': 'cltbld', 00:18:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:18:31 INFO - 'MOZ_NO_REMOTE': '1', 00:18:31 INFO - 'NO_EM_RESTART': '1', 00:18:31 INFO - 'PAGER': '/bin/cat', 00:18:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:18:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:18:31 INFO - 'PWD': '/builds/slave/test', 00:18:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:18:31 INFO - 'SHELL': '/bin/bash', 00:18:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.q5WcXm0Zwg/Listeners', 00:18:31 INFO - 'TMPDIR': '/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/', 00:18:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:18:31 INFO - 'USER': 'cltbld', 00:18:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:18:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:18:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:18:31 INFO - 'XPC_FLAGS': '0x0', 00:18:31 INFO - 'XPC_SERVICE_NAME': '0', 00:18:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:18:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:18:31 INFO - Downloading/unpacking jsonschema 00:18:31 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 00:18:31 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 00:18:31 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 00:18:31 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 00:18:31 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 00:18:31 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 00:18:34 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 00:18:34 INFO - Downloading/unpacking functools32 (from jsonschema) 00:18:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:18:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:18:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:18:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:18:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:18:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:18:35 INFO - Downloading functools32-3.2.3-2.tar.gz 00:18:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 00:18:35 INFO - warning: no files found matching '*.txt' 00:18:35 INFO - no previously-included directories found matching 'build' 00:18:35 INFO - no previously-included directories found matching 'dist' 00:18:35 INFO - no previously-included directories found matching '.git*' 00:18:35 INFO - Installing collected packages: jsonschema, functools32 00:18:35 INFO - Running setup.py install for functools32 00:18:35 INFO - warning: no files found matching '*.txt' 00:18:35 INFO - no previously-included directories found matching 'build' 00:18:35 INFO - no previously-included directories found matching 'dist' 00:18:35 INFO - no previously-included directories found matching '.git*' 00:18:35 INFO - Successfully installed jsonschema functools32 00:18:35 INFO - Cleaning up... 00:18:35 INFO - Return code: 0 00:18:35 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 00:18: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')]} 00:18:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:18:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:18: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')]} 00:18:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:18:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:18:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109372a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1093794c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f92605c4e80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109216d30>, '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 0x10907adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10920db20>, '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.J3hKxV99GU/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.q5WcXm0Zwg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/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 00:18:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 00:18:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 00:18:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.J3hKxV99GU/Render', 00:18:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:18:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:18:35 INFO - 'HOME': '/Users/cltbld', 00:18:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:18:35 INFO - 'LOGNAME': 'cltbld', 00:18:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:18:35 INFO - 'MOZ_NO_REMOTE': '1', 00:18:35 INFO - 'NO_EM_RESTART': '1', 00:18:35 INFO - 'PAGER': '/bin/cat', 00:18:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:18:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:18:35 INFO - 'PWD': '/builds/slave/test', 00:18:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:18:35 INFO - 'SHELL': '/bin/bash', 00:18:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.q5WcXm0Zwg/Listeners', 00:18:35 INFO - 'TMPDIR': '/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/', 00:18:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:18:35 INFO - 'USER': 'cltbld', 00:18:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:18:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:18:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:18:35 INFO - 'XPC_FLAGS': '0x0', 00:18:35 INFO - 'XPC_SERVICE_NAME': '0', 00:18:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:18:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:18:35 INFO - Downloading/unpacking flake8 00:18:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:18:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:18:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:18:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:18:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:18:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:18:38 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 00:18:38 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 00:18:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:18:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:18:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:18:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:18:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:18:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:18:38 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 00:18:38 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 00:18:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:18:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:18:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:18:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:18:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:18:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:18:39 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 00:18:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:18:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:18:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:18:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:18:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:18:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:18:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 00:18:39 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 00:18:39 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 00:18:39 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 00:18:39 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 00:18:39 INFO - no previously-included directories found matching 'docs/_build' 00:18:39 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 00:18:39 INFO - Running setup.py install for pep8 00:18:40 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 00:18:40 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 00:18:40 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 00:18:40 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 00:18:40 INFO - no previously-included directories found matching 'docs/_build' 00:18:40 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 00:18:40 INFO - Successfully installed flake8 mccabe pyflakes pep8 00:18:40 INFO - Cleaning up... 00:18:40 INFO - Return code: 0 00:18:40 INFO - Running post-action listener: _resource_record_post_action 00:18:40 INFO - Running post-action listener: _start_resource_monitoring 00:18:40 INFO - Starting resource monitoring. 00:18:40 INFO - ##### 00:18:40 INFO - ##### Running install step. 00:18:40 INFO - ##### 00:18:40 INFO - Running pre-action listener: _resource_record_pre_action 00:18:40 INFO - Running main action method: install 00:18:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 00:18:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 00:18:40 INFO - Reading from file tmpfile_stdout 00:18:40 INFO - Detecting whether we're running mozinstall >=1.0... 00:18:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 00:18:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 00:18:40 INFO - Reading from file tmpfile_stdout 00:18:40 INFO - Output received: 00:18:40 INFO - Usage: mozinstall [options] installer 00:18:40 INFO - Options: 00:18:40 INFO - -h, --help show this help message and exit 00:18:40 INFO - -d DEST, --destination=DEST 00:18:40 INFO - Directory to install application into. [default: 00:18:40 INFO - "/builds/slave/test"] 00:18:40 INFO - --app=APP Application being installed. [default: firefox] 00:18:40 INFO - mkdir: /builds/slave/test/build/application 00:18:40 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'] 00:18:40 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 00:19:12 INFO - Reading from file tmpfile_stdout 00:19:12 INFO - Output received: 00:19:12 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 00:19:12 INFO - Running post-action listener: _resource_record_post_action 00:19:12 INFO - ##### 00:19:12 INFO - ##### Running run-tests step. 00:19:12 INFO - ##### 00:19:12 INFO - Running pre-action listener: _resource_record_pre_action 00:19:12 INFO - Running main action method: run_tests 00:19:12 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 00:19:12 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 00:19:12 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 00:19:12 INFO - 2016-04-20 00:19:12.912 screenresolution[1922:15826] starting screenresolution argv=screenresolution get 00:19:12 INFO - 2016-04-20 00:19:12.915 screenresolution[1922:15826] Display 0: 1600x1200x32@60 00:19:12 INFO - 2016-04-20 00:19:12.921 screenresolution[1923:15828] starting screenresolution argv=screenresolution list 00:19:12 INFO - Available Modes on Display 0 00:19:12 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 00:19:12 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 00:19:12 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 00:19:12 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 00:19:13 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 00:19:13 INFO - Intel Iris: 00:19:13 INFO - Chipset Model: Intel Iris 00:19:13 INFO - Type: GPU 00:19:13 INFO - Bus: Built-In 00:19:13 INFO - VRAM (Dynamic, Max): 1536 MB 00:19:13 INFO - Vendor: Intel (0x8086) 00:19:13 INFO - Device ID: 0x0a2e 00:19:13 INFO - Revision ID: 0x0009 00:19:13 INFO - Displays: 00:19:13 INFO - Display: 00:19:13 INFO - Resolution: 1600 x 1200 @ 60 Hz 00:19:13 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 00:19:13 INFO - Display Serial Number: 1600x1200 60 00:19:13 INFO - Main Display: Yes 00:19:13 INFO - Mirror: Off 00:19:13 INFO - Online: Yes 00:19:13 INFO - Rotation: Supported 00:19:13 INFO - Return code: 0 00:19:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 00:19:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 00:19:13 INFO - Python 2.7.3 00:19:13 INFO - Return code: 0 00:19:13 INFO - grabbing minidump binary from tooltool 00:19: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')]} 00:19:13 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 0x109216d30>, '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 0x10907adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10920db20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 00:19:13 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 00:19:13 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 00:19:13 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 00:19:13 INFO - Return code: 0 00:19:13 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 00:19:13 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 00:19:13 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 00:19:13 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 00:19:13 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 00:19:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 00:19:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 00:19:14 INFO - Return code: 0 00:19:14 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/F2UAd3ecR-KTlDpvL5mYEg/artifacts/public/build/firefox-47.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0078', '--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 00:19:14 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/F2UAd3ecR-KTlDpvL5mYEg/artifacts/public/build/firefox-47.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0078 --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 00:19:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.J3hKxV99GU/Render', 00:19:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:19:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:19:14 INFO - 'HOME': '/Users/cltbld', 00:19:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:19:14 INFO - 'LOGNAME': 'cltbld', 00:19:14 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 00:19:14 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 00:19:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:19:14 INFO - 'MOZ_NO_REMOTE': '1', 00:19:14 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 00:19:14 INFO - 'NO_EM_RESTART': '1', 00:19:14 INFO - 'PAGER': '/bin/cat', 00:19:14 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:19:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:19:14 INFO - 'PWD': '/builds/slave/test', 00:19:14 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 00:19:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:19:14 INFO - 'SHELL': '/bin/bash', 00:19:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.q5WcXm0Zwg/Listeners', 00:19:14 INFO - 'TMPDIR': '/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/', 00:19:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:19:14 INFO - 'USER': 'cltbld', 00:19:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:19:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:19:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:19:14 INFO - 'XPC_FLAGS': '0x0', 00:19:14 INFO - 'XPC_SERVICE_NAME': '0', 00:19:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:19:14 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/F2UAd3ecR-KTlDpvL5mYEg/artifacts/public/build/firefox-47.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0078', '--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 00:19:14 INFO - mozversion application_buildid: 20160419222814 00:19:14 INFO - mozversion application_changeset: 8210de2a2b4fdb1701d3dadf65184bda51d6fbe7 00:19:14 INFO - mozversion application_display_name: FirefoxDeveloperEdition 00:19:14 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 00:19:14 INFO - mozversion application_name: Firefox 00:19:14 INFO - mozversion application_remotingname: firefox-dev 00:19:14 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 00:19:14 INFO - mozversion application_vendor: Mozilla 00:19:14 INFO - mozversion application_version: 47.0a2 00:19:14 INFO - mozversion platform_buildid: 20160419222814 00:19:14 INFO - mozversion platform_changeset: 8210de2a2b4fdb1701d3dadf65184bda51d6fbe7 00:19:14 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 00:19:14 INFO - mozversion platform_version: 47.0a2 00:19:14 INFO - using testdate: 1461136754 00:19:14 INFO - actual date: 1461136754 00:19:14 INFO - starting webserver on 'localhost:52461' 00:19:14 INFO - SUITE-START | Running 2 tests 00:19:14 INFO - TEST-START | dromaeo_css 00:19:14 INFO - operating with platform_type : mac_ 00:19:14 INFO - Initialising browser for dromaeo_css test... 00:19:14 INFO - TEST-INFO | started process 1941 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/tmp431vY0/profile http://localhost:52461/getInfo.html) 00:19:17 INFO - PROCESS | 1941 | __metrics Screen width/height:1600/1200 00:19:17 INFO - PROCESS | 1941 | colorDepth:24 00:19:17 INFO - PROCESS | 1941 | Browser inner width/height: 1024/689 00:19:17 INFO - PROCESS | 1941 | __metrics 00:19:17 ERROR - PROCESS | 1941 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 00:19:17 INFO - TEST-INFO | 1941: exit 0 00:19:17 INFO - Browser initialized. 00:19:17 INFO - Running cycle 1/1 for dromaeo_css test... 00:19:17 INFO - TEST-INFO | started process 1944 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/tmp431vY0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 00:19:29 INFO - PROCESS | 1944 | RSS: Main: 217817088 00:19:29 INFO - PROCESS | 1944 | 00:20:19 INFO - PROCESS | 1944 | 1461136819435 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] 00:22:29 INFO - PROCESS | 1944 | Cycle 1(1): loaded http://localhost:52461/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52461/tests/dromaeo/cssquery-ext.html) 00:22:30 INFO - PROCESS | 1944 | RSS: Main: 228499456 00:22:30 INFO - PROCESS | 1944 | 00:25:32 INFO - PROCESS | 1944 | Cycle 1(1): loaded http://localhost:52461/tests/dromaeo/cssquery-ext.html (next: http://localhost:52461/tests/dromaeo/cssquery-jquery.html) 00:25:32 INFO - PROCESS | 1944 | RSS: Main: 240050176 00:25:32 INFO - PROCESS | 1944 | 00:28:34 INFO - PROCESS | 1944 | Cycle 1(1): loaded http://localhost:52461/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52461/tests/dromaeo/cssquery-mootools.html) 00:28:35 INFO - PROCESS | 1944 | RSS: Main: 241909760 00:28:35 INFO - PROCESS | 1944 | 00:31:36 INFO - PROCESS | 1944 | Cycle 1(1): loaded http://localhost:52461/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52461/tests/dromaeo/cssquery-prototype.html) 00:31:37 INFO - PROCESS | 1944 | RSS: Main: 243671040 00:31:37 INFO - PROCESS | 1944 | 00:34:40 INFO - PROCESS | 1944 | Cycle 1(1): loaded http://localhost:52461/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52461/tests/dromaeo/cssquery-yui.html) 00:34:40 INFO - PROCESS | 1944 | RSS: Main: 246673408 00:34:40 INFO - PROCESS | 1944 | 00:37:42 INFO - PROCESS | 1944 | Cycle 1(1): loaded http://localhost:52461/tests/dromaeo/cssquery-yui.html (next: http://localhost:52461/tests/dromaeo/cssquery-dojo.html) 00:37:43 INFO - PROCESS | 1944 | RSS: Main: 247590912 00:37:43 INFO - PROCESS | 1944 | 00:37:43 INFO - PROCESS | 1944 | __start_tp_report 00:37:43 INFO - PROCESS | 1944 | _x_x_mozilla_page_load 00:37:43 INFO - PROCESS | 1944 | _x_x_mozilla_page_load_details 00:37:43 INFO - PROCESS | 1944 | |i|pagename|runs| 00:37:43 INFO - PROCESS | 1944 | |0;dojo.html;2847.373577812881;3139.4349017176905;3498.807565583895;3522.418800897852;3533.1873669056117;5671.7731290748325;5686.20393144959;5691.971540142304;5723.885522289552;5746.885062298751;5658.43415658434;5707.743151558179;5724.685142317171;5726.083826587746;5740.569457290699;5124.590032797386;5127.692338459686;5178.48215178481;5234.764435600388;5269.051570717269;5132.28148059272;5239.659422137549;5279.996800607892;5293.417724050351;5300.787968481275;5133.2300154976865;5205.349331333583;5233.842984710464;5276.4459731728;5289.471052894699;5179.585633149339;5205.479452054802;5211.947880521184;5213.113770658997;5274.815381461669;5022.397312322508;5101.846944591668;5159.200323949756;5190.299309593194;5192.71440070796;5471.23402723619;5558.166275058733;5576.024195765765;5595.832125036215;5608.411116832755;6093.573449858467;6137.41694539018;6140.324564297924;6176.752929882799;6188.226471691039;5072.847814565569;6048.667323297217;6230;6259.499240060784;6265.060240963846;5764.682942438164;5805.651660900359;5815.563832712522;5831.970840145772;5849.85375365615;6241.687915604201;6244.531660125509;6246.6876656167005;6247.531435142382;6255.874882502416;5180.352455943007;6008.369121242294;6135.877282454326;6142.877142457215;6148.600340977822;6193.752249910043;6195.876082478325;6226.813195604139;6227.439530442282;6238.750449982041;6070.726817293233;6170.907436388457;6185.721642526097;6190.876182476325;6200.038993955944;6109.16175461965;6143.600665956698;6187.783427580013;6223.1287619733275;6236;4888.364512613338;4892.339534162914;4901;4909.68087074339;4912.803487860446;4384.430024096847;4403.2734598791485;4425.004374015885;4428.092241090569;4430.246858034142;4581.358609794632;4845.345878306454;5607.355154157324;5687.146927960839;5727.799527016535;6108.35862234459;6148.323684394713;6233.815575040728;6240.65676387794;6245.781397651152;5457.263269458652;5762.567807414377;5770.422957704196;5842.883142337129;5845.561582881301;5254.816081437131;5355.598330125178;5404.8108316208745;5414.539764120015;5443.42844001382;6358.554901156875;6361.809145725636;6390.265119511223;6398.999999999907;6415.615063096229;6121.602095863755;6136.23297087864;6146.200993870768;6167.167432396569;6172.351903050115;6179.474744646755;6249.25008998923;6400.807975760735;6406.5515413920575;6442.8389290268115;6095.939040609537;6108;6112.32764395925;6112.908306375319;6129.570930034854;6104.664243466652;6174.691265436621;6176.166217560752;6178.691065446799;6193.040078787795;5972.790952316648;6009.429104235091;6099.84750381244;6111.98679349419;6142.2629284484365;6051.576389652682;6085.604435711664;6089.725962331617;6095.51235901118;6102.786402475892;5719.199312096393;5971.014782560829;5992.280926288873;5993.220881285405;6007.759689612367;5997.850053748692;6082.665453399928;6095.512359011357;6106.023036314168;6129.448349648553;5893.5874488787085;5900.64596124234;5923.881522369615;5992.280926288873;6025.758969641341 00:37:43 INFO - PROCESS | 1944 | |1;ext.html;533.0245650459659;544.9101796407185;578.7816645960254;675.844555752177;678.1895634716515;38066.42900356493;38691;38753.41869871947;38769;38820.80589597048;40227;40545.391819122735;40601.59398406015;40636.78089657307;40753.796231018874;9597.952010239975;9625.22998160149;9663.323567350271;9668.564914578861;9704;7977.601119944009;7978.242067003625;7984.161663025386;8058.717944871931;8077.313428358597;8009.559474228915;8009.879851802228;8017.799555011113;8126;8205.712800051999;7953.761387158394;7960.761177164694;8004.159563245834;8145.470544414624;8216.424850260484;9585.233181345475;9682.70951871445;9711.397619392792;9731.221502279801;9776.853347199798;38618.227635447416;38706;38740;38880.61119388827;39106;2353.7175538935267;3116.719495245416;3311.5529403530695;3371.123507887942;3449.034270404291;28414.28964275889;28641.57037644437;28744;29044.709552904413;29117.70882291171;2220.9333719988263;2598.285471495335;2602.232341459255;2603.765661090511;2636.8813403396703;488085;488706;493690;494836;497150;70608.64695676489;70970;71242;71314.64342678254;71332.64333678402;65133.67433162804;72971.63514182501;73150.63424682949;73716;74851.62574187094;14730.337134828958;17218.397356092475;17420.651586968444;17569.912150439166;17608.647827043387;13212.009099317398;13219.867801322056;13413.195208287534;13449.529266475627;13527.188368697909;17630.82369176292;19965.800341996684;21556.89221553882;21899.562008760055;21933.890330548245;8115.472494287852;9325.440473571607;9467.289953253396;9537.189338906132;9575.281853860988;986.3933680786265;1011.3476807459148;1059.2705995431982;1073.0878753059837;1084.1218612923558;24285.621719691473;29517.557236641467;29600.703992959796;30058.39883202324;30642.92749753748;1050.5850189175233;1059.2267644619317;1121.8317252412203;1197.5688752049255;1214.7570485902854;14929.701405972037;15170.469033583771;15199.316030778642;15250.9269724188;15265.313060912285;543552;547731;552454;553695;555179;55789.16316255259;59942.70028649916;60194;60201.397986019576;60295.69852150711;1567.498400511848;1578.8026496687914;1589.1100983449305;1592.6496170842397;1595.39375037485;29167.85416072906;29297.121086367442;29474.557881631365;29740.256493587833;29911.850440748527;50047.499525004285;50459.74770126273;50476.74761626168;50583.74708126436;50586.49413505818;499613;511682;511740;512128;513094;33459.83270083634;34061.48907766336;34164;34337.656623433446;34755.9573212804;44994.550054499035;45017;45277.094458111314;46079.76960115178;46770;31118;36900.446493302086;37203;37697.86906392813;38202.617973819906;36990.260194796494;37083.25833483369;37155;37328.25343493169;37355.439668404455;31607.84196079005;36554.8172259137;36833.81583092068;36932.26135477329;37352.813235933645;29356.412871742872;30988.84505577458;31167.68832311648;31178.532322015642;31315.060548183592;20193.59612807765;20512.282070127472;24891.354784630013;25138.497230055662;25426.491470170862 00:37:43 INFO - PROCESS | 1944 | |2;jquery.html;310.7591616497216;366.19254543731057;370.9573399059109;377.8054302034452;380.0896852039364;20221.191152353906;20574.588508229845;21040.473988150305;21246.36260912173;21294.57410851782;20603.381898543066;21242.150313987422;21432.785672143273;21494.032768525416;21632.89183554084;5798.420157984199;6035.185249991239;6060.909086363708;6071.4232147946095;6080.604760690541;5016.523430274118;5645.096784514479;5783.5951483396175;5840.912386314188;5924.111383292519;5787.826365209029;5838.241028666267;5851.297844258695;5860.443257890493;5879.32387775407;5670.8015219467325;5845.941540584604;5931.347551769302;5939.703014849283;5948.851278718023;5148.897022059537;5170.25031370453;5178.792848286064;5179.300794392747;5190.7404629768735;22036.779632203794;26001;26562.33594160142;27143.728562714317;27502.449951000868;1957.667196576571;2175.575762726269;2228.075348730275;2350.8707021113833;2446.47400808827;14993.32530036151;15669.843301567067;15726.977746446559;15743.055416675035;15882.444114455939;1412.6185929798999;1698.651776385838;1736.6179440523065;1749.247823435922;1791.570023194437;96664;104345;109189.45405273003;109846;110178.44910775394;11128.276662016942;11706.600146969851;11908;11948.820767688492;12016.33910134951;14559;14564.49024284145;14653.047551909092;14728;14751.63120921964;9077.45535267886;9120.908790912139;9124.361294709306;9144.314176436794;9210.986791452935;9189.3108016899;9235.353525253167;9236.122568355995;9263.120003599783;9276.07239276067;3937.684985201177;4463.419755431773;4557.977210113928;4565.474970378449;4625.560571745679;1928.4696708405302;1940.1269428757116;1950.629380417716;1956.3935180094215;1994.321930543622;880.9867851982225;895.4985208283382;910.2945217456391;940.2243149401634;1056.155075939261;18734;20731.067101980447;21247.893760531097;21832.345029649136;21844.563108737737;936.194872409727;974.2985050763439;978.3933960944117;1000.2648053680539;1013.5844303835393;11389.772204555862;11713.531458741725;11754.823677644843;11761.059115270758;11761.470733817;675099;678282;693023;694417;699248;97488;130314.34842825915;130489;132297;134049;1051.558345494894;1089.4117176724637;1105.8949399807007;1115.8437818705388;1120.288616728367;15356.464353564554;19135.904320478865;19357.225710971405;19407.417777466697;19684.50788730293;53220.66948326323;54009.919801604534;54654;54773.63065923384;57034.574135646944;77526;80584.59707701424;81345;82185.35629287262;82762.75855862047;8321.08468068524;8394;8408.2432581068;8537.74386768398;8645.736522720046;9528.380655257386;13076.411561479566;13500.797488037884;13766.793498097337;13911.652208694864;11211.887881121085;11801.822972655245;11913.82129268079;12137.57518486884;12138.635840924786;11276.830847537129;11546.82679759821;11733.296002239893;11893.464794084113;12026.75946481048;11806.58676946337;11858.110641701734;12005;12139.332336721212;12273.263604183778;8231.588420579066;8307.875381869399;8441.70454034106;8503.064662887202;8545.444546104483;10052.748681283027;11307.378094204898;12026.939865300617;12175.878241217475;12241.571544995883 00:37:43 INFO - PROCESS | 1944 | |3;mootools.html;1640.3110693508725;1652.7768751218587;1986.255154317131;2034.5727397246587;2100.705901173835;7440.441966852481;8205.220504052106;8982.820343593125;9200.125988031135;9219.446833190004;8818.118188181179;8869.201771840533;8888.55557222138;8937.150970657793;8959.686410975617;2538.3527200563876;2554.9361265968405;2564.7948164146824;2572.6141078838136;2580.870956452179;2549.3371723351875;2577.896884124642;2581.2772423721294;2583.4962182374443;2594.2347007632698;2517.6852893388327;2525.1162093267303;2543.9364015899564;2564.7948164146824;2571.4214301782135;2351.49442869783;2550.2859199424192;2553.502067096917;2553.859537725424;2579.2520169151016;2384.0106355862295;2395.532871090121;2569.5374832530138;2591.8444893306273;2594.8313359631566;7670.578118203496;9030.187283144549;9031.774205644846;9056.230220431271;9074.77313067172;5572.192032155355;5643.971780141114;5653.773849046033;5705.942940570582;5793.536517078665;3580.3555360035184;3667.8166091695575;3720.21875406165;3720.813959302051;3727.720420968411;1015.7612960954244;1039.7296702857311;1046.0637729232294;1046.7278507588005;1047.8271085270922;12201.633950981484;12230.205036672587;12373.948214401697;12378.56675016379;12464.875351246554;4996.325496058058;5063.13926632466;5108.233764935215;5138;5173.094708426011;10466.424346661006;10578;10584.841227381596;10587.470626468647;10596.682099537025;5702.087665973508;5726.312842458931;5740.827775166752;5749.626274292157;5762.394948530427;4559.612432943237;4943.209086546207;5007.24891266313;5029.84910452687;5136.845894623168;4109.8972525686495;4154.543000269968;4184.372344148342;4191.685623578243;4230.259704551752;1367.548708926052;1372.4167228927665;1381.8618138186303;1387.6877702516854;1394.274977011948;1063;1167.575557819459;1183.248637115438;1386.3414877933103;1473.2928194466715;8199.631016604148;8263.132371101068;8328.208820162075;8473.915260847436;8492.235698787015;529.8489930369826;531.4818052398957;535.9758810853521;539.4955716405174;540.497337476151;6316.526260530387;6347.714352854133;6395.136656551306;6401.615903045832;6402.039694045838;10562.260641755003;10904.945475272572;11005.89941005893;11052.281601695864;11084.556617735361;10485.266031377883;10694.037536621741;10816.188785841094;10835.729106772236;10862;7204.603746793977;8462.36532260083;8496.787580310418;8562.657493700182;8607.612657430305;7880.763577092696;8049.114597394165;8062.8790568142695;8127.3091787198755;8142.022957245168;9549.809003819746;9734.221262299141;9775.462349570558;9826.705198844045;9836.3606365586;9886.950565247127;10156.89843101589;10219.080282774587;10255.384676919408;10333.328333658288;6959.234484206834;7538.396928245617;7576.583287919218;7728.072631284282;7768.53388796674;8391.496510209407;8402.789930251549;8424.11546787603;8449.155084491502;8474.830503390021;7324.780256592311;7415.184329723834;7470.962645186739;7568.3945284378215;7576.810579735551;6281.937180628135;7353.742619008309;7427.2201418850245;7440.776776696708;7497.212792656693;7833.060032795873;7877.291043806085;7899.486533375312;7918.366530677416;7933.722319718782;7094.184168820651;7149.285071493017;7203.891941620985;7227.349538541556;7228.385587225145;7293.598852062975;7311.744088956861;7360.411167106726;7426.777196683892;7499.550026998398 00:37:43 INFO - PROCESS | 1944 | |4;prototype.html;289.23930063931857;301.3836703940443;333.95305716578525;339.6773065587691;339.8368782984166;6821.181458225007;6914.239433662293;6914.9973253878225;6968;7003.3346832050875;6787.558808677432;6800;6811.591304521732;6816.250212476623;6852.211995620505;4785.521447855204;4898.926516102243;5021.196608542634;5050.267711181877;5082.923756143661;4032.5765794591584;4960.925586116211;4998.925016124761;5006.249062640615;5013.273075404064;5004.524570165847;5015.122353588125;5023.095842748304;5034.42104158021;5060.797568097271;5043.672161309503;5044.419891712445;5066.518680725325;5074.340335756328;5075.822346217901;4356.89107772305;4357.150355680644;4361.738295702236;4362.149380870732;4365.192439398721;6291.937080629181;6607.174103237096;6617.636030018347;6619.86760264792;6639.468842492589;5866.501347385435;5901.645901245896;5902.9114563281155;5910.083936989773;5911.379305172981;7314.963425182893;7358.153812311599;7361.926380736178;7366.373858222058;7387.5936823474685;4399.450068741407;4481.991551900829;4724.645651576146;4742.905141897178;4745.098431298043;7676.46264761467;7747.845043099106;7754.069511658637;7759.2240775921955;7784.688612455495;4555.202839503074;4568.109218702321;4666.066786642685;4745.193317136095;4754.595859351924;4030.314846476106;4828.275758636232;4840.903181936412;4841.564259216688;4841.636877234221;5853.268341457318;5856.882862342729;5875.118732190205;5875.50058245054;5881.911771323434;6427.775027874002;6747.325267473213;7301.014363061025;7311.670974806147;7357.117145942414;1672.7574501697186;1697.5077227603856;1698.3716025070803;1698.8131305556378;1703.4463799265288;1038.7195457226508;1066.8559744434558;1091.9672409827717;1094.0536435982817;1094.316052467208;6739.191297044386;6782.660866956632;6794.72821087151;6822.727090916308;6844.076049733322;6271.404216599416;7098.793205155136;7603.239676032353;7612.885806712904;7620.923790762133;6816.284290149562;6830.180378354629;6838.384545390939;6841.760538381232;6873.037774711544;3813.694904407641;3945.92108157841;3992.461017762565;4000.899977500586;4003.3394489908837;6280.748770049238;7926.48477848938;7940.920590794133;7946.920530794734;7948.403869709795;7810.6875724971505;7821.100573434014;7821.608919554;7823.100343460461;7846.666066768663;6356.650384228819;7916.881246781303;7928.246816552418;7932.484388514728;7944.920550794418;7285.4900156990625;7556.8866467001935;7558.508696934681;7578.886316705143;7584.924150758642;7305.5981920994855;7331.266873312626;7370.852582948418;7384.076990376203;7384.261573842573;6385.489160867212;7855.5286682799215;7900.960495197487;7917.129115797143;8005.959970200344;4981.452040275494;5036.622253331088;5051.3433253676785;5054.2923990642075;5059.696418214919;7181.892271616034;7396.519226250277;7528.435367347581;7569.205233450629;7571.886421703789;7316.268373162641;7345.045144131229;7387.1874093848555;7388.593627350548;7395.556266624019;7339.8532029360185;7349.228331025165;7376.815579610338;7379.963100184465;7381.667824947783;6939.618320992394;7160.212376638461;7161.355478007004;7189.964050179716;7193.172785129568;7297.598632075287;7312.890306645299;7333.816654583678;7337;7384.96307518459;7106.822329441805;7145.285471452813;7162.534435261691;7163.391111755559;7168 00:37:43 INFO - PROCESS | 1944 | |5;yui.html;689.3485656055024;717.2218143314504;751.6166754954975;756.43267549338;763.4042468704397;15280.388784448623;15378.84621153788;15468.767968480468;15489.612759681013;15531.301091450883;14438.927805360958;14451.494197703083;14465.276736163203;14474.348654310556;14480.855191448083;778.8636988527013;956.8612551180074;962;981.40134517944;984.8325784616633;769.5113602862167;968.5544649461257;970.0445061614304;984.2372161574765;985.3201291109148;1021.3208216535994;1028.6245520385044;1031.4224034540644;1031.736907088695;1032.328986158999;996.1482932093029;1018.5467466977198;1026.5791025679473;1028.239103063735;1032.0969151992008;740.3558903753768;754.3248792330888;764.9349805266559;765.0971853213206;767.6814122139306;15253.542393728207;15339.693206135926;15371.846281537153;15547.766783498257;15580.143092129929;13236.338183090807;13269.933650331686;13272.402741876542;13324.800127998087;13444.86555134446;10167.135793457564;10332.948335258276;10334.7416314592;10411.375317480975;10522.78954420915;3552.8401221945073;3554.040409089557;3593.4250519916686;3651.1054791576234;3828.062124779447;79787;82364;83265;83500.58249708773;83631.74552381659;9313.301502387349;9722.9027709722;9772.267079969031;9774.657886973922;10107.54516046765;22718.864056797094;22978.080876764743;23036.769632303796;23047.193348232733;23051.423714406938;6674.5995240284765;7458.664360103699;7490.9887165233085;7615.657295421719;7652.693892244248;4138.689598280081;4189.308764053958;4191.3293872980175;4192.287311157111;4210.179015092089;3619.2942376236906;3652.6712595866497;3677.79772112531;3681.079730067483;3688.207035487383;647.2297965421134;653.1737352249409;656.4125108028288;657.5462930577982;658.9703463344161;568.7184843502492;592.5585438848086;596.5198015597485;604.4348534120611;614.9016157414792;6875.931240687529;8435.32517398619;8522.360822938304;8540.359473039547;8628.741137765877;477.92353223484076;520.8385400525849;568.9474472226348;599.9580029397988;599.9640021598718;3873.5932727063814;3873.767573945572;3876.1666241758157;3977.6420122188565;4089.836406543705;90199;93435.53282233546;94433.58349624761;94586;94621;57095.14357284644;64726.029109563395;78095;78281;78548;62303;69164.6541767288;69555;71570.64214678893;72939;8605.177430184418;8721.65113395457;8739.344549158966;8775.56122193875;8871.467711937046;46572.36996705099;47383.52616473791;48918;49416.50583494119;50982;62294;63626.68186659037;69568;70285.29714702787;72802;10894.945525272324;11072.557097716;11227.66317010491;11317.943410282896;11458.541658333574;11901.404929753651;12178.147529672839;12190.512379505075;12242.571509997108;12704.110712250054;9705.272104592043;9720.562574684298;10191.235657325878;10210.540525676213;10452.634157804441;11662.12534059966;11681.824772628588;11697.473613687234;11808.114391420506;12240;8478.618462169341;10659.667541557305;11513.30920144794;11514.30914145154;11734.647960561197;9480.288978326515;9588.232941364813;9964.202863771026;10249.538770755484;10258.948705256425;7944.324732397579;9794.951025244829;9807.21542276602;9830.852537212091;9965.551550180404 00:37:43 INFO - PROCESS | 1944 | __end_tp_report 00:37:43 INFO - PROCESS | 1944 | __start_cc_report 00:37:43 INFO - PROCESS | 1944 | _x_x_mozilla_cycle_collect,367 00:37:43 INFO - PROCESS | 1944 | __end_cc_report 00:37:43 INFO - PROCESS | 1944 | __startTimestamp1461137863136__endTimestamp 00:37:43 INFO - PROCESS | 1944 | 00:37:43 INFO - PROCESS | 1944 | ------- Summary: start ------- 00:37:43 INFO - PROCESS | 1944 | Number of tests: 6 00:37:43 INFO - PROCESS | 1944 | 00:37:43 INFO - PROCESS | 1944 | [#0] dojo.html Cycles:165 Average:5701.29 Median:5972.79 stddev:650.93 (10.9%) stddev-sans-first:613.22 00:37:43 INFO - PROCESS | 1944 | Values: 2847.4 3139.4 3498.8 3522.4 3533.2 5671.8 5686.2 5692.0 5723.9 5746.9 5658.4 5707.7 5724.7 5726.1 5740.6 5124.6 5127.7 5178.5 5234.8 5269.1 5132.3 5239.7 5280.0 5293.4 5300.8 5133.2 5205.3 5233.8 5276.4 5289.5 5179.6 5205.5 5211.9 5213.1 5274.8 5022.4 5101.8 5159.2 5190.3 5192.7 5471.2 5558.2 5576.0 5595.8 5608.4 6093.6 6137.4 6140.3 6176.8 6188.2 5072.8 6048.7 6230.0 6259.5 6265.1 5764.7 5805.7 5815.6 5832.0 5849.9 6241.7 6244.5 6246.7 6247.5 6255.9 5180.4 6008.4 6135.9 6142.9 6148.6 6193.8 6195.9 6226.8 6227.4 6238.8 6070.7 6170.9 6185.7 6190.9 6200.0 6109.2 6143.6 6187.8 6223.1 6236.0 4888.4 4892.3 4901.0 4909.7 4912.8 4384.4 4403.3 4425.0 4428.1 4430.2 4581.4 4845.3 5607.4 5687.1 5727.8 6108.4 6148.3 6233.8 6240.7 6245.8 5457.3 5762.6 5770.4 5842.9 5845.6 5254.8 5355.6 5404.8 5414.5 5443.4 6358.6 6361.8 6390.3 6399.0 6415.6 6121.6 6136.2 6146.2 6167.2 6172.4 6179.5 6249.3 6400.8 6406.6 6442.8 6095.9 6108.0 6112.3 6112.9 6129.6 6104.7 6174.7 6176.2 6178.7 6193.0 5972.8 6009.4 6099.8 6112.0 6142.3 6051.6 6085.6 6089.7 6095.5 6102.8 5719.2 5971.0 5992.3 5993.2 6007.8 5997.9 6082.7 6095.5 6106.0 6129.4 5893.6 5900.6 5923.9 5992.3 6025.8 00:37:43 INFO - PROCESS | 1944 | 00:37:43 INFO - PROCESS | 1944 | [#1] ext.html Cycles:180 Average:66177.24 Median:38654.61 stddev:137982.01 (357.0%) stddev-sans-first:138281.07 00:37:43 INFO - PROCESS | 1944 | Values: 533.0 544.9 578.8 675.8 678.2 38066.4 38691.0 38753.4 38769.0 38820.8 40227.0 40545.4 40601.6 40636.8 40753.8 9598.0 9625.2 9663.3 9668.6 9704.0 7977.6 7978.2 7984.2 8058.7 8077.3 8009.6 8009.9 8017.8 8126.0 8205.7 7953.8 7960.8 8004.2 8145.5 8216.4 9585.2 9682.7 9711.4 9731.2 9776.9 38618.2 38706.0 38740.0 38880.6 39106.0 2353.7 3116.7 3311.6 3371.1 3449.0 28414.3 28641.6 28744.0 29044.7 29117.7 2220.9 2598.3 2602.2 2603.8 2636.9 488085.0 488706.0 493690.0 494836.0 497150.0 70608.6 70970.0 71242.0 71314.6 71332.6 65133.7 72971.6 73150.6 73716.0 74851.6 14730.3 17218.4 17420.7 17569.9 17608.6 13212.0 13219.9 13413.2 13449.5 13527.2 17630.8 19965.8 21556.9 21899.6 21933.9 8115.5 9325.4 9467.3 9537.2 9575.3 986.4 1011.3 1059.3 1073.1 1084.1 24285.6 29517.6 29600.7 30058.4 30642.9 1050.6 1059.2 1121.8 1197.6 1214.8 14929.7 15170.5 15199.3 15250.9 15265.3 543552.0 547731.0 552454.0 553695.0 555179.0 55789.2 59942.7 60194.0 60201.4 60295.7 1567.5 1578.8 1589.1 1592.6 1595.4 29167.9 29297.1 29474.6 29740.3 29911.9 50047.5 50459.7 50476.7 50583.7 50586.5 499613.0 511682.0 511740.0 512128.0 513094.0 33459.8 34061.5 34164.0 34337.7 34756.0 44994.6 45017.0 45277.1 46079.8 46770.0 31118.0 36900.4 37203.0 37697.9 38202.6 36990.3 37083.3 37155.0 37328.3 37355.4 31607.8 36554.8 36833.8 36932.3 37352.8 29356.4 30988.8 31167.7 31178.5 31315.1 20193.6 20512.3 24891.4 25138.5 25426.5 00:37:43 INFO - PROCESS | 1944 | 00:37:43 INFO - PROCESS | 1944 | [#2] jquery.html Cycles:180 Average:37585.19 Median:21838.45 stddev:113786.99 (521.0%) stddev-sans-first:114071.77 00:37:43 INFO - PROCESS | 1944 | Values: 310.8 366.2 371.0 377.8 380.1 20221.2 20574.6 21040.5 21246.4 21294.6 20603.4 21242.2 21432.8 21494.0 21632.9 5798.4 6035.2 6060.9 6071.4 6080.6 5016.5 5645.1 5783.6 5840.9 5924.1 5787.8 5838.2 5851.3 5860.4 5879.3 5670.8 5845.9 5931.3 5939.7 5948.9 5148.9 5170.3 5178.8 5179.3 5190.7 22036.8 26001.0 26562.3 27143.7 27502.4 1957.7 2175.6 2228.1 2350.9 2446.5 14993.3 15669.8 15727.0 15743.1 15882.4 1412.6 1698.7 1736.6 1749.2 1791.6 96664.0 104345.0 109189.5 109846.0 110178.4 11128.3 11706.6 11908.0 11948.8 12016.3 14559.0 14564.5 14653.0 14728.0 14751.6 9077.5 9120.9 9124.4 9144.3 9211.0 9189.3 9235.4 9236.1 9263.1 9276.1 3937.7 4463.4 4558.0 4565.5 4625.6 1928.5 1940.1 1950.6 1956.4 1994.3 881.0 895.5 910.3 940.2 1056.2 18734.0 20731.1 21247.9 21832.3 21844.6 936.2 974.3 978.4 1000.3 1013.6 11389.8 11713.5 11754.8 11761.1 11761.5 675099.0 678282.0 693023.0 694417.0 699248.0 97488.0 130314.3 130489.0 132297.0 134049.0 1051.6 1089.4 1105.9 1115.8 1120.3 15356.5 19135.9 19357.2 19407.4 19684.5 53220.7 54009.9 54654.0 54773.6 57034.6 77526.0 80584.6 81345.0 82185.4 82762.8 8321.1 8394.0 8408.2 8537.7 8645.7 9528.4 13076.4 13500.8 13766.8 13911.7 11211.9 11801.8 11913.8 12137.6 12138.6 11276.8 11546.8 11733.3 11893.5 12026.8 11806.6 11858.1 12005.0 12139.3 12273.3 8231.6 8307.9 8441.7 8503.1 8545.4 10052.7 11307.4 12026.9 12175.9 12241.6 00:37:43 INFO - PROCESS | 1944 | 00:37:43 INFO - PROCESS | 1944 | [#3] mootools.html Cycles:180 Average:6193.18 Median:533.73 stddev:3265.48 (611.8%) stddev-sans-first:3256.71 00:37:43 INFO - PROCESS | 1944 | Values: 1640.3 1652.8 1986.3 2034.6 2100.7 7440.4 8205.2 8982.8 9200.1 9219.4 8818.1 8869.2 8888.6 8937.2 8959.7 2538.4 2554.9 2564.8 2572.6 2580.9 2549.3 2577.9 2581.3 2583.5 2594.2 2517.7 2525.1 2543.9 2564.8 2571.4 2351.5 2550.3 2553.5 2553.9 2579.3 2384.0 2395.5 2569.5 2591.8 2594.8 7670.6 9030.2 9031.8 9056.2 9074.8 5572.2 5644.0 5653.8 5705.9 5793.5 3580.4 3667.8 3720.2 3720.8 3727.7 1015.8 1039.7 1046.1 1046.7 1047.8 12201.6 12230.2 12373.9 12378.6 12464.9 4996.3 5063.1 5108.2 5138.0 5173.1 10466.4 10578.0 10584.8 10587.5 10596.7 5702.1 5726.3 5740.8 5749.6 5762.4 4559.6 4943.2 5007.2 5029.8 5136.8 4109.9 4154.5 4184.4 4191.7 4230.3 1367.5 1372.4 1381.9 1387.7 1394.3 1063.0 1167.6 1183.2 1386.3 1473.3 8199.6 8263.1 8328.2 8473.9 8492.2 529.8 531.5 536.0 539.5 540.5 6316.5 6347.7 6395.1 6401.6 6402.0 10562.3 10904.9 11005.9 11052.3 11084.6 10485.3 10694.0 10816.2 10835.7 10862.0 7204.6 8462.4 8496.8 8562.7 8607.6 7880.8 8049.1 8062.9 8127.3 8142.0 9549.8 9734.2 9775.5 9826.7 9836.4 9887.0 10156.9 10219.1 10255.4 10333.3 6959.2 7538.4 7576.6 7728.1 7768.5 8391.5 8402.8 8424.1 8449.2 8474.8 7324.8 7415.2 7471.0 7568.4 7576.8 6281.9 7353.7 7427.2 7440.8 7497.2 7833.1 7877.3 7899.5 7918.4 7933.7 7094.2 7149.3 7203.9 7227.3 7228.4 7293.6 7311.7 7360.4 7426.8 7499.6 00:37:43 INFO - PROCESS | 1944 | 00:37:43 INFO - PROCESS | 1944 | [#4] prototype.html Cycles:180 Average:5962.37 Median:6805.80 stddev:1910.90 (28.1%) stddev-sans-first:1868.21 00:37:43 INFO - PROCESS | 1944 | Values: 289.2 301.4 334.0 339.7 339.8 6821.2 6914.2 6915.0 6968.0 7003.3 6787.6 6800.0 6811.6 6816.3 6852.2 4785.5 4898.9 5021.2 5050.3 5082.9 4032.6 4960.9 4998.9 5006.2 5013.3 5004.5 5015.1 5023.1 5034.4 5060.8 5043.7 5044.4 5066.5 5074.3 5075.8 4356.9 4357.2 4361.7 4362.1 4365.2 6291.9 6607.2 6617.6 6619.9 6639.5 5866.5 5901.6 5902.9 5910.1 5911.4 7315.0 7358.2 7361.9 7366.4 7387.6 4399.5 4482.0 4724.6 4742.9 4745.1 7676.5 7747.8 7754.1 7759.2 7784.7 4555.2 4568.1 4666.1 4745.2 4754.6 4030.3 4828.3 4840.9 4841.6 4841.6 5853.3 5856.9 5875.1 5875.5 5881.9 6427.8 6747.3 7301.0 7311.7 7357.1 1672.8 1697.5 1698.4 1698.8 1703.4 1038.7 1066.9 1092.0 1094.1 1094.3 6739.2 6782.7 6794.7 6822.7 6844.1 6271.4 7098.8 7603.2 7612.9 7620.9 6816.3 6830.2 6838.4 6841.8 6873.0 3813.7 3945.9 3992.5 4000.9 4003.3 6280.7 7926.5 7940.9 7946.9 7948.4 7810.7 7821.1 7821.6 7823.1 7846.7 6356.7 7916.9 7928.2 7932.5 7944.9 7285.5 7556.9 7558.5 7578.9 7584.9 7305.6 7331.3 7370.9 7384.1 7384.3 6385.5 7855.5 7901.0 7917.1 8006.0 4981.5 5036.6 5051.3 5054.3 5059.7 7181.9 7396.5 7528.4 7569.2 7571.9 7316.3 7345.0 7387.2 7388.6 7395.6 7339.9 7349.2 7376.8 7380.0 7381.7 6939.6 7160.2 7161.4 7190.0 7193.2 7297.6 7312.9 7333.8 7337.0 7385.0 7106.8 7145.3 7162.5 7163.4 7168.0 00:37:43 INFO - PROCESS | 1944 | 00:37:43 INFO - PROCESS | 1944 | [#5] yui.html Cycles:180 Average:18247.12 Median:544.78 stddev:25439.40 (4669.7%) stddev-sans-first:25476.61 00:37:43 INFO - PROCESS | 1944 | Values: 689.3 717.2 751.6 756.4 763.4 15280.4 15378.8 15468.8 15489.6 15531.3 14438.9 14451.5 14465.3 14474.3 14480.9 778.9 956.9 962.0 981.4 984.8 769.5 968.6 970.0 984.2 985.3 1021.3 1028.6 1031.4 1031.7 1032.3 996.1 1018.5 1026.6 1028.2 1032.1 740.4 754.3 764.9 765.1 767.7 15253.5 15339.7 15371.8 15547.8 15580.1 13236.3 13269.9 13272.4 13324.8 13444.9 10167.1 10332.9 10334.7 10411.4 10522.8 3552.8 3554.0 3593.4 3651.1 3828.1 79787.0 82364.0 83265.0 83500.6 83631.7 9313.3 9722.9 9772.3 9774.7 10107.5 22718.9 22978.1 23036.8 23047.2 23051.4 6674.6 7458.7 7491.0 7615.7 7652.7 4138.7 4189.3 4191.3 4192.3 4210.2 3619.3 3652.7 3677.8 3681.1 3688.2 647.2 653.2 656.4 657.5 659.0 568.7 592.6 596.5 604.4 614.9 6875.9 8435.3 8522.4 8540.4 8628.7 477.9 520.8 568.9 600.0 600.0 3873.6 3873.8 3876.2 3977.6 4089.8 90199.0 93435.5 94433.6 94586.0 94621.0 57095.1 64726.0 78095.0 78281.0 78548.0 62303.0 69164.7 69555.0 71570.6 72939.0 8605.2 8721.7 8739.3 8775.6 8871.5 46572.4 47383.5 48918.0 49416.5 50982.0 62294.0 63626.7 69568.0 70285.3 72802.0 10894.9 11072.6 11227.7 11317.9 11458.5 11901.4 12178.1 12190.5 12242.6 12704.1 9705.3 9720.6 10191.2 10210.5 10452.6 11662.1 11681.8 11697.5 11808.1 12240.0 8478.6 10659.7 11513.3 11514.3 11734.6 9480.3 9588.2 9964.2 10249.5 10258.9 7944.3 9795.0 9807.2 9830.9 9965.6 00:37:43 INFO - PROCESS | 1944 | -------- Summary: end -------- 00:37:43 INFO - PROCESS | 1944 | 00:37:43 INFO - TEST-INFO | 1944: exit 0 00:37:43 INFO - TEST-OK | dromaeo_css | took 1109006ms 00:37:43 INFO - TEST-START | kraken 00:37:43 INFO - operating with platform_type : mac_ 00:37:43 INFO - Initialising browser for kraken test... 00:37:43 INFO - TEST-INFO | started process 1950 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/tmpDr1Kge/profile http://localhost:52461/getInfo.html) 00:37:46 INFO - PROCESS | 1950 | __metrics Screen width/height:1600/1200 00:37:46 INFO - PROCESS | 1950 | colorDepth:24 00:37:46 INFO - PROCESS | 1950 | Browser inner width/height: 1024/689 00:37:46 INFO - PROCESS | 1950 | __metrics 00:37:46 ERROR - PROCESS | 1950 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 00:37:46 INFO - TEST-INFO | 1950: exit 0 00:37:46 INFO - Browser initialized. 00:37:46 INFO - Running cycle 1/1 for kraken test... 00:37:46 INFO - TEST-INFO | started process 1953 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/tmpDr1Kge/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 00:37:58 INFO - PROCESS | 1953 | RSS: Main: 217444352 00:37:58 INFO - PROCESS | 1953 | 00:38:01 INFO - PROCESS | 1953 | Cycle 1(1): loaded http://localhost:52461/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52461/tests/kraken/driver.html?testName=audio-beat-detection) 00:38:02 INFO - PROCESS | 1953 | RSS: Main: 229830656 00:38:02 INFO - PROCESS | 1953 | 00:38:05 INFO - PROCESS | 1953 | Cycle 1(1): loaded http://localhost:52461/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52461/tests/kraken/driver.html?testName=audio-dft) 00:38:05 INFO - PROCESS | 1953 | RSS: Main: 239390720 00:38:05 INFO - PROCESS | 1953 | 00:38:09 INFO - PROCESS | 1953 | Cycle 1(1): loaded http://localhost:52461/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52461/tests/kraken/driver.html?testName=audio-fft) 00:38:09 INFO - PROCESS | 1953 | RSS: Main: 241324032 00:38:09 INFO - PROCESS | 1953 | 00:38:11 INFO - PROCESS | 1953 | Cycle 1(1): loaded http://localhost:52461/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52461/tests/kraken/driver.html?testName=audio-oscillator) 00:38:12 INFO - PROCESS | 1953 | RSS: Main: 243052544 00:38:12 INFO - PROCESS | 1953 | 00:38:14 INFO - PROCESS | 1953 | Cycle 1(1): loaded http://localhost:52461/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52461/tests/kraken/driver.html?testName=imaging-gaussian-blur) 00:38:15 INFO - PROCESS | 1953 | RSS: Main: 243437568 00:38:15 INFO - PROCESS | 1953 | 00:38:17 INFO - PROCESS | 1953 | Cycle 1(1): loaded http://localhost:52461/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52461/tests/kraken/driver.html?testName=imaging-darkroom) 00:38:18 INFO - PROCESS | 1953 | RSS: Main: 242716672 00:38:18 INFO - PROCESS | 1953 | 00:38:21 INFO - PROCESS | 1953 | Cycle 1(1): loaded http://localhost:52461/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52461/tests/kraken/driver.html?testName=imaging-desaturate) 00:38:22 INFO - PROCESS | 1953 | RSS: Main: 244629504 00:38:22 INFO - PROCESS | 1953 | 00:38:24 INFO - PROCESS | 1953 | Cycle 1(1): loaded http://localhost:52461/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52461/tests/kraken/driver.html?testName=json-parse-financial) 00:38:25 INFO - PROCESS | 1953 | RSS: Main: 244080640 00:38:25 INFO - PROCESS | 1953 | 00:38:27 INFO - PROCESS | 1953 | Cycle 1(1): loaded http://localhost:52461/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52461/tests/kraken/driver.html?testName=json-stringify-tinderbox) 00:38:27 INFO - PROCESS | 1953 | RSS: Main: 244121600 00:38:27 INFO - PROCESS | 1953 | 00:38:29 INFO - PROCESS | 1953 | Cycle 1(1): loaded http://localhost:52461/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52461/tests/kraken/driver.html?testName=stanford-crypto-aes) 00:38:30 INFO - PROCESS | 1953 | RSS: Main: 244310016 00:38:30 INFO - PROCESS | 1953 | 00:38:32 INFO - PROCESS | 1953 | Cycle 1(1): loaded http://localhost:52461/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52461/tests/kraken/driver.html?testName=stanford-crypto-ccm) 00:38:32 INFO - PROCESS | 1953 | RSS: Main: 245350400 00:38:32 INFO - PROCESS | 1953 | 00:38:35 INFO - PROCESS | 1953 | Cycle 1(1): loaded http://localhost:52461/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52461/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 00:38:36 INFO - PROCESS | 1953 | RSS: Main: 244936704 00:38:36 INFO - PROCESS | 1953 | 00:38:38 INFO - PROCESS | 1953 | Cycle 1(1): loaded http://localhost:52461/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52461/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 00:38:39 INFO - PROCESS | 1953 | RSS: Main: 244781056 00:38:39 INFO - PROCESS | 1953 | 00:38:41 INFO - PROCESS | 1953 | Cycle 1(1): loaded http://localhost:52461/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52461/tests/kraken/driver.html?testName=ai-astar) 00:38:41 INFO - PROCESS | 1953 | RSS: Main: 246665216 00:38:41 INFO - PROCESS | 1953 | 00:38:41 INFO - PROCESS | 1953 | __start_tp_report 00:38:41 INFO - PROCESS | 1953 | _x_x_mozilla_page_load 00:38:41 INFO - PROCESS | 1953 | _x_x_mozilla_page_load_details 00:38:41 INFO - PROCESS | 1953 | |i|pagename|runs| 00:38:41 INFO - PROCESS | 1953 | |0;ai-astar;132;114;113;114;115;148;169;167;118;104 00:38:41 INFO - PROCESS | 1953 | |1;audio-beat-detection;147;120;145;170;150;144;145;174;181;153 00:38:41 INFO - PROCESS | 1953 | |2;audio-dft;197;232;226;204;201;231;211;280;242;196 00:38:41 INFO - PROCESS | 1953 | |3;audio-fft;73;71;76;116;59;57;57;62;116;73 00:38:41 INFO - PROCESS | 1953 | |4;audio-oscillator;85;86;130;116;72;87;152;65;64;105 00:38:41 INFO - PROCESS | 1953 | |5;imaging-gaussian-blur;89;132;82;132;135;125;90;86;88;86 00:38:41 INFO - PROCESS | 1953 | |6;imaging-darkroom;130;118;94;123;100;149;121;94;95;94 00:38:41 INFO - PROCESS | 1953 | |7;imaging-desaturate;91;96;92;91;93;90;91;90;90;93 00:38:41 INFO - PROCESS | 1953 | |8;json-parse-financial;56;60;58;61;62;61;61;70;58;55 00:38:41 INFO - PROCESS | 1953 | |9;json-stringify-tinderbox;64;65;71;68;76;69;68;66;66;70 00:38:41 INFO - PROCESS | 1953 | |10;stanford-crypto-aes;87;84;85;98;72;108;116;110;109;99 00:38:41 INFO - PROCESS | 1953 | |11;stanford-crypto-ccm;133;118;131;119;136;152;136;142;136;119 00:38:41 INFO - PROCESS | 1953 | |12;stanford-crypto-pbkdf2;128;128;139;170;137;126;164;177;150;128 00:38:41 INFO - PROCESS | 1953 | |13;stanford-crypto-sha256-iterative;67;67;66;67;68;66;69;65;66;64 00:38:41 INFO - PROCESS | 1953 | __end_tp_report 00:38:41 INFO - PROCESS | 1953 | __start_cc_report 00:38:41 INFO - PROCESS | 1953 | _x_x_mozilla_cycle_collect,929 00:38:41 INFO - PROCESS | 1953 | __end_cc_report 00:38:41 INFO - PROCESS | 1953 | __startTimestamp1461137921339__endTimestamp 00:38:41 INFO - PROCESS | 1953 | 00:38:41 INFO - PROCESS | 1953 | ------- Summary: start ------- 00:38:41 INFO - PROCESS | 1953 | Number of tests: 14 00:38:41 INFO - PROCESS | 1953 | 00:38:41 INFO - PROCESS | 1953 | [#0] ai-astar Cycles:10 Average:129.40 Median:125.00 stddev:23.71 (19.0%) stddev-sans-first:25.13 00:38:41 INFO - PROCESS | 1953 | Values: 132.0 114.0 113.0 114.0 115.0 148.0 169.0 167.0 118.0 104.0 00:38:41 INFO - PROCESS | 1953 | 00:38:41 INFO - PROCESS | 1953 | [#1] audio-beat-detection Cycles:10 Average:152.90 Median:151.50 stddev:17.82 (11.8%) stddev-sans-first:18.77 00:38:41 INFO - PROCESS | 1953 | Values: 147.0 120.0 145.0 170.0 150.0 144.0 145.0 174.0 181.0 153.0 00:38:41 INFO - PROCESS | 1953 | 00:38:41 INFO - PROCESS | 1953 | [#2] audio-dft Cycles:10 Average:222.00 Median:228.50 stddev:26.14 (11.4%) stddev-sans-first:26.11 00:38:41 INFO - PROCESS | 1953 | Values: 197.0 232.0 226.0 204.0 201.0 231.0 211.0 280.0 242.0 196.0 00:38:41 INFO - PROCESS | 1953 | 00:38:41 INFO - PROCESS | 1953 | [#3] audio-fft Cycles:10 Average:76.00 Median:66.50 stddev:22.24 (33.4%) stddev-sans-first:23.56 00:38:41 INFO - PROCESS | 1953 | Values: 73.0 71.0 76.0 116.0 59.0 57.0 57.0 62.0 116.0 73.0 00:38:41 INFO - PROCESS | 1953 | 00:38:41 INFO - PROCESS | 1953 | [#4] audio-oscillator Cycles:10 Average:96.20 Median:68.50 stddev:29.13 (42.5%) stddev-sans-first:30.61 00:38:41 INFO - PROCESS | 1953 | Values: 85.0 86.0 130.0 116.0 72.0 87.0 152.0 65.0 64.0 105.0 00:38:41 INFO - PROCESS | 1953 | 00:38:41 INFO - PROCESS | 1953 | [#5] imaging-gaussian-blur Cycles:10 Average:104.50 Median:86.00 stddev:23.04 (26.8%) stddev-sans-first:23.74 00:38:41 INFO - PROCESS | 1953 | Values: 89.0 132.0 82.0 132.0 135.0 125.0 90.0 86.0 88.0 86.0 00:38:41 INFO - PROCESS | 1953 | 00:38:41 INFO - PROCESS | 1953 | [#6] imaging-darkroom Cycles:10 Average:111.80 Median:121.50 stddev:19.25 (15.8%) stddev-sans-first:19.26 00:38:41 INFO - PROCESS | 1953 | Values: 130.0 118.0 94.0 123.0 100.0 149.0 121.0 94.0 95.0 94.0 00:38:41 INFO - PROCESS | 1953 | 00:38:41 INFO - PROCESS | 1953 | [#7] imaging-desaturate Cycles:10 Average:91.70 Median:91.50 stddev:1.89 (2.1%) stddev-sans-first:1.99 00:38:41 INFO - PROCESS | 1953 | Values: 91.0 96.0 92.0 91.0 93.0 90.0 91.0 90.0 90.0 93.0 00:38:41 INFO - PROCESS | 1953 | 00:38:41 INFO - PROCESS | 1953 | [#8] json-parse-financial Cycles:10 Average:60.20 Median:61.00 stddev:4.16 (6.8%) stddev-sans-first:4.12 00:38:41 INFO - PROCESS | 1953 | Values: 56.0 60.0 58.0 61.0 62.0 61.0 61.0 70.0 58.0 55.0 00:38:41 INFO - PROCESS | 1953 | 00:38:41 INFO - PROCESS | 1953 | [#9] json-stringify-tinderbox Cycles:10 Average:68.30 Median:68.50 stddev:3.50 (5.1%) stddev-sans-first:3.35 00:38:41 INFO - PROCESS | 1953 | Values: 64.0 65.0 71.0 68.0 76.0 69.0 68.0 66.0 66.0 70.0 00:38:41 INFO - PROCESS | 1953 | 00:38:41 INFO - PROCESS | 1953 | [#10] stanford-crypto-aes Cycles:10 Average:96.80 Median:84.50 stddev:14.29 (16.9%) stddev-sans-first:14.71 00:38:41 INFO - PROCESS | 1953 | Values: 87.0 84.0 85.0 98.0 72.0 108.0 116.0 110.0 109.0 99.0 00:38:41 INFO - PROCESS | 1953 | 00:38:41 INFO - PROCESS | 1953 | [#11] stanford-crypto-ccm Cycles:10 Average:132.20 Median:136.00 stddev:10.97 (8.1%) stddev-sans-first:11.63 00:38:41 INFO - PROCESS | 1953 | Values: 133.0 118.0 131.0 119.0 136.0 152.0 136.0 142.0 136.0 119.0 00:38:41 INFO - PROCESS | 1953 | 00:38:41 INFO - PROCESS | 1953 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:144.70 Median:144.50 stddev:19.33 (13.4%) stddev-sans-first:19.53 00:38:41 INFO - PROCESS | 1953 | Values: 128.0 128.0 139.0 170.0 137.0 126.0 164.0 177.0 150.0 128.0 00:38:41 INFO - PROCESS | 1953 | 00:38:41 INFO - PROCESS | 1953 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.50 Median:67.00 stddev:1.43 (2.1%) stddev-sans-first:1.51 00:38:41 INFO - PROCESS | 1953 | Values: 67.0 67.0 66.0 67.0 68.0 66.0 69.0 65.0 66.0 64.0 00:38:41 INFO - PROCESS | 1953 | -------- Summary: end -------- 00:38:41 INFO - PROCESS | 1953 | 00:38:42 INFO - TEST-INFO | 1953: exit 0 00:38:42 INFO - TEST-OK | kraken | took 58578ms 00:38:42 INFO - SUITE-END | took 1167s 00:38:42 INFO - Completed test suite (00:19:27) 00:38:42 INFO - javascript benchmark 00:38:42 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2847.373577812881, 3139.4349017176905, 3498.807565583895, 3522.418800897852, 3533.1873669056117, 5671.7731290748325, 5686.20393144959, 5691.971540142304, 5723.885522289552, 5746.885062298751, 5658.43415658434, 5707.743151558179, 5724.685142317171, 5726.083826587746, 5740.569457290699, 5124.590032797386, 5127.692338459686, 5178.48215178481, 5234.764435600388, 5269.051570717269, 5132.28148059272, 5239.659422137549, 5279.996800607892, 5293.417724050351, 5300.787968481275, 5133.2300154976865, 5205.349331333583, 5233.842984710464, 5276.4459731728, 5289.471052894699, 5179.585633149339, 5205.479452054802, 5211.947880521184, 5213.113770658997, 5274.815381461669, 5022.397312322508, 5101.846944591668, 5159.200323949756, 5190.299309593194, 5192.71440070796, 5471.23402723619, 5558.166275058733, 5576.024195765765, 5595.832125036215, 5608.411116832755, 6093.573449858467, 6137.41694539018, 6140.324564297924, 6176.752929882799, 6188.226471691039, 5072.847814565569, 6048.667323297217, 6230.0, 6259.499240060784, 6265.060240963846, 5764.682942438164, 5805.651660900359, 5815.563832712522, 5831.970840145772, 5849.85375365615, 6241.687915604201, 6244.531660125509, 6246.6876656167005, 6247.531435142382, 6255.874882502416, 5180.352455943007, 6008.369121242294, 6135.877282454326, 6142.877142457215, 6148.600340977822, 6193.752249910043, 6195.876082478325, 6226.813195604139, 6227.439530442282, 6238.750449982041, 6070.726817293233, 6170.907436388457, 6185.721642526097, 6190.876182476325, 6200.038993955944, 6109.16175461965, 6143.600665956698, 6187.783427580013, 6223.1287619733275, 6236.0, 4888.364512613338, 4892.339534162914, 4901.0, 4909.68087074339, 4912.803487860446, 4384.430024096847, 4403.2734598791485, 4425.004374015885, 4428.092241090569, 4430.246858034142, 4581.358609794632, 4845.345878306454, 5607.355154157324, 5687.146927960839, 5727.799527016535, 6108.35862234459, 6148.323684394713, 6233.815575040728, 6240.65676387794, 6245.781397651152, 5457.263269458652, 5762.567807414377, 5770.422957704196, 5842.883142337129, 5845.561582881301, 5254.816081437131, 5355.598330125178, 5404.8108316208745, 5414.539764120015, 5443.42844001382, 6358.554901156875, 6361.809145725636, 6390.265119511223, 6398.999999999907, 6415.615063096229, 6121.602095863755, 6136.23297087864, 6146.200993870768, 6167.167432396569, 6172.351903050115, 6179.474744646755, 6249.25008998923, 6400.807975760735, 6406.5515413920575, 6442.8389290268115, 6095.939040609537, 6108.0, 6112.32764395925, 6112.908306375319, 6129.570930034854, 6104.664243466652, 6174.691265436621, 6176.166217560752, 6178.691065446799, 6193.040078787795, 5972.790952316648, 6009.429104235091, 6099.84750381244, 6111.98679349419, 6142.2629284484365, 6051.576389652682, 6085.604435711664, 6089.725962331617, 6095.51235901118, 6102.786402475892, 5719.199312096393, 5971.014782560829, 5992.280926288873, 5993.220881285405, 6007.759689612367, 5997.850053748692, 6082.665453399928, 6095.512359011357, 6106.023036314168, 6129.448349648553, 5893.5874488787085, 5900.64596124234, 5923.881522369615, 5992.280926288873, 6025.758969641341], "unit": "score", "name": "dojo.html", "value": 5659.486385873109}, {"lowerIsBetter": false, "replicates": [533.0245650459659, 544.9101796407185, 578.7816645960254, 675.844555752177, 678.1895634716515, 38066.42900356493, 38691.0, 38753.41869871947, 38769.0, 38820.80589597048, 40227.0, 40545.391819122735, 40601.59398406015, 40636.78089657307, 40753.796231018874, 9597.952010239975, 9625.22998160149, 9663.323567350271, 9668.564914578861, 9704.0, 7977.601119944009, 7978.242067003625, 7984.161663025386, 8058.717944871931, 8077.313428358597, 8009.559474228915, 8009.879851802228, 8017.799555011113, 8126.0, 8205.712800051999, 7953.761387158394, 7960.761177164694, 8004.159563245834, 8145.470544414624, 8216.424850260484, 9585.233181345475, 9682.70951871445, 9711.397619392792, 9731.221502279801, 9776.853347199798, 38618.227635447416, 38706.0, 38740.0, 38880.61119388827, 39106.0, 2353.7175538935267, 3116.719495245416, 3311.5529403530695, 3371.123507887942, 3449.034270404291, 28414.28964275889, 28641.57037644437, 28744.0, 29044.709552904413, 29117.70882291171, 2220.9333719988263, 2598.285471495335, 2602.232341459255, 2603.765661090511, 2636.8813403396703, 488085.0, 488706.0, 493690.0, 494836.0, 497150.0, 70608.64695676489, 70970.0, 71242.0, 71314.64342678254, 71332.64333678402, 65133.67433162804, 72971.63514182501, 73150.63424682949, 73716.0, 74851.62574187094, 14730.337134828958, 17218.397356092475, 17420.651586968444, 17569.912150439166, 17608.647827043387, 13212.009099317398, 13219.867801322056, 13413.195208287534, 13449.529266475627, 13527.188368697909, 17630.82369176292, 19965.800341996684, 21556.89221553882, 21899.562008760055, 21933.890330548245, 8115.472494287852, 9325.440473571607, 9467.289953253396, 9537.189338906132, 9575.281853860988, 986.3933680786265, 1011.3476807459148, 1059.2705995431982, 1073.0878753059837, 1084.1218612923558, 24285.621719691473, 29517.557236641467, 29600.703992959796, 30058.39883202324, 30642.92749753748, 1050.5850189175233, 1059.2267644619317, 1121.8317252412203, 1197.5688752049255, 1214.7570485902854, 14929.701405972037, 15170.469033583771, 15199.316030778642, 15250.9269724188, 15265.313060912285, 543552.0, 547731.0, 552454.0, 553695.0, 555179.0, 55789.16316255259, 59942.70028649916, 60194.0, 60201.397986019576, 60295.69852150711, 1567.498400511848, 1578.8026496687914, 1589.1100983449305, 1592.6496170842397, 1595.39375037485, 29167.85416072906, 29297.121086367442, 29474.557881631365, 29740.256493587833, 29911.850440748527, 50047.499525004285, 50459.74770126273, 50476.74761626168, 50583.74708126436, 50586.49413505818, 499613.0, 511682.0, 511740.0, 512128.0, 513094.0, 33459.83270083634, 34061.48907766336, 34164.0, 34337.656623433446, 34755.9573212804, 44994.550054499035, 45017.0, 45277.094458111314, 46079.76960115178, 46770.0, 31118.0, 36900.446493302086, 37203.0, 37697.86906392813, 38202.617973819906, 36990.260194796494, 37083.25833483369, 37155.0, 37328.25343493169, 37355.439668404455, 31607.84196079005, 36554.8172259137, 36833.81583092068, 36932.26135477329, 37352.813235933645, 29356.412871742872, 30988.84505577458, 31167.68832311648, 31178.532322015642, 31315.060548183592, 20193.59612807765, 20512.282070127472, 24891.354784630013, 25138.497230055662, 25426.491470170862], "unit": "score", "name": "ext.html", "value": 19800.532179671056}, {"lowerIsBetter": false, "replicates": [310.7591616497216, 366.19254543731057, 370.9573399059109, 377.8054302034452, 380.0896852039364, 20221.191152353906, 20574.588508229845, 21040.473988150305, 21246.36260912173, 21294.57410851782, 20603.381898543066, 21242.150313987422, 21432.785672143273, 21494.032768525416, 21632.89183554084, 5798.420157984199, 6035.185249991239, 6060.909086363708, 6071.4232147946095, 6080.604760690541, 5016.523430274118, 5645.096784514479, 5783.5951483396175, 5840.912386314188, 5924.111383292519, 5787.826365209029, 5838.241028666267, 5851.297844258695, 5860.443257890493, 5879.32387775407, 5670.8015219467325, 5845.941540584604, 5931.347551769302, 5939.703014849283, 5948.851278718023, 5148.897022059537, 5170.25031370453, 5178.792848286064, 5179.300794392747, 5190.7404629768735, 22036.779632203794, 26001.0, 26562.33594160142, 27143.728562714317, 27502.449951000868, 1957.667196576571, 2175.575762726269, 2228.075348730275, 2350.8707021113833, 2446.47400808827, 14993.32530036151, 15669.843301567067, 15726.977746446559, 15743.055416675035, 15882.444114455939, 1412.6185929798999, 1698.651776385838, 1736.6179440523065, 1749.247823435922, 1791.570023194437, 96664.0, 104345.0, 109189.45405273003, 109846.0, 110178.44910775394, 11128.276662016942, 11706.600146969851, 11908.0, 11948.820767688492, 12016.33910134951, 14559.0, 14564.49024284145, 14653.047551909092, 14728.0, 14751.63120921964, 9077.45535267886, 9120.908790912139, 9124.361294709306, 9144.314176436794, 9210.986791452935, 9189.3108016899, 9235.353525253167, 9236.122568355995, 9263.120003599783, 9276.07239276067, 3937.684985201177, 4463.419755431773, 4557.977210113928, 4565.474970378449, 4625.560571745679, 1928.4696708405302, 1940.1269428757116, 1950.629380417716, 1956.3935180094215, 1994.321930543622, 880.9867851982225, 895.4985208283382, 910.2945217456391, 940.2243149401634, 1056.155075939261, 18734.0, 20731.067101980447, 21247.893760531097, 21832.345029649136, 21844.563108737737, 936.194872409727, 974.2985050763439, 978.3933960944117, 1000.2648053680539, 1013.5844303835393, 11389.772204555862, 11713.531458741725, 11754.823677644843, 11761.059115270758, 11761.470733817, 675099.0, 678282.0, 693023.0, 694417.0, 699248.0, 97488.0, 130314.34842825915, 130489.0, 132297.0, 134049.0, 1051.558345494894, 1089.4117176724637, 1105.8949399807007, 1115.8437818705388, 1120.288616728367, 15356.464353564554, 19135.904320478865, 19357.225710971405, 19407.417777466697, 19684.50788730293, 53220.66948326323, 54009.919801604534, 54654.0, 54773.63065923384, 57034.574135646944, 77526.0, 80584.59707701424, 81345.0, 82185.35629287262, 82762.75855862047, 8321.08468068524, 8394.0, 8408.2432581068, 8537.74386768398, 8645.736522720046, 9528.380655257386, 13076.411561479566, 13500.797488037884, 13766.793498097337, 13911.652208694864, 11211.887881121085, 11801.822972655245, 11913.82129268079, 12137.57518486884, 12138.635840924786, 11276.830847537129, 11546.82679759821, 11733.296002239893, 11893.464794084113, 12026.75946481048, 11806.58676946337, 11858.110641701734, 12005.0, 12139.332336721212, 12273.263604183778, 8231.588420579066, 8307.875381869399, 8441.70454034106, 8503.064662887202, 8545.444546104483, 10052.748681283027, 11307.378094204898, 12026.939865300617, 12175.878241217475, 12241.571544995883], "unit": "score", "name": "jquery.html", "value": 9855.662483863482}, {"lowerIsBetter": false, "replicates": [1640.3110693508725, 1652.7768751218587, 1986.255154317131, 2034.5727397246587, 2100.705901173835, 7440.441966852481, 8205.220504052106, 8982.820343593125, 9200.125988031135, 9219.446833190004, 8818.118188181179, 8869.201771840533, 8888.55557222138, 8937.150970657793, 8959.686410975617, 2538.3527200563876, 2554.9361265968405, 2564.7948164146824, 2572.6141078838136, 2580.870956452179, 2549.3371723351875, 2577.896884124642, 2581.2772423721294, 2583.4962182374443, 2594.2347007632698, 2517.6852893388327, 2525.1162093267303, 2543.9364015899564, 2564.7948164146824, 2571.4214301782135, 2351.49442869783, 2550.2859199424192, 2553.502067096917, 2553.859537725424, 2579.2520169151016, 2384.0106355862295, 2395.532871090121, 2569.5374832530138, 2591.8444893306273, 2594.8313359631566, 7670.578118203496, 9030.187283144549, 9031.774205644846, 9056.230220431271, 9074.77313067172, 5572.192032155355, 5643.971780141114, 5653.773849046033, 5705.942940570582, 5793.536517078665, 3580.3555360035184, 3667.8166091695575, 3720.21875406165, 3720.813959302051, 3727.720420968411, 1015.7612960954244, 1039.7296702857311, 1046.0637729232294, 1046.7278507588005, 1047.8271085270922, 12201.633950981484, 12230.205036672587, 12373.948214401697, 12378.56675016379, 12464.875351246554, 4996.325496058058, 5063.13926632466, 5108.233764935215, 5138.0, 5173.094708426011, 10466.424346661006, 10578.0, 10584.841227381596, 10587.470626468647, 10596.682099537025, 5702.087665973508, 5726.312842458931, 5740.827775166752, 5749.626274292157, 5762.394948530427, 4559.612432943237, 4943.209086546207, 5007.24891266313, 5029.84910452687, 5136.845894623168, 4109.8972525686495, 4154.543000269968, 4184.372344148342, 4191.685623578243, 4230.259704551752, 1367.548708926052, 1372.4167228927665, 1381.8618138186303, 1387.6877702516854, 1394.274977011948, 1063.0, 1167.575557819459, 1183.248637115438, 1386.3414877933103, 1473.2928194466715, 8199.631016604148, 8263.132371101068, 8328.208820162075, 8473.915260847436, 8492.235698787015, 529.8489930369826, 531.4818052398957, 535.9758810853521, 539.4955716405174, 540.497337476151, 6316.526260530387, 6347.714352854133, 6395.136656551306, 6401.615903045832, 6402.039694045838, 10562.260641755003, 10904.945475272572, 11005.89941005893, 11052.281601695864, 11084.556617735361, 10485.266031377883, 10694.037536621741, 10816.188785841094, 10835.729106772236, 10862.0, 7204.603746793977, 8462.36532260083, 8496.787580310418, 8562.657493700182, 8607.612657430305, 7880.763577092696, 8049.114597394165, 8062.8790568142695, 8127.3091787198755, 8142.022957245168, 9549.809003819746, 9734.221262299141, 9775.462349570558, 9826.705198844045, 9836.3606365586, 9886.950565247127, 10156.89843101589, 10219.080282774587, 10255.384676919408, 10333.328333658288, 6959.234484206834, 7538.396928245617, 7576.583287919218, 7728.072631284282, 7768.53388796674, 8391.496510209407, 8402.789930251549, 8424.11546787603, 8449.155084491502, 8474.830503390021, 7324.780256592311, 7415.184329723834, 7470.962645186739, 7568.3945284378215, 7576.810579735551, 6281.937180628135, 7353.742619008309, 7427.2201418850245, 7440.776776696708, 7497.212792656693, 7833.060032795873, 7877.291043806085, 7899.486533375312, 7918.366530677416, 7933.722319718782, 7094.184168820651, 7149.285071493017, 7203.891941620985, 7227.349538541556, 7228.385587225145, 7293.598852062975, 7311.744088956861, 7360.411167106726, 7426.777196683892, 7499.550026998398], "unit": "score", "name": "mootools.html", "value": 4978.683270783641}, {"lowerIsBetter": false, "replicates": [289.23930063931857, 301.3836703940443, 333.95305716578525, 339.6773065587691, 339.8368782984166, 6821.181458225007, 6914.239433662293, 6914.9973253878225, 6968.0, 7003.3346832050875, 6787.558808677432, 6800.0, 6811.591304521732, 6816.250212476623, 6852.211995620505, 4785.521447855204, 4898.926516102243, 5021.196608542634, 5050.267711181877, 5082.923756143661, 4032.5765794591584, 4960.925586116211, 4998.925016124761, 5006.249062640615, 5013.273075404064, 5004.524570165847, 5015.122353588125, 5023.095842748304, 5034.42104158021, 5060.797568097271, 5043.672161309503, 5044.419891712445, 5066.518680725325, 5074.340335756328, 5075.822346217901, 4356.89107772305, 4357.150355680644, 4361.738295702236, 4362.149380870732, 4365.192439398721, 6291.937080629181, 6607.174103237096, 6617.636030018347, 6619.86760264792, 6639.468842492589, 5866.501347385435, 5901.645901245896, 5902.9114563281155, 5910.083936989773, 5911.379305172981, 7314.963425182893, 7358.153812311599, 7361.926380736178, 7366.373858222058, 7387.5936823474685, 4399.450068741407, 4481.991551900829, 4724.645651576146, 4742.905141897178, 4745.098431298043, 7676.46264761467, 7747.845043099106, 7754.069511658637, 7759.2240775921955, 7784.688612455495, 4555.202839503074, 4568.109218702321, 4666.066786642685, 4745.193317136095, 4754.595859351924, 4030.314846476106, 4828.275758636232, 4840.903181936412, 4841.564259216688, 4841.636877234221, 5853.268341457318, 5856.882862342729, 5875.118732190205, 5875.50058245054, 5881.911771323434, 6427.775027874002, 6747.325267473213, 7301.014363061025, 7311.670974806147, 7357.117145942414, 1672.7574501697186, 1697.5077227603856, 1698.3716025070803, 1698.8131305556378, 1703.4463799265288, 1038.7195457226508, 1066.8559744434558, 1091.9672409827717, 1094.0536435982817, 1094.316052467208, 6739.191297044386, 6782.660866956632, 6794.72821087151, 6822.727090916308, 6844.076049733322, 6271.404216599416, 7098.793205155136, 7603.239676032353, 7612.885806712904, 7620.923790762133, 6816.284290149562, 6830.180378354629, 6838.384545390939, 6841.760538381232, 6873.037774711544, 3813.694904407641, 3945.92108157841, 3992.461017762565, 4000.899977500586, 4003.3394489908837, 6280.748770049238, 7926.48477848938, 7940.920590794133, 7946.920530794734, 7948.403869709795, 7810.6875724971505, 7821.100573434014, 7821.608919554, 7823.100343460461, 7846.666066768663, 6356.650384228819, 7916.881246781303, 7928.246816552418, 7932.484388514728, 7944.920550794418, 7285.4900156990625, 7556.8866467001935, 7558.508696934681, 7578.886316705143, 7584.924150758642, 7305.5981920994855, 7331.266873312626, 7370.852582948418, 7384.076990376203, 7384.261573842573, 6385.489160867212, 7855.5286682799215, 7900.960495197487, 7917.129115797143, 8005.959970200344, 4981.452040275494, 5036.622253331088, 5051.3433253676785, 5054.2923990642075, 5059.696418214919, 7181.892271616034, 7396.519226250277, 7528.435367347581, 7569.205233450629, 7571.886421703789, 7316.268373162641, 7345.045144131229, 7387.1874093848555, 7388.593627350548, 7395.556266624019, 7339.8532029360185, 7349.228331025165, 7376.815579610338, 7379.963100184465, 7381.667824947783, 6939.618320992394, 7160.212376638461, 7161.355478007004, 7189.964050179716, 7193.172785129568, 7297.598632075287, 7312.890306645299, 7333.816654583678, 7337.0, 7384.96307518459, 7106.822329441805, 7145.285471452813, 7162.534435261691, 7163.391111755559, 7168.0], "unit": "score", "name": "prototype.html", "value": 5312.997934080658}, {"lowerIsBetter": false, "replicates": [689.3485656055024, 717.2218143314504, 751.6166754954975, 756.43267549338, 763.4042468704397, 15280.388784448623, 15378.84621153788, 15468.767968480468, 15489.612759681013, 15531.301091450883, 14438.927805360958, 14451.494197703083, 14465.276736163203, 14474.348654310556, 14480.855191448083, 778.8636988527013, 956.8612551180074, 962.0, 981.40134517944, 984.8325784616633, 769.5113602862167, 968.5544649461257, 970.0445061614304, 984.2372161574765, 985.3201291109148, 1021.3208216535994, 1028.6245520385044, 1031.4224034540644, 1031.736907088695, 1032.328986158999, 996.1482932093029, 1018.5467466977198, 1026.5791025679473, 1028.239103063735, 1032.0969151992008, 740.3558903753768, 754.3248792330888, 764.9349805266559, 765.0971853213206, 767.6814122139306, 15253.542393728207, 15339.693206135926, 15371.846281537153, 15547.766783498257, 15580.143092129929, 13236.338183090807, 13269.933650331686, 13272.402741876542, 13324.800127998087, 13444.86555134446, 10167.135793457564, 10332.948335258276, 10334.7416314592, 10411.375317480975, 10522.78954420915, 3552.8401221945073, 3554.040409089557, 3593.4250519916686, 3651.1054791576234, 3828.062124779447, 79787.0, 82364.0, 83265.0, 83500.58249708773, 83631.74552381659, 9313.301502387349, 9722.9027709722, 9772.267079969031, 9774.657886973922, 10107.54516046765, 22718.864056797094, 22978.080876764743, 23036.769632303796, 23047.193348232733, 23051.423714406938, 6674.5995240284765, 7458.664360103699, 7490.9887165233085, 7615.657295421719, 7652.693892244248, 4138.689598280081, 4189.308764053958, 4191.3293872980175, 4192.287311157111, 4210.179015092089, 3619.2942376236906, 3652.6712595866497, 3677.79772112531, 3681.079730067483, 3688.207035487383, 647.2297965421134, 653.1737352249409, 656.4125108028288, 657.5462930577982, 658.9703463344161, 568.7184843502492, 592.5585438848086, 596.5198015597485, 604.4348534120611, 614.9016157414792, 6875.931240687529, 8435.32517398619, 8522.360822938304, 8540.359473039547, 8628.741137765877, 477.92353223484076, 520.8385400525849, 568.9474472226348, 599.9580029397988, 599.9640021598718, 3873.5932727063814, 3873.767573945572, 3876.1666241758157, 3977.6420122188565, 4089.836406543705, 90199.0, 93435.53282233546, 94433.58349624761, 94586.0, 94621.0, 57095.14357284644, 64726.029109563395, 78095.0, 78281.0, 78548.0, 62303.0, 69164.6541767288, 69555.0, 71570.64214678893, 72939.0, 8605.177430184418, 8721.65113395457, 8739.344549158966, 8775.56122193875, 8871.467711937046, 46572.36996705099, 47383.52616473791, 48918.0, 49416.50583494119, 50982.0, 62294.0, 63626.68186659037, 69568.0, 70285.29714702787, 72802.0, 10894.945525272324, 11072.557097716, 11227.66317010491, 11317.943410282896, 11458.541658333574, 11901.404929753651, 12178.147529672839, 12190.512379505075, 12242.571509997108, 12704.110712250054, 9705.272104592043, 9720.562574684298, 10191.235657325878, 10210.540525676213, 10452.634157804441, 11662.12534059966, 11681.824772628588, 11697.473613687234, 11808.114391420506, 12240.0, 8478.618462169341, 10659.667541557305, 11513.30920144794, 11514.30914145154, 11734.647960561197, 9480.288978326515, 9588.232941364813, 9964.202863771026, 10249.538770755484, 10258.948705256425, 7944.324732397579, 9794.951025244829, 9807.21542276602, 9830.852537212091, 9965.551550180404], "unit": "score", "name": "yui.html", "value": 7012.600634243021}], "name": "dromaeo_css", "value": 7678.054697385161}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [132.0, 114.0, 113.0, 114.0, 115.0, 148.0, 169.0, 167.0, 118.0, 104.0], "unit": "score", "name": "ai-astar", "value": 129.4}, {"lowerIsBetter": true, "replicates": [147.0, 120.0, 145.0, 170.0, 150.0, 144.0, 145.0, 174.0, 181.0, 153.0], "unit": "score", "name": "audio-beat-detection", "value": 152.9}, {"lowerIsBetter": true, "replicates": [197.0, 232.0, 226.0, 204.0, 201.0, 231.0, 211.0, 280.0, 242.0, 196.0], "unit": "score", "name": "audio-dft", "value": 222.0}, {"lowerIsBetter": true, "replicates": [73.0, 71.0, 76.0, 116.0, 59.0, 57.0, 57.0, 62.0, 116.0, 73.0], "unit": "score", "name": "audio-fft", "value": 76.0}, {"lowerIsBetter": true, "replicates": [85.0, 86.0, 130.0, 116.0, 72.0, 87.0, 152.0, 65.0, 64.0, 105.0], "unit": "score", "name": "audio-oscillator", "value": 96.2}, {"lowerIsBetter": true, "replicates": [89.0, 132.0, 82.0, 132.0, 135.0, 125.0, 90.0, 86.0, 88.0, 86.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 104.5}, {"lowerIsBetter": true, "replicates": [130.0, 118.0, 94.0, 123.0, 100.0, 149.0, 121.0, 94.0, 95.0, 94.0], "unit": "score", "name": "imaging-darkroom", "value": 111.8}, {"lowerIsBetter": true, "replicates": [91.0, 96.0, 92.0, 91.0, 93.0, 90.0, 91.0, 90.0, 90.0, 93.0], "unit": "score", "name": "imaging-desaturate", "value": 91.7}, {"lowerIsBetter": true, "replicates": [56.0, 60.0, 58.0, 61.0, 62.0, 61.0, 61.0, 70.0, 58.0, 55.0], "unit": "score", "name": "json-parse-financial", "value": 60.2}, {"lowerIsBetter": true, "replicates": [64.0, 65.0, 71.0, 68.0, 76.0, 69.0, 68.0, 66.0, 66.0, 70.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.3}, {"lowerIsBetter": true, "replicates": [87.0, 84.0, 85.0, 98.0, 72.0, 108.0, 116.0, 110.0, 109.0, 99.0], "unit": "score", "name": "stanford-crypto-aes", "value": 96.8}, {"lowerIsBetter": true, "replicates": [133.0, 118.0, 131.0, 119.0, 136.0, 152.0, 136.0, 142.0, 136.0, 119.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 132.2}, {"lowerIsBetter": true, "replicates": [128.0, 128.0, 139.0, 170.0, 137.0, 126.0, 164.0, 177.0, 150.0, 128.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 144.7}, {"lowerIsBetter": true, "replicates": [67.0, 67.0, 66.0, 67.0, 68.0, 66.0, 69.0, 65.0, 66.0, 64.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.5}], "name": "kraken", "value": 1553.2}]} 00:38:42 INFO - Return code: 0 00:38:42 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 00:38:42 ERROR - # TBPL SUCCESS # 00:38:42 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 00:38:42 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 00:38:42 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 00:38:42 INFO - 2016-04-20 00:38:42.636 screenresolution[1958:18952] starting screenresolution argv=screenresolution get 00:38:42 INFO - 2016-04-20 00:38:42.639 screenresolution[1958:18952] Display 0: 1600x1200x32@60 00:38:42 INFO - 2016-04-20 00:38:42.645 screenresolution[1959:18955] starting screenresolution argv=screenresolution list 00:38:42 INFO - Available Modes on Display 0 00:38:42 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 00:38:42 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 00:38:42 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 00:38:42 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 00:38:42 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 00:38:42 INFO - Intel Iris: 00:38:42 INFO - Chipset Model: Intel Iris 00:38:42 INFO - Type: GPU 00:38:42 INFO - Bus: Built-In 00:38:42 INFO - VRAM (Dynamic, Max): 1536 MB 00:38:42 INFO - Vendor: Intel (0x8086) 00:38:42 INFO - Device ID: 0x0a2e 00:38:42 INFO - Revision ID: 0x0009 00:38:42 INFO - Displays: 00:38:42 INFO - Display: 00:38:42 INFO - Resolution: 1600 x 1200 @ 60 Hz 00:38:42 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 00:38:42 INFO - Display Serial Number: 1600x1200 60 00:38:42 INFO - Main Display: Yes 00:38:42 INFO - Mirror: Off 00:38:42 INFO - Online: Yes 00:38:42 INFO - Rotation: Supported 00:38:42 INFO - Return code: 0 00:38:42 INFO - Running post-action listener: _resource_record_post_action 00:38:42 INFO - Running post-run listener: _resource_record_post_run 00:38:43 INFO - Total resource usage - Wall time: 1202s; CPU: 53.0%; Read bytes: 1683456; Write bytes: 667858432; Read time: 16; Write time: 1915 00:38:43 INFO - install - Wall time: 33s; CPU: 55.0%; Read bytes: 354130432; Write bytes: 353375744; Read time: 28069; Write time: 611 00:38:43 INFO - run-tests - Wall time: 1170s; CPU: 53.0%; Read bytes: 1683456; Write bytes: 302582272; Read time: 16; Write time: 1231 00:38:43 INFO - Running post-run listener: _upload_blobber_files 00:38:43 INFO - Blob upload gear active. 00:38:43 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 00:38:43 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 00:38:43 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'] 00:38:43 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 00:38:44 INFO - (blobuploader) - INFO - Open directory for files ... 00:38:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 00:38:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:38:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:38:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 00:38:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:38:46 INFO - (blobuploader) - INFO - Done attempting. 00:38:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 00:38:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:38:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:38:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 00:38:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:38:48 INFO - (blobuploader) - INFO - Done attempting. 00:38:48 INFO - (blobuploader) - INFO - Iteration through files over. 00:38:48 INFO - Return code: 0 00:38:48 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 00:38:48 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 00:38:48 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d1018fbb9f8f21a559ff8c9d638a2a11396f50c7deeb65153a3a38e2b5dfb28169c580232d5e71e0d9986a636f2857ffa408827e5f5d7315c8beea79eb7c79a6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0e77dae76f3bdf1b3ebc22a63f380682e25cfa04c537de683104aa7a1c4760364eff2104c7f7221502a1dbaba4b4c3662b0fff1c2964e83f44dfa35948e019b6"} 00:38:48 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 00:38:48 INFO - Writing to file /builds/slave/test/properties/blobber_files 00:38:48 INFO - Contents: 00:38:48 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d1018fbb9f8f21a559ff8c9d638a2a11396f50c7deeb65153a3a38e2b5dfb28169c580232d5e71e0d9986a636f2857ffa408827e5f5d7315c8beea79eb7c79a6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0e77dae76f3bdf1b3ebc22a63f380682e25cfa04c537de683104aa7a1c4760364eff2104c7f7221502a1dbaba4b4c3662b0fff1c2964e83f44dfa35948e019b6"} 00:38:48 INFO - Running post-run listener: copy_logs_to_upload_dir 00:38:48 INFO - Copying logs to upload dir... 00:38:48 INFO - mkdir: /builds/slave/test/build/upload/logs 00:38:48 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1273.496698 ========= master_lag: 0.21 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2016-04-20 00:38:48.349706) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 3 secs) (at 2016-04-20 00:38:48.350915) ========= 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.J3hKxV99GU/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.q5WcXm0Zwg/Listeners TMPDIR=/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/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/d1018fbb9f8f21a559ff8c9d638a2a11396f50c7deeb65153a3a38e2b5dfb28169c580232d5e71e0d9986a636f2857ffa408827e5f5d7315c8beea79eb7c79a6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0e77dae76f3bdf1b3ebc22a63f380682e25cfa04c537de683104aa7a1c4760364eff2104c7f7221502a1dbaba4b4c3662b0fff1c2964e83f44dfa35948e019b6"} build_url:https://queue.taskcluster.net/v1/task/F2UAd3ecR-KTlDpvL5mYEg/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011200 build_url: 'https://queue.taskcluster.net/v1/task/F2UAd3ecR-KTlDpvL5mYEg/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/d1018fbb9f8f21a559ff8c9d638a2a11396f50c7deeb65153a3a38e2b5dfb28169c580232d5e71e0d9986a636f2857ffa408827e5f5d7315c8beea79eb7c79a6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0e77dae76f3bdf1b3ebc22a63f380682e25cfa04c537de683104aa7a1c4760364eff2104c7f7221502a1dbaba4b4c3662b0fff1c2964e83f44dfa35948e019b6"}' ========= master_lag: 3.90 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 3 secs) (at 2016-04-20 00:38:52.263491) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 12 secs) (at 2016-04-20 00:38:52.263848) ========= 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.J3hKxV99GU/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.q5WcXm0Zwg/Listeners TMPDIR=/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/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.005247 ========= master_lag: 12.68 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 12 secs) (at 2016-04-20 00:39:04.952828) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-20 00:39:04.953224) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-20 00:39:05.199014) ========= ========= Total master_lag: 16.97 =========