builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0177 starttime: 1461977697.28 results: success (0) buildid: 20160429165741 builduid: dbc67d91af24440286648716d476ba03 revision: 8008dbbe1841442ea9d0f376bb9e47058d1a8f7c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-29 17:54:57.277385) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-29 17:54:57.277812) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-29 17:54:57.278091) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-29 17:54:57.296115) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 17:54:57.296395) ========= 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.SiXXJTN09E/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.didN9QTR83/Listeners TMPDIR=/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/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-29 17:54:57-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 7.99M=0.001s 2016-04-29 17:54:57 (7.99 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.132724 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 17:54:57.447324) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 17:54:57.447932) ========= 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.SiXXJTN09E/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.didN9QTR83/Listeners TMPDIR=/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/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.020168 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 17:54:57.497489) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-29 17:54:57.498213) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 8008dbbe1841442ea9d0f376bb9e47058d1a8f7c --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-beta --rev 8008dbbe1841442ea9d0f376bb9e47058d1a8f7c --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.SiXXJTN09E/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.didN9QTR83/Listeners TMPDIR=/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/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-29 17:54:57,574 truncating revision to first 12 chars 2016-04-29 17:54:57,574 Setting DEBUG logging. 2016-04-29 17:54:57,574 attempt 1/10 2016-04-29 17:54:57,575 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/8008dbbe1841?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-29 17:54:59,152 unpacking tar archive at: mozilla-beta-8008dbbe1841/testing/mozharness/ program finished with exit code 0 elapsedTime=1.838889 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-29 17:54:59.355071) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-29 17:54:59.355425) ========= script_repo_revision: 8008dbbe1841442ea9d0f376bb9e47058d1a8f7c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-29 17:54:59.355841) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-29 17:54:59.356110) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-29 17:54:59.370421) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-04-29 17:54:59.370740) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.SiXXJTN09E/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.didN9QTR83/Listeners TMPDIR=/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/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 17:54:59 INFO - MultiFileLogger online at 20160429 17:54:59 in /builds/slave/test 17:54:59 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 17:54:59 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:54:59 INFO - {'append_to_log': False, 17:54:59 INFO - 'base_work_dir': '/builds/slave/test', 17:54:59 INFO - 'blob_upload_branch': 'Mozilla-Beta', 17:54:59 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:54:59 INFO - 'branch': 'Mozilla-Beta', 17:54:59 INFO - 'buildbot_json_path': 'buildprops.json', 17:54:59 INFO - 'config_files': ('talos/mac_config.py',), 17:54:59 INFO - 'default_actions': ('clobber', 17:54:59 INFO - 'read-buildbot-config', 17:54:59 INFO - 'download-and-extract', 17:54:59 INFO - 'populate-webroot', 17:54:59 INFO - 'create-virtualenv', 17:54:59 INFO - 'install', 17:54:59 INFO - 'run-tests'), 17:54:59 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:54:59 INFO - 'download_minidump_stackwalk': True, 17:54:59 INFO - 'download_symbols': 'ondemand', 17:54:59 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:54:59 INFO - 'tooltool.py': '/tools/tooltool.py', 17:54:59 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:54:59 INFO - '/tools/misc-python/virtualenv.py')}, 17:54:59 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:54:59 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:54:59 INFO - 'installer_path': 'installer.exe', 17:54:59 INFO - 'log_level': 'info', 17:54:59 INFO - 'log_name': 'talos', 17:54:59 INFO - 'log_to_console': True, 17:54:59 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 17:54:59 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 17:54:59 INFO - 'opt_config_files': (), 17:54:59 INFO - 'pip_index': False, 17:54:59 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 17:54:59 INFO - 'cmd': ('bash', 17:54:59 INFO - '-c', 17:54:59 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 17:54:59 INFO - 'enabled': True, 17:54:59 INFO - 'halt_on_failure': False, 17:54:59 INFO - 'name': 'check_screen_resolution'},), 17:54:59 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 17:54:59 INFO - 'cmd': ('bash', 17:54:59 INFO - '-c', 17:54:59 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 17:54:59 INFO - 'enabled': True, 17:54:59 INFO - 'halt_on_failure': False, 17:54:59 INFO - 'name': 'check_screen_resolution'},), 17:54:59 INFO - 'run_cmd_checks_enabled': True, 17:54:59 INFO - 'sps_profile': False, 17:54:59 INFO - 'sps_profile_interval': 0, 17:54:59 INFO - 'suite': 'dromaeojs', 17:54:59 INFO - 'system_bits': '32', 17:54:59 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:54:59 INFO - 'title': 't-yosemite-r7-0177', 17:54:59 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:54:59 INFO - 'use_talos_json': True, 17:54:59 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:54:59 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:54:59 INFO - 'work_dir': 'build'} 17:54:59 INFO - ##### 17:54:59 INFO - ##### Running clobber step. 17:54:59 INFO - ##### 17:54:59 INFO - Running pre-action listener: _resource_record_pre_action 17:54:59 INFO - Running main action method: clobber 17:54:59 INFO - rmtree: /builds/slave/test/build 17:54:59 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:55:00 INFO - Running post-action listener: _resource_record_post_action 17:55:00 INFO - ##### 17:55:00 INFO - ##### Running read-buildbot-config step. 17:55:00 INFO - ##### 17:55:00 INFO - Running pre-action listener: _resource_record_pre_action 17:55:00 INFO - Running main action method: read_buildbot_config 17:55:00 INFO - Using buildbot properties: 17:55:00 INFO - { 17:55:00 INFO - "project": "", 17:55:00 INFO - "product": "firefox", 17:55:00 INFO - "script_repo_revision": "production", 17:55:00 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 17:55:00 INFO - "repository": "", 17:55:00 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 17:55:00 INFO - "buildid": "20160429165741", 17:55:00 INFO - "pgo_build": "False", 17:55:00 INFO - "basedir": "/builds/slave/test", 17:55:00 INFO - "buildnumber": 55, 17:55:00 INFO - "slavename": "t-yosemite-r7-0177", 17:55:00 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 17:55:00 INFO - "platform": "yosemite_r7", 17:55:00 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 17:55:00 INFO - "branch": "mozilla-beta", 17:55:00 INFO - "repo_path": "releases/mozilla-beta", 17:55:00 INFO - "revision": "8008dbbe1841442ea9d0f376bb9e47058d1a8f7c", 17:55:00 INFO - "stage_platform": "macosx64", 17:55:00 INFO - "builduid": "dbc67d91af24440286648716d476ba03", 17:55:00 INFO - "slavebuilddir": "test" 17:55:00 INFO - } 17:55:00 INFO - Found installer url https://queue.taskcluster.net/v1/task/EvtvSMdoRB-BeTMT9KgmUg/artifacts/public/build/firefox-47.0.en-US.mac.dmg. 17:55:00 INFO - Running post-action listener: _resource_record_post_action 17:55:00 INFO - ##### 17:55:00 INFO - ##### Running download-and-extract step. 17:55:00 INFO - ##### 17:55:00 INFO - Running pre-action listener: _resource_record_pre_action 17:55:00 INFO - Running main action method: download_and_extract 17:55:00 INFO - mkdir: /builds/slave/test/build/tests 17:55:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:55:00 INFO - https://queue.taskcluster.net/v1/task/EvtvSMdoRB-BeTMT9KgmUg/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json matches https://queue.taskcluster.net 17:55:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EvtvSMdoRB-BeTMT9KgmUg/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json 17:55:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EvtvSMdoRB-BeTMT9KgmUg/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json 17:55:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EvtvSMdoRB-BeTMT9KgmUg/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-47.0.en-US.mac.test_packages.json 17:55:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EvtvSMdoRB-BeTMT9KgmUg/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-47.0.en-US.mac.test_packages.json'}, attempt #1 17:55:01 INFO - Downloaded 1241 bytes. 17:55:01 INFO - Reading from file /builds/slave/test/build/firefox-47.0.en-US.mac.test_packages.json 17:55:01 INFO - Using the following test package requirements: 17:55:01 INFO - {u'common': [u'firefox-47.0.en-US.mac.common.tests.zip'], 17:55:01 INFO - u'cppunittest': [u'firefox-47.0.en-US.mac.common.tests.zip', 17:55:01 INFO - u'firefox-47.0.en-US.mac.cppunittest.tests.zip'], 17:55:01 INFO - u'gtest': [u'firefox-47.0.en-US.mac.common.tests.zip', 17:55:01 INFO - u'firefox-47.0.en-US.mac.gtest.tests.zip'], 17:55:01 INFO - u'jittest': [u'firefox-47.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 17:55:01 INFO - u'mochitest': [u'firefox-47.0.en-US.mac.common.tests.zip', 17:55:01 INFO - u'firefox-47.0.en-US.mac.mochitest.tests.zip'], 17:55:01 INFO - u'mozbase': [u'firefox-47.0.en-US.mac.common.tests.zip'], 17:55:01 INFO - u'reftest': [u'firefox-47.0.en-US.mac.common.tests.zip', 17:55:01 INFO - u'firefox-47.0.en-US.mac.reftest.tests.zip'], 17:55:01 INFO - u'talos': [u'firefox-47.0.en-US.mac.common.tests.zip', 17:55:01 INFO - u'firefox-47.0.en-US.mac.talos.tests.zip'], 17:55:01 INFO - u'web-platform': [u'firefox-47.0.en-US.mac.common.tests.zip', 17:55:01 INFO - u'firefox-47.0.en-US.mac.web-platform.tests.zip'], 17:55:01 INFO - u'webapprt': [u'firefox-47.0.en-US.mac.common.tests.zip'], 17:55:01 INFO - u'xpcshell': [u'firefox-47.0.en-US.mac.common.tests.zip', 17:55:01 INFO - u'firefox-47.0.en-US.mac.xpcshell.tests.zip']} 17:55:01 INFO - Downloading packages: [u'firefox-47.0.en-US.mac.common.tests.zip'] for test suite category: common 17:55:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:55:01 INFO - https://queue.taskcluster.net/v1/task/EvtvSMdoRB-BeTMT9KgmUg/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 17:55:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EvtvSMdoRB-BeTMT9KgmUg/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip 17:55:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EvtvSMdoRB-BeTMT9KgmUg/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip 17:55:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EvtvSMdoRB-BeTMT9KgmUg/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip 17:55:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EvtvSMdoRB-BeTMT9KgmUg/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip'}, attempt #1 17:55:02 INFO - Downloaded 17745612 bytes. 17:55:02 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:55:02 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 17:55:05 INFO - Return code: 0 17:55:05 INFO - Downloading packages: [u'firefox-47.0.en-US.mac.common.tests.zip', u'firefox-47.0.en-US.mac.talos.tests.zip'] for test suite category: talos 17:55:05 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')]} 17:55:05 INFO - https://queue.taskcluster.net/v1/task/EvtvSMdoRB-BeTMT9KgmUg/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 17:55:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EvtvSMdoRB-BeTMT9KgmUg/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip 17:55:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EvtvSMdoRB-BeTMT9KgmUg/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip 17:55:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EvtvSMdoRB-BeTMT9KgmUg/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip 17:55:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EvtvSMdoRB-BeTMT9KgmUg/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip'}, attempt #1 17:55:06 INFO - Downloaded 17745612 bytes. 17:55:06 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:55:06 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 17:55:10 INFO - Return code: 0 17:55:10 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')]} 17:55:10 INFO - https://queue.taskcluster.net/v1/task/EvtvSMdoRB-BeTMT9KgmUg/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 17:55:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EvtvSMdoRB-BeTMT9KgmUg/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip 17:55:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EvtvSMdoRB-BeTMT9KgmUg/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip 17:55:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EvtvSMdoRB-BeTMT9KgmUg/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-47.0.en-US.mac.talos.tests.zip 17:55:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EvtvSMdoRB-BeTMT9KgmUg/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.en-US.mac.talos.tests.zip'}, attempt #1 17:55:11 INFO - Downloaded 10845194 bytes. 17:55:11 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:55:11 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 17:55:11 INFO - Return code: 0 17:55:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:55:11 INFO - https://queue.taskcluster.net/v1/task/EvtvSMdoRB-BeTMT9KgmUg/artifacts/public/build/firefox-47.0.en-US.mac.dmg matches https://queue.taskcluster.net 17:55:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EvtvSMdoRB-BeTMT9KgmUg/artifacts/public/build/firefox-47.0.en-US.mac.dmg 17:55:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EvtvSMdoRB-BeTMT9KgmUg/artifacts/public/build/firefox-47.0.en-US.mac.dmg 17:55:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EvtvSMdoRB-BeTMT9KgmUg/artifacts/public/build/firefox-47.0.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0.en-US.mac.dmg 17:55:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EvtvSMdoRB-BeTMT9KgmUg/artifacts/public/build/firefox-47.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-47.0.en-US.mac.dmg'}, attempt #1 17:55:14 INFO - Downloaded 88278544 bytes. 17:55:14 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/EvtvSMdoRB-BeTMT9KgmUg/artifacts/public/build/firefox-47.0.en-US.mac.dmg 17:55:14 INFO - mkdir: /builds/slave/test/properties 17:55:14 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:55:14 INFO - Writing to file /builds/slave/test/properties/build_url 17:55:14 INFO - Contents: 17:55:14 INFO - build_url:https://queue.taskcluster.net/v1/task/EvtvSMdoRB-BeTMT9KgmUg/artifacts/public/build/firefox-47.0.en-US.mac.dmg 17:55:15 INFO - Running post-action listener: _resource_record_post_action 17:55:15 INFO - Running post-action listener: set_extra_try_arguments 17:55:15 INFO - ##### 17:55:15 INFO - ##### Running populate-webroot step. 17:55:15 INFO - ##### 17:55:15 INFO - Running pre-action listener: _resource_record_pre_action 17:55:15 INFO - Running main action method: populate_webroot 17:55:15 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:55:15 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:55:15 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:55:15 INFO - '--tppagecycles', 17:55:15 INFO - '7'], 17:55:15 INFO - 'tests': ['tsvgm']}}, 17:55:15 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 17:55:15 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 17:55:15 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:55:15 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 17:55:15 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 17:55:15 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:55:15 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:55:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:55:15 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:55:15 INFO - 'talos_options': ['--e10s'], 17:55:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:55:15 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:55:15 INFO - 'tests': ['damp', 'tps']}, 17:55:15 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:55:15 INFO - 'talos_options': ['--e10s'], 17:55:15 INFO - 'tests': ['damp', 'tps']}, 17:55:15 INFO - 'g3': {'tests': ['dromaeo_dom']}, 17:55:15 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:55:15 INFO - 'other': {'tests': ['a11yr', 17:55:15 INFO - 'ts_paint', 17:55:15 INFO - 'tpaint', 17:55:15 INFO - 'sessionrestore', 17:55:15 INFO - 'sessionrestore_no_auto_restore', 17:55:15 INFO - 'tabpaint']}, 17:55:15 INFO - 'other-e10s': {'talos_options': ['--e10s'], 17:55:15 INFO - 'tests': ['a11yr', 17:55:15 INFO - 'ts_paint', 17:55:15 INFO - 'tpaint', 17:55:15 INFO - 'sessionrestore', 17:55:15 INFO - 'sessionrestore_no_auto_restore', 17:55:15 INFO - 'tabpaint']}, 17:55:15 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 17:55:15 INFO - 'tests': ['a11yr', 17:55:15 INFO - 'ts_paint', 17:55:15 INFO - 'tpaint', 17:55:15 INFO - 'sessionrestore', 17:55:15 INFO - 'sessionrestore_no_auto_restore', 17:55:15 INFO - 'tabpaint']}, 17:55:15 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 17:55:15 INFO - 'tests': ['a11yr', 17:55:15 INFO - 'ts_paint', 17:55:15 INFO - 'tpaint', 17:55:15 INFO - 'sessionrestore', 17:55:15 INFO - 'sessionrestore_no_auto_restore', 17:55:15 INFO - 'tabpaint']}, 17:55:15 INFO - 'other_l64': {'tests': ['a11yr', 17:55:15 INFO - 'ts_paint', 17:55:15 INFO - 'tpaint', 17:55:15 INFO - 'sessionrestore', 17:55:15 INFO - 'sessionrestore_no_auto_restore', 17:55:15 INFO - 'tabpaint']}, 17:55:15 INFO - 'other_nol64': {'tests': ['a11yr', 17:55:15 INFO - 'ts_paint', 17:55:15 INFO - 'tpaint', 17:55:15 INFO - 'sessionrestore', 17:55:15 INFO - 'sessionrestore_no_auto_restore', 17:55:15 INFO - 'tabpaint']}, 17:55:15 INFO - 'svgr': {'tests': ['tsvgx', 17:55:15 INFO - 'tsvgr_opacity', 17:55:15 INFO - 'tart', 17:55:15 INFO - 'tscrollx', 17:55:15 INFO - 'cart']}, 17:55:15 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 17:55:15 INFO - 'tests': ['tsvgx', 17:55:15 INFO - 'tsvgr_opacity', 17:55:15 INFO - 'tart', 17:55:15 INFO - 'tscrollx', 17:55:15 INFO - 'cart']}, 17:55:15 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:55:15 INFO - 'tests': ['tp5o']}, 17:55:15 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:55:15 INFO - 'talos_options': ['--e10s'], 17:55:15 INFO - 'tests': ['tp5o']}, 17:55:15 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:55:15 INFO - 'talos_options': ['--xperf_path', 17:55:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:55:15 INFO - 'tests': ['tp5n']}, 17:55:15 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:55:15 INFO - 'talos_options': ['--e10s', 17:55:15 INFO - '--xperf_path', 17:55:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:55:15 INFO - 'tests': ['tp5n']}}, 17:55:15 INFO - 'talos.zip': {'path': '', 17:55:15 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:55:15 INFO - Running post-action listener: _resource_record_post_action 17:55:15 INFO - ##### 17:55:15 INFO - ##### Running create-virtualenv step. 17:55:15 INFO - ##### 17:55:15 INFO - Running pre-action listener: _resource_record_pre_action 17:55:15 INFO - Running main action method: create_virtualenv 17:55:15 INFO - Creating virtualenv /builds/slave/test/build/venv 17:55:15 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 17:55:15 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:55:16 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:55:16 INFO - Using real prefix '/tools/python27' 17:55:16 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:55:16 INFO - Installing distribute.............................................................................................................................................................................................done. 17:55:19 INFO - Installing pip.................done. 17:55:19 INFO - Return code: 0 17:55:19 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:55:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:55:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:55:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:55:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:55:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:55:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:55:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x106b1ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106b224c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f98b9c7f9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1069bfd30>, '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 0x106823db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1069b6b20>, '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.SiXXJTN09E/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.didN9QTR83/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/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 17:55:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 17:55:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 17:55:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SiXXJTN09E/Render', 17:55:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:55:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:55:19 INFO - 'HOME': '/Users/cltbld', 17:55:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:55:19 INFO - 'LOGNAME': 'cltbld', 17:55:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:55:19 INFO - 'MOZ_NO_REMOTE': '1', 17:55:19 INFO - 'NO_EM_RESTART': '1', 17:55:19 INFO - 'PAGER': '/bin/cat', 17:55:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:55:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:55:19 INFO - 'PWD': '/builds/slave/test', 17:55:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:55:19 INFO - 'SHELL': '/bin/bash', 17:55:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.didN9QTR83/Listeners', 17:55:19 INFO - 'TMPDIR': '/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/', 17:55:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:55:19 INFO - 'USER': 'cltbld', 17:55:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:55:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:55:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:55:19 INFO - 'XPC_FLAGS': '0x0', 17:55:19 INFO - 'XPC_SERVICE_NAME': '0', 17:55:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:55:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:55:19 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 17:55:19 INFO - Cleaning up... 17:55:19 INFO - Return code: 0 17:55:19 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 17:55:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:55:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:55:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:55:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:55:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:55:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:55:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x106b1ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106b224c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f98b9c7f9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1069bfd30>, '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 0x106823db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1069b6b20>, '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.SiXXJTN09E/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.didN9QTR83/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/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 17:55:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 17:55:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 17:55:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SiXXJTN09E/Render', 17:55:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:55:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:55:19 INFO - 'HOME': '/Users/cltbld', 17:55:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:55:19 INFO - 'LOGNAME': 'cltbld', 17:55:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:55:19 INFO - 'MOZ_NO_REMOTE': '1', 17:55:19 INFO - 'NO_EM_RESTART': '1', 17:55:19 INFO - 'PAGER': '/bin/cat', 17:55:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:55:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:55:19 INFO - 'PWD': '/builds/slave/test', 17:55:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:55:19 INFO - 'SHELL': '/bin/bash', 17:55:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.didN9QTR83/Listeners', 17:55:19 INFO - 'TMPDIR': '/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/', 17:55:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:55:19 INFO - 'USER': 'cltbld', 17:55:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:55:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:55:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:55:19 INFO - 'XPC_FLAGS': '0x0', 17:55:19 INFO - 'XPC_SERVICE_NAME': '0', 17:55:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:55:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:55:20 INFO - Downloading/unpacking psutil>=0.7.1 17:55:20 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 17:55:20 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 17:55:20 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 17:55:20 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 17:55:20 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 17:55:20 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 17:55:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:55:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:55:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:55:23 INFO - Installing collected packages: psutil 17:55:23 INFO - Running setup.py install for psutil 17:55:23 INFO - building 'psutil._psutil_osx' extension 17:55:23 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 17:55:23 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 17:55:23 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 17:55:23 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 17:55:23 INFO - building 'psutil._psutil_posix' extension 17:55:23 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 17:55:23 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 17:55:23 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 17:55:23 INFO - ^ 17:55:23 INFO - 1 warning generated. 17:55:23 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 17:55:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:55:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:55:24 INFO - Successfully installed psutil 17:55:24 INFO - Cleaning up... 17:55:24 INFO - Return code: 0 17:55:24 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 17:55:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:55:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:55:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:55:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:55:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:55:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:55:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x106b1ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106b224c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f98b9c7f9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1069bfd30>, '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 0x106823db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1069b6b20>, '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.SiXXJTN09E/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.didN9QTR83/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/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 17:55:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 17:55:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 17:55:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SiXXJTN09E/Render', 17:55:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:55:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:55:24 INFO - 'HOME': '/Users/cltbld', 17:55:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:55:24 INFO - 'LOGNAME': 'cltbld', 17:55:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:55:24 INFO - 'MOZ_NO_REMOTE': '1', 17:55:24 INFO - 'NO_EM_RESTART': '1', 17:55:24 INFO - 'PAGER': '/bin/cat', 17:55:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:55:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:55:24 INFO - 'PWD': '/builds/slave/test', 17:55:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:55:24 INFO - 'SHELL': '/bin/bash', 17:55:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.didN9QTR83/Listeners', 17:55:24 INFO - 'TMPDIR': '/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/', 17:55:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:55:24 INFO - 'USER': 'cltbld', 17:55:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:55:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:55:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:55:24 INFO - 'XPC_FLAGS': '0x0', 17:55:24 INFO - 'XPC_SERVICE_NAME': '0', 17:55:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:55:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:55:24 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 17:55:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:55:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:55:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:55:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:55:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:55:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:55:26 INFO - Downloading mozsystemmonitor-0.0.tar.gz 17:55:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:55:26 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 17:55:26 INFO - Installing collected packages: mozsystemmonitor 17:55:26 INFO - Running setup.py install for mozsystemmonitor 17:55:26 INFO - Successfully installed mozsystemmonitor 17:55:26 INFO - Cleaning up... 17:55:27 INFO - Return code: 0 17:55:27 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:55:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:55:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:55:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:55:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:55:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:55:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:55:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x106b1ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106b224c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f98b9c7f9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1069bfd30>, '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 0x106823db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1069b6b20>, '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.SiXXJTN09E/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.didN9QTR83/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/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 17:55:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 17:55:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 17:55:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SiXXJTN09E/Render', 17:55:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:55:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:55:27 INFO - 'HOME': '/Users/cltbld', 17:55:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:55:27 INFO - 'LOGNAME': 'cltbld', 17:55:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:55:27 INFO - 'MOZ_NO_REMOTE': '1', 17:55:27 INFO - 'NO_EM_RESTART': '1', 17:55:27 INFO - 'PAGER': '/bin/cat', 17:55:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:55:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:55:27 INFO - 'PWD': '/builds/slave/test', 17:55:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:55:27 INFO - 'SHELL': '/bin/bash', 17:55:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.didN9QTR83/Listeners', 17:55:27 INFO - 'TMPDIR': '/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/', 17:55:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:55:27 INFO - 'USER': 'cltbld', 17:55:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:55:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:55:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:55:27 INFO - 'XPC_FLAGS': '0x0', 17:55:27 INFO - 'XPC_SERVICE_NAME': '0', 17:55:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:55:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:55:27 INFO - Downloading/unpacking blobuploader==1.2.4 17:55: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 17:55: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 17:55: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 17:55: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 17:55: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 17:55: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 17:55:29 INFO - Downloading blobuploader-1.2.4.tar.gz 17:55:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:55:29 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:55:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:55:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:55:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:55:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:55:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:55:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:55:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:55:30 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:55:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:55:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:55:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:55:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:55:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:55:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:55:30 INFO - Downloading docopt-0.6.1.tar.gz 17:55:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:55:30 INFO - Installing collected packages: blobuploader, requests, docopt 17:55:30 INFO - Running setup.py install for blobuploader 17:55:30 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:55:31 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:55:31 INFO - Running setup.py install for requests 17:55:31 INFO - Running setup.py install for docopt 17:55:31 INFO - Successfully installed blobuploader requests docopt 17:55:31 INFO - Cleaning up... 17:55:31 INFO - Return code: 0 17:55:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:55: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')]} 17:55:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:55:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:55: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')]} 17:55:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:55:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:55:31 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 0x106b1ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106b224c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f98b9c7f9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1069bfd30>, '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 0x106823db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1069b6b20>, '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.SiXXJTN09E/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.didN9QTR83/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/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 17:55:31 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 17:55:31 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 17:55:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SiXXJTN09E/Render', 17:55:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:55:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:55:31 INFO - 'HOME': '/Users/cltbld', 17:55:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:55:31 INFO - 'LOGNAME': 'cltbld', 17:55:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:55:31 INFO - 'MOZ_NO_REMOTE': '1', 17:55:31 INFO - 'NO_EM_RESTART': '1', 17:55:31 INFO - 'PAGER': '/bin/cat', 17:55:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:55:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:55:31 INFO - 'PWD': '/builds/slave/test', 17:55:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:55:31 INFO - 'SHELL': '/bin/bash', 17:55:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.didN9QTR83/Listeners', 17:55:31 INFO - 'TMPDIR': '/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/', 17:55:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:55:31 INFO - 'USER': 'cltbld', 17:55:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:55:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:55:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:55:31 INFO - 'XPC_FLAGS': '0x0', 17:55:31 INFO - 'XPC_SERVICE_NAME': '0', 17:55:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:55:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:55:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:55:32 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-MKzFfc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:55:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:55:32 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-Z5skEA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:55:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:55:32 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-ooj4rk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:55:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:55:32 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-DzwJd4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:55:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:55:32 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-RGdiO3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:55:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:55:32 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-TUo9xp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:55:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:55:32 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-7ATMix-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:55:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:55:32 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-H1KJ0O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:55:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:55:32 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-0uMnZL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:55:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:55:32 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-vBNyGI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:55:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:55:33 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-DK6rXZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:55:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:55:33 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-2Biayg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:55:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:55:33 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-0Izz2h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:55:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:55:33 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-qk3mKC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:55:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:55:33 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-yY9wlG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:55:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:55:33 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-t_xtEA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:55:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:55:33 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-7mYiJD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:55:33 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:55:33 INFO - Running setup.py install for manifestparser 17:55:33 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:55:33 INFO - Running setup.py install for mozcrash 17:55:34 INFO - Running setup.py install for mozdebug 17:55:34 INFO - Running setup.py install for mozdevice 17:55:34 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:55:34 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:55:34 INFO - Running setup.py install for mozfile 17:55:34 INFO - Running setup.py install for mozhttpd 17:55:34 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:55:34 INFO - Running setup.py install for mozinfo 17:55:34 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:55:34 INFO - Running setup.py install for mozInstall 17:55:34 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:55:34 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:55:34 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:55:34 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:55:34 INFO - Running setup.py install for mozleak 17:55:35 INFO - Running setup.py install for mozlog 17:55:35 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:55:35 INFO - Running setup.py install for moznetwork 17:55:35 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:55:35 INFO - Running setup.py install for mozprocess 17:55:35 INFO - Running setup.py install for mozprofile 17:55:35 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:55:35 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:55:35 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:55:35 INFO - Running setup.py install for mozrunner 17:55:35 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:55:35 INFO - Running setup.py install for mozscreenshot 17:55:36 INFO - Running setup.py install for moztest 17:55:36 INFO - Running setup.py install for mozversion 17:55:36 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:55:36 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:55:36 INFO - Cleaning up... 17:55:36 INFO - Return code: 0 17:55:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:55: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')]} 17:55:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:55:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:55: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')]} 17:55:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:55:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:55:36 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 0x106b1ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106b224c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f98b9c7f9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1069bfd30>, '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 0x106823db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1069b6b20>, '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.SiXXJTN09E/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.didN9QTR83/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/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 17:55:36 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 17:55:36 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 17:55:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SiXXJTN09E/Render', 17:55:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:55:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:55:36 INFO - 'HOME': '/Users/cltbld', 17:55:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:55:36 INFO - 'LOGNAME': 'cltbld', 17:55:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:55:36 INFO - 'MOZ_NO_REMOTE': '1', 17:55:36 INFO - 'NO_EM_RESTART': '1', 17:55:36 INFO - 'PAGER': '/bin/cat', 17:55:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:55:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:55:36 INFO - 'PWD': '/builds/slave/test', 17:55:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:55:36 INFO - 'SHELL': '/bin/bash', 17:55:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.didN9QTR83/Listeners', 17:55:36 INFO - 'TMPDIR': '/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/', 17:55:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:55:36 INFO - 'USER': 'cltbld', 17:55:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:55:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:55:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:55:36 INFO - 'XPC_FLAGS': '0x0', 17:55:36 INFO - 'XPC_SERVICE_NAME': '0', 17:55:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:55:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:55:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:55:36 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-G6lgFB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:55:36 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)) 17:55:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:55:36 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-ARS2jq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:55:36 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)) 17:55:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:55:36 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-uonmf8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:55:36 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)) 17:55:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:55:36 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-oJSLXp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:55:37 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)) 17:55:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:55:37 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-l963HP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:55:37 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)) 17:55:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:55:37 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-N3VnU1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:55:37 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)) 17:55:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:55:37 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-39hSMR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:55:37 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)) 17:55:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:55:37 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-Y2IygJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:55:37 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)) 17:55:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:55:37 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-JVUoNi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:55:37 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)) 17:55:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:55:37 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-54nzLj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:55:37 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)) 17:55:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:55:37 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-etqzJ3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:55:37 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)) 17:55:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:55:37 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-hz1sxB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:55:37 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)) 17:55:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:55:37 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-mO7PeP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:55:38 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)) 17:55:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:55:38 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-cAhx20-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:55:38 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)) 17:55:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:55:38 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-xd4Hdo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:55:38 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)) 17:55:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:55:38 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-C_Sflv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:55:38 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)) 17:55:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:55:38 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-7j7SQZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:55:38 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)) 17:55:38 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)) 17:55:38 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)) 17:55:38 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)) 17:55:38 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)) 17:55:38 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)) 17:55:38 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:55: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 17:55: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 17:55: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 17:55: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 17:55: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 17:55: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 17:55:40 INFO - Downloading blessings-1.6.tar.gz 17:55:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:55:40 INFO - Installing collected packages: blessings 17:55:40 INFO - Running setup.py install for blessings 17:55:41 INFO - Successfully installed blessings 17:55:41 INFO - Cleaning up... 17:55:41 INFO - Return code: 0 17:55:41 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:55:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:55:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:55:41 INFO - Reading from file tmpfile_stdout 17:55:41 INFO - Current package versions: 17:55:41 INFO - blessings == 1.6 17:55:41 INFO - blobuploader == 1.2.4 17:55:41 INFO - docopt == 0.6.1 17:55:41 INFO - manifestparser == 1.1 17:55:41 INFO - mozInstall == 1.12 17:55:41 INFO - mozcrash == 0.17 17:55:41 INFO - mozdebug == 0.1 17:55:41 INFO - mozdevice == 0.48 17:55:41 INFO - mozfile == 1.2 17:55:41 INFO - mozhttpd == 0.7 17:55:41 INFO - mozinfo == 0.9 17:55:41 INFO - mozleak == 0.1 17:55:41 INFO - mozlog == 3.1 17:55:41 INFO - moznetwork == 0.27 17:55:41 INFO - mozprocess == 0.22 17:55:41 INFO - mozprofile == 0.28 17:55:41 INFO - mozrunner == 6.11 17:55:41 INFO - mozscreenshot == 0.1 17:55:41 INFO - mozsystemmonitor == 0.0 17:55:41 INFO - moztest == 0.7 17:55:41 INFO - mozversion == 1.4 17:55:41 INFO - psutil == 3.1.1 17:55:41 INFO - requests == 1.2.3 17:55:41 INFO - wsgiref == 0.1.2 17:55:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:55:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:55:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:55:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:55:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:55:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:55:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:55:41 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 0x106b1ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106b224c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f98b9c7f9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1069bfd30>, '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 0x106823db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1069b6b20>, '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.SiXXJTN09E/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.didN9QTR83/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/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 17:55:41 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 17:55:41 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 17:55:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SiXXJTN09E/Render', 17:55:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:55:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:55:41 INFO - 'HOME': '/Users/cltbld', 17:55:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:55:41 INFO - 'LOGNAME': 'cltbld', 17:55:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:55:41 INFO - 'MOZ_NO_REMOTE': '1', 17:55:41 INFO - 'NO_EM_RESTART': '1', 17:55:41 INFO - 'PAGER': '/bin/cat', 17:55:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:55:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:55:41 INFO - 'PWD': '/builds/slave/test', 17:55:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:55:41 INFO - 'SHELL': '/bin/bash', 17:55:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.didN9QTR83/Listeners', 17:55:41 INFO - 'TMPDIR': '/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/', 17:55:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:55:41 INFO - 'USER': 'cltbld', 17:55:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:55:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:55:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:55:41 INFO - 'XPC_FLAGS': '0x0', 17:55:41 INFO - 'XPC_SERVICE_NAME': '0', 17:55:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:55:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:55:41 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)) 17:55:41 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)) 17:55:41 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)) 17:55:41 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)) 17:55:41 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)) 17:55:41 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)) 17:55:41 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)) 17:55:41 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)) 17:55:41 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)) 17:55:41 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)) 17:55:41 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)) 17:55:41 INFO - Cleaning up... 17:55:41 INFO - Return code: 0 17:55:41 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:55:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:55:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:55:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:55:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:55:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:55:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:55:41 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 0x106b1ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106b224c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f98b9c7f9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1069bfd30>, '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 0x106823db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1069b6b20>, '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.SiXXJTN09E/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.didN9QTR83/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/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 17:55:41 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 17:55:41 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 17:55:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SiXXJTN09E/Render', 17:55:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:55:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:55:41 INFO - 'HOME': '/Users/cltbld', 17:55:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:55:41 INFO - 'LOGNAME': 'cltbld', 17:55:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:55:41 INFO - 'MOZ_NO_REMOTE': '1', 17:55:41 INFO - 'NO_EM_RESTART': '1', 17:55:41 INFO - 'PAGER': '/bin/cat', 17:55:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:55:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:55:41 INFO - 'PWD': '/builds/slave/test', 17:55:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:55:41 INFO - 'SHELL': '/bin/bash', 17:55:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.didN9QTR83/Listeners', 17:55:41 INFO - 'TMPDIR': '/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/', 17:55:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:55:41 INFO - 'USER': 'cltbld', 17:55:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:55:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:55:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:55:41 INFO - 'XPC_FLAGS': '0x0', 17:55:41 INFO - 'XPC_SERVICE_NAME': '0', 17:55:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:55:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:55:42 INFO - Downloading/unpacking jsonschema 17:55:42 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 17:55:42 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 17:55:42 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 17:55:42 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 17:55:42 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 17:55:42 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 17:55:44 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:55:44 INFO - Downloading/unpacking functools32 (from jsonschema) 17:55:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:55:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:55:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:55:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:55:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:55:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:55:44 INFO - Downloading functools32-3.2.3-2.tar.gz 17:55:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:55:44 INFO - warning: no files found matching '*.txt' 17:55:44 INFO - no previously-included directories found matching 'build' 17:55:44 INFO - no previously-included directories found matching 'dist' 17:55:44 INFO - no previously-included directories found matching '.git*' 17:55:44 INFO - Installing collected packages: jsonschema, functools32 17:55:44 INFO - Running setup.py install for functools32 17:55:45 INFO - warning: no files found matching '*.txt' 17:55:45 INFO - no previously-included directories found matching 'build' 17:55:45 INFO - no previously-included directories found matching 'dist' 17:55:45 INFO - no previously-included directories found matching '.git*' 17:55:45 INFO - Successfully installed jsonschema functools32 17:55:45 INFO - Cleaning up... 17:55:45 INFO - Return code: 0 17:55:45 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 17:55:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:55:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:55:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:55:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:55:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:55:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:55:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x106b1ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106b224c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f98b9c7f9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1069bfd30>, '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 0x106823db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1069b6b20>, '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.SiXXJTN09E/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.didN9QTR83/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/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 17:55:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 17:55:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 17:55:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SiXXJTN09E/Render', 17:55:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:55:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:55:45 INFO - 'HOME': '/Users/cltbld', 17:55:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:55:45 INFO - 'LOGNAME': 'cltbld', 17:55:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:55:45 INFO - 'MOZ_NO_REMOTE': '1', 17:55:45 INFO - 'NO_EM_RESTART': '1', 17:55:45 INFO - 'PAGER': '/bin/cat', 17:55:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:55:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:55:45 INFO - 'PWD': '/builds/slave/test', 17:55:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:55:45 INFO - 'SHELL': '/bin/bash', 17:55:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.didN9QTR83/Listeners', 17:55:45 INFO - 'TMPDIR': '/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/', 17:55:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:55:45 INFO - 'USER': 'cltbld', 17:55:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:55:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:55:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:55:45 INFO - 'XPC_FLAGS': '0x0', 17:55:45 INFO - 'XPC_SERVICE_NAME': '0', 17:55:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:55:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:55:45 INFO - Downloading/unpacking flake8 17:55:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:55:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:55:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:55:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:55:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:55:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:55:47 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 17:55:47 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 17:55:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:55:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:55:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:55:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:55:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:55:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:55:48 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 17:55:48 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 17:55:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:55:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:55:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:55:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:55:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:55:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:55:48 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 17:55:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:55:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:55:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:55:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:55:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:55:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:55:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 17:55:49 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:55:49 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:55:49 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:55:49 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:55:49 INFO - no previously-included directories found matching 'docs/_build' 17:55:49 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 17:55:49 INFO - Running setup.py install for pep8 17:55:49 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:55:49 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:55:49 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:55:49 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:55:49 INFO - no previously-included directories found matching 'docs/_build' 17:55:49 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 17:55:49 INFO - Successfully installed flake8 mccabe pyflakes pep8 17:55:49 INFO - Cleaning up... 17:55:49 INFO - Return code: 0 17:55:49 INFO - Running post-action listener: _resource_record_post_action 17:55:49 INFO - Running post-action listener: _start_resource_monitoring 17:55:49 INFO - Starting resource monitoring. 17:55:49 INFO - ##### 17:55:49 INFO - ##### Running install step. 17:55:49 INFO - ##### 17:55:49 INFO - Running pre-action listener: _resource_record_pre_action 17:55:49 INFO - Running main action method: install 17:55:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:55:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:55:49 INFO - Reading from file tmpfile_stdout 17:55:49 INFO - Detecting whether we're running mozinstall >=1.0... 17:55:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:55:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:55:49 INFO - Reading from file tmpfile_stdout 17:55:49 INFO - Output received: 17:55:49 INFO - Usage: mozinstall [options] installer 17:55:49 INFO - Options: 17:55:49 INFO - -h, --help show this help message and exit 17:55:49 INFO - -d DEST, --destination=DEST 17:55:49 INFO - Directory to install application into. [default: 17:55:49 INFO - "/builds/slave/test"] 17:55:49 INFO - --app=APP Application being installed. [default: firefox] 17:55:49 INFO - mkdir: /builds/slave/test/build/application 17:55:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 17:55:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0.en-US.mac.dmg --destination /builds/slave/test/build/application 17:56:12 INFO - Reading from file tmpfile_stdout 17:56:12 INFO - Output received: 17:56:12 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 17:56:12 INFO - Running post-action listener: _resource_record_post_action 17:56:12 INFO - ##### 17:56:12 INFO - ##### Running run-tests step. 17:56:12 INFO - ##### 17:56:12 INFO - Running pre-action listener: _resource_record_pre_action 17:56:12 INFO - Running main action method: run_tests 17:56:12 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 17:56:12 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 17:56:12 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 17:56:12 INFO - 2016-04-29 17:56:12.318 screenresolution[6259:102652] starting screenresolution argv=screenresolution get 17:56:12 INFO - 2016-04-29 17:56:12.321 screenresolution[6259:102652] Display 0: 1600x1200x32@60 17:56:12 INFO - 2016-04-29 17:56:12.327 screenresolution[6260:102654] starting screenresolution argv=screenresolution list 17:56:12 INFO - Available Modes on Display 0 17:56:12 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 17:56:12 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 17:56:12 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 17:56:12 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 17:56:12 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 17:56:12 INFO - Intel Iris: 17:56:12 INFO - Chipset Model: Intel Iris 17:56:12 INFO - Type: GPU 17:56:12 INFO - Bus: Built-In 17:56:12 INFO - VRAM (Dynamic, Max): 1536 MB 17:56:12 INFO - Vendor: Intel (0x8086) 17:56:12 INFO - Device ID: 0x0a2e 17:56:12 INFO - Revision ID: 0x0009 17:56:12 INFO - Displays: 17:56:12 INFO - Display: 17:56:12 INFO - Resolution: 1600 x 1200 @ 60 Hz 17:56:12 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 17:56:12 INFO - Display Serial Number: 1600x1200 60 17:56:12 INFO - Main Display: Yes 17:56:12 INFO - Mirror: Off 17:56:12 INFO - Online: Yes 17:56:12 INFO - Rotation: Supported 17:56:12 INFO - Return code: 0 17:56:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:56:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:56:12 INFO - Python 2.7.3 17:56:12 INFO - Return code: 0 17:56:12 INFO - grabbing minidump binary from tooltool 17:56: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')]} 17:56:12 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 0x1069bfd30>, '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 0x106823db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1069b6b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:56:12 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 17:56:12 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 17:56:12 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:56:12 INFO - Return code: 0 17:56:12 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 17:56:12 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:56:12 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:56:12 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 17:56:12 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:56:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 17:56:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 17:56:13 INFO - Return code: 0 17:56:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/EvtvSMdoRB-BeTMT9KgmUg/artifacts/public/build/firefox-47.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0177', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 17:56:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/EvtvSMdoRB-BeTMT9KgmUg/artifacts/public/build/firefox-47.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0177 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 17:56:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SiXXJTN09E/Render', 17:56:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:56:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:56:13 INFO - 'HOME': '/Users/cltbld', 17:56:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:56:13 INFO - 'LOGNAME': 'cltbld', 17:56:13 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:56:13 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 17:56:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:56:13 INFO - 'MOZ_NO_REMOTE': '1', 17:56:13 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:56:13 INFO - 'NO_EM_RESTART': '1', 17:56:13 INFO - 'PAGER': '/bin/cat', 17:56:13 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:56:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:56:13 INFO - 'PWD': '/builds/slave/test', 17:56:13 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:56:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:56:13 INFO - 'SHELL': '/bin/bash', 17:56:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.didN9QTR83/Listeners', 17:56:13 INFO - 'TMPDIR': '/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/', 17:56:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:56:13 INFO - 'USER': 'cltbld', 17:56:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:56:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:56:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:56:13 INFO - 'XPC_FLAGS': '0x0', 17:56:13 INFO - 'XPC_SERVICE_NAME': '0', 17:56:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:56:13 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/EvtvSMdoRB-BeTMT9KgmUg/artifacts/public/build/firefox-47.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0177', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 17:56:14 INFO - mozversion application_buildid: 20160429165741 17:56:14 INFO - mozversion application_changeset: 8008dbbe1841442ea9d0f376bb9e47058d1a8f7c 17:56:14 INFO - mozversion application_display_name: Firefox 17:56:14 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:56:14 INFO - mozversion application_name: Firefox 17:56:14 INFO - mozversion application_remotingname: firefox 17:56:14 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 17:56:14 INFO - mozversion application_vendor: Mozilla 17:56:14 INFO - mozversion application_version: 47.0 17:56:14 INFO - mozversion platform_buildid: 20160429165741 17:56:14 INFO - mozversion platform_changeset: 8008dbbe1841442ea9d0f376bb9e47058d1a8f7c 17:56:14 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 17:56:14 INFO - mozversion platform_version: 47.0 17:56:14 INFO - using testdate: 1461977774 17:56:14 INFO - actual date: 1461977774 17:56:14 INFO - starting webserver on 'localhost:57003' 17:56:14 INFO - SUITE-START | Running 2 tests 17:56:14 INFO - TEST-START | dromaeo_css 17:56:14 INFO - operating with platform_type : mac_ 17:56:14 INFO - Initialising browser for dromaeo_css test... 17:56:14 INFO - TEST-INFO | started process 6278 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/tmpclFJqP/profile http://localhost:57003/getInfo.html) 17:56:16 INFO - PROCESS | 6278 | __metrics Screen width/height:1600/1200 17:56:16 INFO - PROCESS | 6278 | colorDepth:24 17:56:16 INFO - PROCESS | 6278 | Browser inner width/height: 1024/689 17:56:16 INFO - PROCESS | 6278 | __metrics 17:56:16 INFO - PROCESS | 6278 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 17:56:16 INFO - PROCESS | 6278 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:56:16 INFO - TEST-INFO | 6278: exit 0 17:56:16 INFO - Browser initialized. 17:56:16 INFO - Running cycle 1/1 for dromaeo_css test... 17:56:16 INFO - TEST-INFO | started process 6282 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/tmpclFJqP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:56:28 INFO - PROCESS | 6282 | RSS: Main: 156532736 17:56:28 INFO - PROCESS | 6282 | 17:57:20 INFO - PROCESS | 6282 | 1461977840394 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] 17:59:29 INFO - PROCESS | 6282 | Cycle 1(1): loaded http://localhost:57003/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57003/tests/dromaeo/cssquery-ext.html) 17:59:30 INFO - PROCESS | 6282 | RSS: Main: 281440256 17:59:30 INFO - PROCESS | 6282 | 18:02:32 INFO - PROCESS | 6282 | Cycle 1(1): loaded http://localhost:57003/tests/dromaeo/cssquery-ext.html (next: http://localhost:57003/tests/dromaeo/cssquery-jquery.html) 18:02:33 INFO - PROCESS | 6282 | RSS: Main: 295346176 18:02:33 INFO - PROCESS | 6282 | 18:05:35 INFO - PROCESS | 6282 | Cycle 1(1): loaded http://localhost:57003/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57003/tests/dromaeo/cssquery-mootools.html) 18:05:35 INFO - PROCESS | 6282 | RSS: Main: 294158336 18:05:35 INFO - PROCESS | 6282 | 18:08:37 INFO - PROCESS | 6282 | Cycle 1(1): loaded http://localhost:57003/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57003/tests/dromaeo/cssquery-prototype.html) 18:08:38 INFO - PROCESS | 6282 | RSS: Main: 252489728 18:08:38 INFO - PROCESS | 6282 | 18:11:41 INFO - PROCESS | 6282 | Cycle 1(1): loaded http://localhost:57003/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57003/tests/dromaeo/cssquery-yui.html) 18:11:41 INFO - PROCESS | 6282 | RSS: Main: 254906368 18:11:41 INFO - PROCESS | 6282 | 18:14:44 INFO - PROCESS | 6282 | Cycle 1(1): loaded http://localhost:57003/tests/dromaeo/cssquery-yui.html (next: http://localhost:57003/tests/dromaeo/cssquery-dojo.html) 18:14:44 INFO - PROCESS | 6282 | RSS: Main: 302039040 18:14:44 INFO - PROCESS | 6282 | 18:14:44 INFO - PROCESS | 6282 | __start_tp_report 18:14:44 INFO - PROCESS | 6282 | _x_x_mozilla_page_load 18:14:44 INFO - PROCESS | 6282 | _x_x_mozilla_page_load_details 18:14:44 INFO - PROCESS | 6282 | |i|pagename|runs| 18:14:44 INFO - PROCESS | 6282 | |0;dojo.html;3555.413356796129;3586.587542432621;3595.5505561804775;3645.6172101929296;3669.5596528416577;5955.702214889249;5956.195913551669;5972.761089556418;5981.760729570818;6050.273967123941;5957.463828255456;5957.88084238315;5988.161657367972;5988.341282458926;5991.520678345732;5200.635955483118;5279.076161671702;5304.787808487675;5352.090144675414;5395.73021348933;5415.620906536544;5428.077226871442;5429.592780541475;5429.864253393657;5430.619856610039;5315.6013299002725;5378.78484860607;5393.865153371177;5409.540189083933;5411.512963833255;4794.208955522369;5402.054640437927;5416.295881535375;5422.267993820843;5458.153986132156;5246;5300.602454815904;5307.575393968474;5374.462553744634;5374.6506477078865;5825;5826.1843341931735;5833.474987251126;5852.4440178183;5909.143174239711;6228.906566401508;6273.05904114382;6273.215848018997;6274.435300822948;6341;6255.249370075575;6270.65511396873;6298.3701629837105;6306.558540902139;6326.841828954313;6057.818265452043;6079.088136779518;6086.908696369558;6104.908426373652;6113.510919126504;6241.500679945593;6328.272248691367;6419.871602567922;6430.582012169194;6452.483801295885;6275.278342990615;6282.905756413657;6287.528435367366;6291.307956124822;6311.147995020613;5274.26160337553;6194.81415557525;6285.622862628257;6306.211723534559;6312.179416675803;6194.0708893666315;6215.658138802319;6267.592606480564;6278.780242691484;6299;6232.065190221503;6267.059941008794;6277.7175027123885;6283.2460104787715;6289.654069026247;5032.974835125801;5056.06462804375;5057.393112826484;5063.443021267658;5063.544281014726;4445.422095127613;4486.528914463999;4556.2937744649635;4580.221362368406;4628.861134165981;6006.159137720722;6009.038553831366;6023.186869772525;6023.397660233942;6033.3664965178905;6236.095766113888;6314.842128946813;6336.714847831859;6342;6345.650989195547;5856.945749764998;5928;5988.461038506555;6007.098935159761;6018.578699491081;5090.414602320707;5190.091733946544;5513.393526712059;5528.86177845549;5543.972280138573;6236.376362363727;6298.779542715983;6345.365463453618;6366.108744775827;6390.648514331663;6217.626942383471;6287.528435367274;6297.433231009048;6299.559030867796;6313.526485513513;5359.973200133974;6294.213223347082;6324.683765811783;6344.429001389897;6379.936200637934;6192.969035154795;6210.472109870711;6274.780382686584;6282.623042617458;6296.244450665949;6249.187605611241;6319.210098737658;6326.9683651581445;6333.461655759128;6335.429811316819;6117.84705382369;6264.498840092872;6281.7173227203975;6287.119803227643;6308.116863639002;6109.755609775737;6211.409916057967;6278.6546739929745;6285.811425657238;6308.52686048539;6199.318075011655;6214.316425193316;6232.501399888089;6242.313345531897;6244.063390491463;6219.440250377488;6311.147995020613;6324.304326523987;6327.525435592257;6329.588576742497;6069.180660610761;6126.609281623789;6127.295361033538;6196.070589411444;6250.062490626442 18:14:44 INFO - PROCESS | 6282 | |1;ext.html;499.2984856276932;590.3594599859152;596.7225240263274;658.7529676371361;676.164936303665;32193.51709724353;41062;41497.792511037405;41609.58390416099;41678.58321416785;44952.32571511422;45537.31694024584;45583.54416455834;45638;45736.77131614346;9891.703248902508;10119.898801012007;10162.390256584591;10180.541875615616;10192.490375481233;9963;10132.696019119438;10157.339772914736;10170;10311;10190.184785217165;10334.896651033469;10336.224783141295;10348.741281467986;10352;10132.696019119438;10285.74285642865;10297.021782930648;10308.175345972304;10311.742206444824;10069.496525173712;10216.335938163995;10221.642242521477;10230.897691023069;10264.384136951807;43597.12805743868;43972;44097.55902440999;44124.55875441236;44149.55850441487;2822.463731890934;3167.4932010878147;3249.382617302705;3425.2635683328203;3603.963960360389;25534.361640959123;26332.8683356582;28696.569551456745;28816.711832881614;29167.854160729272;2885.466188755066;2889.133260021985;2895.363020135567;2901.303687115077;2959.9260018499494;418777;421746;422786;422822;425499;71290.00969932158;75526.86709699359;76403.23596764072;76480.61759691277;76560;79960;80716;80829.19170808217;81190;81345;18798.906005469886;18864.622707545772;18974.81025189758;19003.85976841394;19028.143733532026;14304.427822886968;14372.49696260626;14379.209143496999;14387.208703521197;14391;23089.307320780405;23312.251581131484;23332.76667233306;23353.649695254586;23893.402664933517;9050.683226087187;9284.72145835626;9287.399528132133;9322.182174475913;9326.927403348565;969.9224062075017;994.9154321882721;1002.9749256268506;1042.9322094063862;1138.5104405105883;28854.70153843082;29252;29354.605509161163;29454.410911781644;30086.24784380408;1130.7060164357326;1143.6969203161168;1145.5131569083105;1209.7580483903255;1252.3675543850297;15191.924040379727;15425.537233883002;15830.44593439224;17056.744148837777;17433.91283043602;688032;702177.4891125613;704152;706099;706998;67056;67432.66283668649;67523;67674;67855;1447.3052934591244;1555.7977462929746;1585.6907902958812;1587.9682406351808;1687.384104801763;25367.112151074623;30430.543541846448;30775;30912.536311955788;31443.528347074356;53267.73366133145;54066.459335407715;54124.91750164896;54344.18483722668;54401.455985439636;426823;428270;428815;429579;430715;35693.28613427665;47161.29258061063;47344.763276183396;48988.755056224494;49033.75483122562;48794.26808597803;49270.01459970709;50599;50963.49036509736;51983.74008129935;37424.6257537432;38565.42151867668;38989.41515877208;39174.804125979186;39229.803850981705;37913.81043094767;37947.62052379441;37997.62002380051;38593.61406386013;38866.4170037444;38418;38583;38621;39077.41383879187;39150.2169956605;30291;34308.31383372368;34853.65146348504;34930.301393972484;35109.47335789914;25867.466931646464;25870.87064564665;25905.48189036171;26125.869370653025;26369 18:14:44 INFO - PROCESS | 6282 | |2;jquery.html;383.2928247383577;383.51676887122227;390.43387088721363;399.42083978231574;400.2255635345605;17166.91416542917;20009.399718008466;21205.257815976445;21395.786042139574;21441.892790536065;21915.452113697167;21922;22189.673013762324;22500.43748906278;22821.315360539167;5805;5946.286445626509;6031.215941927543;6053.697315134248;6097;5745.080787074069;5921.674307913063;5952.642841429506;5953.732082056318;5956.761729530814;5659.6321239119325;5893.38119497453;5913.201717768111;5931.881362372772;5994.340622531518;5852.67810270435;5860.619059761123;5903.996320625504;5917.792877249319;5951.851203719898;5076.060928728197;5131.486851314876;5150.716710580917;5153.716545589991;5156.381234251914;26144.73855261442;26326;26557.33606659849;26701.332466688487;26808;2226.25420484138;2242.7532971373134;2287.3938406322336;2440.670509481215;2781.860906954644;15275.312610932535;15283.770743438858;15387.846121538752;15556.299966501421;15628.4530041448;1817.6273863857878;1849.1216672080789;1852.6202128563611;1861.050864059326;1973.822355987968;105353;109155;121265;127324;129541.35229323887;9460.116973000819;11379.146564007733;11514.424278786028;11670.840894434386;11715.531378744925;14523.927380363242;14595.41618335276;14672.779908301383;14703.970722049355;14722.705545889023;8992.595333210022;9141.680041198526;9167.587458564381;9199.678011269574;9265.073492650681;8270.338372930151;9348.626054957862;9364.484953327496;9379.062093790566;9493.810123797486;4308.4399028126145;4604.562566556172;4607.539246075433;4612.677112602086;4642.489326174118;1905.323021155279;1949.4249196486787;1959.931402400909;1963.7250784890127;1964.5481539246055;948.7485816258559;995.8954309797512;1002;1058.090042563395;1148.3224897310627;20641;21334.466638333855;21468.677969830464;21547.506332690587;21883.452913677287;1027.9897201028043;1029.5367084811865;1030.7629245273629;1073.6027669762238;1089.455272363818;11035.282706624044;11339.319640821577;11439.428028598702;11462.369569673749;11510.59712910044;556527;561509;562224;620429;623536;135059;140120;141878.29060854836;143856.28071859782;144417.11165776837;1051.5268129341828;1095.64939219449;1105.4307031878589;1111.7387413957713;1117.0393461622998;18542.629147417247;18855.811441885955;19138.425847224604;19198.8080119197;19312.4206273812;46737.53262467332;54982.72508637431;55172.72413637906;55775.721121394134;58146.54633634193;77775.61112194402;81184.59407702924;81311;82115.5894220549;82701.58649206956;7976.760697179094;8109.878351824609;8123.106458289702;8418.452800567944;8421.07368189511;9448.95275523618;10830.891691082988;12666.556670516487;13196.14225075367;13593.048486605843;9846.901530984598;11304;11305;11831.526738930346;11988.76022479563;11529.942350288195;11823.467943942715;11926.522939082339;11938.403079846146;12189.146759726735;11792.941035295113;12083;12338.938305308417;12384.938075309567;12446.315452650191;8275.462094963808;8432.114627963976;8674.696385626472;8759.781005474913;8877;11387.943060284977;11875.76248475043;11988.340641264465;12021.519139234682;12070.879291207328 18:14:44 INFO - PROCESS | 6282 | |3;mootools.html;1511.8941674082805;1639.352455779967;1670.0898010584235;2007.4579863436873;2078.6881967704844;8335.666573337066;8918.331125165614;9109.908900910988;9117.316201284897;9126.95436522818;8757.211850933414;8961.686340978067;8997.370184087116;9017.23353514952;9043.864342034874;2576.2786419802437;2601;2605.4137818990766;2608.7912966962695;2610.5170543449426;2539.1366935242013;2603.505333986546;2604.869756512176;2618.266885272117;2624.790016798661;2194.6049711052005;2472.554940110779;2585.6380106785064;2622.38373982115;2623.5933430318237;2586.0690151545523;2606.139973808648;2616.071294690386;2617.293330800673;2621.1612284069106;2554.9872250638628;2584.6510721052605;2592.2482480080753;2594.4681340325187;2602.037246218892;9151.908480915172;9208.217301529377;9220.585073671633;9228.169464748205;9250.213731832802;5707.514861236758;5818.8254352369495;5861.85345366365;5868.2371291732225;5873.030949893263;3045.8781648734025;3784.6026167252594;3817.1793064491267;3846.653801157909;3846.8461261549783;1073.9624113156;1091.1816137896578;1094.9726256843562;1108.894655007773;1127.7913585986537;12462.81305780414;12462.940650044666;12474.93963013145;12475.001999839991;12484.250944943242;4975.676581022222;5001.474845141208;5098.1842905135745;5117.590592752571;5137.383513978347;9544.33189676716;9958.352707074017;10594;10617.734556636145;10629.787404251872;5834.504067154255;5850.23946886902;5861;5869.002269614176;5888.764449421975;4666.65000124992;4767.189577771787;5055.469175736568;5192.844214673566;5279.498447647467;3445.620981692012;4048.3522636378625;4087.017796368759;4114.300568903293;4134.193832202752;1348.92580908051;1349.9392527336292;1364.6520137364907;1378.4555100735154;1385.3073463268365;1228.7419641875306;1348.9680394498216;1396.9441222350993;1419.9432022719182;1420.488624095325;8548.829023419621;8576.399652024424;8587.270082043096;8611.268042216356;8689.869651955225;1163.8836116388463;1189.643806061091;1194.832723418722;1213.969650758738;1268.536984000833;6548.869022619616;6620.735170593122;6737.966310168418;6741.426978706767;6747.662616869137;11209.71975700614;11363.829542556869;11473.827892581618;11511.366874821964;11520.078393728481;10508.422036787897;10739.301945373525;11186.552537898555;11245.943770281096;11293.15301352402;8476;8617.82764344722;8645.524496152646;8686.435381700168;8716.564171791386;6999.195092564217;8373.706920257762;8458.407911446386;8483.490990540588;8508;9699.515024248618;9881.20950323958;9902.554385052546;9929.65246216379;10000.04999525044;8163;8538.44500107491;10064.345817521838;10252.077313041862;10332.793344132924;7771.572563509061;7830.804229894298;7867.409944254318;7894.960525197567;7903.644336004779;8504.489730616182;8516.148385161434;8585.441946273471;8586.656533738831;8588.871166932377;7615.504992175491;7760.029996250469;7840.3727701784865;7869.48848324857;7883.251091146332;6313.305536391085;6634.83412914681;7470.0662417197855;7728.033995750531;7822.569758663328;8193.221643943816;8219.301359384519;8229.835403291781;8240.752777416687;8242.876356854533;7347.228541003332;7376.631168441664;7444.032275804111;7449.180590134973;7482.139553951148;7496.137944136276;7523.473356865185;7552;7571.432142589438;7575.621218939141 18:14:44 INFO - PROCESS | 6282 | |4;prototype.html;338.12088569718725;345.6871531264207;346.5425638157633;348.3364191215734;354.286113481335;6424.972004479284;6484.1894763154605;6499.772507962228;6505.544611877171;6523.412892839643;6479.967600162005;6480.675966201683;6495.642739649317;6498.577592456487;6500.869982600345;4646.4888862225125;4729.59798417135;4788.832390866321;4827.300041493982;4879.194932836087;4804.399450068741;4820.975895120519;4823.300621409893;4823.831165909194;4891.070696567658;4827.927581086286;4834.395700537433;4842.588379987706;4848.369711937443;4856.17445034345;4627.028324051937;4689.484156742756;4788.61691064714;4812.350332705075;4816.879578010543;4106.1992911382295;4118.176364727066;4120.608542188487;4125.50493940726;4134.772587507686;6040.335563088057;6116.113163591299;6205.379462053758;6207.099970504297;6222.97320942044;5676.148577713335;5681.857953551153;5685.54515638752;5694.544436445074;5711.143328500717;5566.66600003997;6858.530928865604;6877.9656101719675;6885.655717214169;6899.930510770839;4338.089001309729;4504.301833215857;4516.503184649686;4539.273716205391;4547.977260113711;7128.64356782164;7257.709691612329;7269.491135620508;7270.563766174047;7279.818004549876;4593.977030114895;4599.448066232007;4610.608098311681;4615.007773328751;4618.884527886829;4660.4407471103;4666.043461090469;4668.5798278155125;4670.719756814602;4681.548719896843;5494.890102198014;5501.174823776386;5508.228847961289;5511.145772405283;5518.668879867221;6651.467882569383;6876.862462750817;6893.448524118058;6894;6946.583205007716;1603.3907115296347;1613.903165810055;1626.3819748495496;1632.7142750018936;1637.5414883832545;987.1855719031684;997.4065431068502;1032.4940779018227;1035.2701345551368;1057.5346847387125;5439.428859969726;6442.61344319333;6552.50856185788;6565.868682626417;6579.243387010555;7201.819954501075;7235.384992275715;7236.851969393226;7242;7281.781546553612;5387.434319396485;6525.510586706016;6547.181602299713;6556.0493728410065;6568.770093046721;2749.917502474889;3770.868019619355;3813.84744610218;3823.6941044716355;3828.9042773930873;7046.577205367695;7304.7443339483925;7324.450666199949;7366.668499917517;7380.889286660705;6005.909911351333;7399.149097853816;7402.3707984821895;7425;7427.108746950401;7286.635668216568;7304.306090921247;7311.853762924606;7312.268773122645;7322.97478353031;7160.57036577807;7199.316064973819;7202.89195662055;7205.315495027964;7219.061522002316;6828.795136145924;7104.360607545345;7105.715771369088;7115.6086415247655;7134.072570565793;7281.871309946967;7288.744893928687;7310.707571697072;7321.670524826289;7328.450366222662;4599.586037256663;4612.377329060668;4618.63050955916;4619;4629.606483448944;7171.390431813355;7174.067371241706;7175.964120179366;7181.210066892533;7195.6761945713615;6687.297833727389;6877.58734475933;6952.270011648907;6971.058907047483;6986.580805151707;6885.242623311332;6925.930740692528;6932.7226910923;6935.098437203132;6954.860902781815;6777.6272305023695;6781.830454238683;6788.422984046411;6795.93204067953;6796.456283497408;6757.050749574842;6948.930510694829;6951.617661028692;6959.234484206632;6962.094927659372;6593.505487088391;6699.765508207384;6721;6789.1174147360525;6863.759768408082 18:14:44 INFO - PROCESS | 6282 | |5;yui.html;694.1947341084343;698.0889938630093;736.6280028585563;797.4139007829245;801.9438639295248;15565.455209067684;15763.921180394096;15792.368305267804;15821.288042038108;15848.920755396235;14664.486742963998;14721.55835324942;14737.115773053598;14743.04170228937;14761.630959225999;822.4859462835742;846.6782622603433;977.1938151025432;1011.0496133634397;1018.836986082227;996.6362277768599;1009.0111690543272;1010.151472762879;1013.2400699475394;1016.6899095775785;1058.5025038232018;1061.861957945466;1063.4682658670665;1067.8184708599517;1072.3726619927352;857.7083791510885;900.3517467423445;1063.191974099682;1069.3316677076828;1077.4181941751444;802.9721955896462;809.7773112394079;811.3306522119275;812.3379445751752;812.7561731480532;15717.842821571752;15793.289301981438;15803.920980395025;15819.446319378767;15862.127582982932;13222.338883055809;13289.60131196056;13452.730945381136;13455.865441345657;13928.30358482082;10328.328658637165;10392;10434.530446129866;10715.946420267926;11072.723181920517;3081.9691803081905;3421.5894092709036;3630.3465376232266;3670.724695647837;3749.9250014999548;85030.14969850346;85215.99999999937;87758;88660.55669721674;88747.55626221892;9915.851262231072;9991.700248992542;9993.10062094415;10079.647212347532;10142.290039697298;23948.52102957931;23961.52076958486;24013.879930600586;24024.87987560051;24055.518889622108;7832.804179895548;7880.487768295043;7895.289423951872;7899.723509677134;8134.59327033646;4033.495813023372;4036.4348991141264;4089.7137200396282;4139.0066384068205;4182.121754431603;3801.201747633028;3840.0975770693863;3844.8462061517785;3844.9038774030314;3846.7307288489537;616.6300219868133;688.7348370877248;703.4618516834626;735.724103461202;752.0862152484757;499.5529001543598;525.0103554799231;607.2803727582829;607.9391461898927;629.4083561452312;8055.234752698484;8125.837483250302;8470;8575.656973720981;8720.651173953098;521.947805219475;560.2129008742723;578.3435800366614;584.2521572387351;593.7209511529575;3547.94678079829;3666.3767159582935;3779.281936432069;4019.457373254632;4118.135191609736;68649;85856.57071714726;89264.5536772312;89590;91151.54424227837;87265;87955.08404243649;89651.55174224217;90683;92654.07345926455;72940;74324.25675743281;75563.62218188983;76617.23382766101;78962.60518697485;6696.497762667722;7628.578705299063;7813.960930195312;7885.723999659985;7908.881366779618;52981.73509132584;53909.730451347496;53919.73040134774;54021;55530;46910.29634555416;71855.28144718695;75483;76038;76845;9732.221422286058;10170.440625765654;10526.947365263124;10683.57265709363;10721.839172412265;11034.889651103385;11050.723731906766;11214.943925280648;11385.886141138482;12007.279563226235;8180.304674102768;10599.682009539727;10627.681169564925;10705.304155229886;10832.404217767784;10554.261201716114;10574.387149203169;10665.520051597541;10698.14414846826;10742.355458672504;10387.117095046704;10394.688159355232;10454.477276136011;10492.895071049192;10678.73303167427;8973.327000475121;9178.495182765013;9217.953910230406;9294.442333460014;9592;8925.866112008196;8984.371094023356;9040.502772347583;9103.317251206054;9359.953200234228 18:14:44 INFO - PROCESS | 6282 | __end_tp_report 18:14:44 INFO - PROCESS | 6282 | __start_cc_report 18:14:44 INFO - PROCESS | 6282 | _x_x_mozilla_cycle_collect,1079 18:14:44 INFO - PROCESS | 6282 | __end_cc_report 18:14:44 INFO - PROCESS | 6282 | __startTimestamp1461978884572__endTimestamp 18:14:44 INFO - PROCESS | 6282 | 18:14:44 INFO - PROCESS | 6282 | ------- Summary: start ------- 18:14:44 INFO - PROCESS | 6282 | Number of tests: 6 18:14:44 INFO - PROCESS | 6282 | 18:14:44 INFO - PROCESS | 6282 | [#0] dojo.html Cycles:165 Average:5873.40 Median:6192.97 stddev:618.14 (10.0%) stddev-sans-first:592.69 18:14:44 INFO - PROCESS | 6282 | Values: 3555.4 3586.6 3595.6 3645.6 3669.6 5955.7 5956.2 5972.8 5981.8 6050.3 5957.5 5957.9 5988.2 5988.3 5991.5 5200.6 5279.1 5304.8 5352.1 5395.7 5415.6 5428.1 5429.6 5429.9 5430.6 5315.6 5378.8 5393.9 5409.5 5411.5 4794.2 5402.1 5416.3 5422.3 5458.2 5246.0 5300.6 5307.6 5374.5 5374.7 5825.0 5826.2 5833.5 5852.4 5909.1 6228.9 6273.1 6273.2 6274.4 6341.0 6255.2 6270.7 6298.4 6306.6 6326.8 6057.8 6079.1 6086.9 6104.9 6113.5 6241.5 6328.3 6419.9 6430.6 6452.5 6275.3 6282.9 6287.5 6291.3 6311.1 5274.3 6194.8 6285.6 6306.2 6312.2 6194.1 6215.7 6267.6 6278.8 6299.0 6232.1 6267.1 6277.7 6283.2 6289.7 5033.0 5056.1 5057.4 5063.4 5063.5 4445.4 4486.5 4556.3 4580.2 4628.9 6006.2 6009.0 6023.2 6023.4 6033.4 6236.1 6314.8 6336.7 6342.0 6345.7 5856.9 5928.0 5988.5 6007.1 6018.6 5090.4 5190.1 5513.4 5528.9 5544.0 6236.4 6298.8 6345.4 6366.1 6390.6 6217.6 6287.5 6297.4 6299.6 6313.5 5360.0 6294.2 6324.7 6344.4 6379.9 6193.0 6210.5 6274.8 6282.6 6296.2 6249.2 6319.2 6327.0 6333.5 6335.4 6117.8 6264.5 6281.7 6287.1 6308.1 6109.8 6211.4 6278.7 6285.8 6308.5 6199.3 6214.3 6232.5 6242.3 6244.1 6219.4 6311.1 6324.3 6327.5 6329.6 6069.2 6126.6 6127.3 6196.1 6250.1 18:14:44 INFO - PROCESS | 6282 | 18:14:44 INFO - PROCESS | 6282 | [#1] ext.html Cycles:180 Average:68376.98 Median:35401.38 stddev:142486.38 (402.5%) stddev-sans-first:142794.96 18:14:44 INFO - PROCESS | 6282 | Values: 499.3 590.4 596.7 658.8 676.2 32193.5 41062.0 41497.8 41609.6 41678.6 44952.3 45537.3 45583.5 45638.0 45736.8 9891.7 10119.9 10162.4 10180.5 10192.5 9963.0 10132.7 10157.3 10170.0 10311.0 10190.2 10334.9 10336.2 10348.7 10352.0 10132.7 10285.7 10297.0 10308.2 10311.7 10069.5 10216.3 10221.6 10230.9 10264.4 43597.1 43972.0 44097.6 44124.6 44149.6 2822.5 3167.5 3249.4 3425.3 3604.0 25534.4 26332.9 28696.6 28816.7 29167.9 2885.5 2889.1 2895.4 2901.3 2959.9 418777.0 421746.0 422786.0 422822.0 425499.0 71290.0 75526.9 76403.2 76480.6 76560.0 79960.0 80716.0 80829.2 81190.0 81345.0 18798.9 18864.6 18974.8 19003.9 19028.1 14304.4 14372.5 14379.2 14387.2 14391.0 23089.3 23312.3 23332.8 23353.6 23893.4 9050.7 9284.7 9287.4 9322.2 9326.9 969.9 994.9 1003.0 1042.9 1138.5 28854.7 29252.0 29354.6 29454.4 30086.2 1130.7 1143.7 1145.5 1209.8 1252.4 15191.9 15425.5 15830.4 17056.7 17433.9 688032.0 702177.5 704152.0 706099.0 706998.0 67056.0 67432.7 67523.0 67674.0 67855.0 1447.3 1555.8 1585.7 1588.0 1687.4 25367.1 30430.5 30775.0 30912.5 31443.5 53267.7 54066.5 54124.9 54344.2 54401.5 426823.0 428270.0 428815.0 429579.0 430715.0 35693.3 47161.3 47344.8 48988.8 49033.8 48794.3 49270.0 50599.0 50963.5 51983.7 37424.6 38565.4 38989.4 39174.8 39229.8 37913.8 37947.6 37997.6 38593.6 38866.4 38418.0 38583.0 38621.0 39077.4 39150.2 30291.0 34308.3 34853.7 34930.3 35109.5 25867.5 25870.9 25905.5 26125.9 26369.0 18:14:44 INFO - PROCESS | 6282 | 18:14:44 INFO - PROCESS | 6282 | [#2] jquery.html Cycles:180 Average:35528.95 Median:21918.73 stddev:98231.15 (448.2%) stddev-sans-first:98471.27 18:14:44 INFO - PROCESS | 6282 | Values: 383.3 383.5 390.4 399.4 400.2 17166.9 20009.4 21205.3 21395.8 21441.9 21915.5 21922.0 22189.7 22500.4 22821.3 5805.0 5946.3 6031.2 6053.7 6097.0 5745.1 5921.7 5952.6 5953.7 5956.8 5659.6 5893.4 5913.2 5931.9 5994.3 5852.7 5860.6 5904.0 5917.8 5951.9 5076.1 5131.5 5150.7 5153.7 5156.4 26144.7 26326.0 26557.3 26701.3 26808.0 2226.3 2242.8 2287.4 2440.7 2781.9 15275.3 15283.8 15387.8 15556.3 15628.5 1817.6 1849.1 1852.6 1861.1 1973.8 105353.0 109155.0 121265.0 127324.0 129541.4 9460.1 11379.1 11514.4 11670.8 11715.5 14523.9 14595.4 14672.8 14704.0 14722.7 8992.6 9141.7 9167.6 9199.7 9265.1 8270.3 9348.6 9364.5 9379.1 9493.8 4308.4 4604.6 4607.5 4612.7 4642.5 1905.3 1949.4 1959.9 1963.7 1964.5 948.7 995.9 1002.0 1058.1 1148.3 20641.0 21334.5 21468.7 21547.5 21883.5 1028.0 1029.5 1030.8 1073.6 1089.5 11035.3 11339.3 11439.4 11462.4 11510.6 556527.0 561509.0 562224.0 620429.0 623536.0 135059.0 140120.0 141878.3 143856.3 144417.1 1051.5 1095.6 1105.4 1111.7 1117.0 18542.6 18855.8 19138.4 19198.8 19312.4 46737.5 54982.7 55172.7 55775.7 58146.5 77775.6 81184.6 81311.0 82115.6 82701.6 7976.8 8109.9 8123.1 8418.5 8421.1 9449.0 10830.9 12666.6 13196.1 13593.0 9846.9 11304.0 11305.0 11831.5 11988.8 11529.9 11823.5 11926.5 11938.4 12189.1 11792.9 12083.0 12338.9 12384.9 12446.3 8275.5 8432.1 8674.7 8759.8 8877.0 11387.9 11875.8 11988.3 12021.5 12070.9 18:14:44 INFO - PROCESS | 6282 | 18:14:44 INFO - PROCESS | 6282 | [#3] mootools.html Cycles:180 Average:6315.06 Median:5236.17 stddev:3294.10 (62.9%) stddev-sans-first:3283.55 18:14:44 INFO - PROCESS | 6282 | Values: 1511.9 1639.4 1670.1 2007.5 2078.7 8335.7 8918.3 9109.9 9117.3 9127.0 8757.2 8961.7 8997.4 9017.2 9043.9 2576.3 2601.0 2605.4 2608.8 2610.5 2539.1 2603.5 2604.9 2618.3 2624.8 2194.6 2472.6 2585.6 2622.4 2623.6 2586.1 2606.1 2616.1 2617.3 2621.2 2555.0 2584.7 2592.2 2594.5 2602.0 9151.9 9208.2 9220.6 9228.2 9250.2 5707.5 5818.8 5861.9 5868.2 5873.0 3045.9 3784.6 3817.2 3846.7 3846.8 1074.0 1091.2 1095.0 1108.9 1127.8 12462.8 12462.9 12474.9 12475.0 12484.3 4975.7 5001.5 5098.2 5117.6 5137.4 9544.3 9958.4 10594.0 10617.7 10629.8 5834.5 5850.2 5861.0 5869.0 5888.8 4666.7 4767.2 5055.5 5192.8 5279.5 3445.6 4048.4 4087.0 4114.3 4134.2 1348.9 1349.9 1364.7 1378.5 1385.3 1228.7 1349.0 1396.9 1419.9 1420.5 8548.8 8576.4 8587.3 8611.3 8689.9 1163.9 1189.6 1194.8 1214.0 1268.5 6548.9 6620.7 6738.0 6741.4 6747.7 11209.7 11363.8 11473.8 11511.4 11520.1 10508.4 10739.3 11186.6 11245.9 11293.2 8476.0 8617.8 8645.5 8686.4 8716.6 6999.2 8373.7 8458.4 8483.5 8508.0 9699.5 9881.2 9902.6 9929.7 10000.0 8163.0 8538.4 10064.3 10252.1 10332.8 7771.6 7830.8 7867.4 7895.0 7903.6 8504.5 8516.1 8585.4 8586.7 8588.9 7615.5 7760.0 7840.4 7869.5 7883.3 6313.3 6634.8 7470.1 7728.0 7822.6 8193.2 8219.3 8229.8 8240.8 8242.9 7347.2 7376.6 7444.0 7449.2 7482.1 7496.1 7523.5 7552.0 7571.4 7575.6 18:14:44 INFO - PROCESS | 6282 | 18:14:44 INFO - PROCESS | 6282 | [#4] prototype.html Cycles:180 Average:5664.72 Median:6503.21 stddev:1794.64 (27.6%) stddev-sans-first:1754.57 18:14:44 INFO - PROCESS | 6282 | Values: 338.1 345.7 346.5 348.3 354.3 6425.0 6484.2 6499.8 6505.5 6523.4 6480.0 6480.7 6495.6 6498.6 6500.9 4646.5 4729.6 4788.8 4827.3 4879.2 4804.4 4821.0 4823.3 4823.8 4891.1 4827.9 4834.4 4842.6 4848.4 4856.2 4627.0 4689.5 4788.6 4812.4 4816.9 4106.2 4118.2 4120.6 4125.5 4134.8 6040.3 6116.1 6205.4 6207.1 6223.0 5676.1 5681.9 5685.5 5694.5 5711.1 5566.7 6858.5 6878.0 6885.7 6899.9 4338.1 4504.3 4516.5 4539.3 4548.0 7128.6 7257.7 7269.5 7270.6 7279.8 4594.0 4599.4 4610.6 4615.0 4618.9 4660.4 4666.0 4668.6 4670.7 4681.5 5494.9 5501.2 5508.2 5511.1 5518.7 6651.5 6876.9 6893.4 6894.0 6946.6 1603.4 1613.9 1626.4 1632.7 1637.5 987.2 997.4 1032.5 1035.3 1057.5 5439.4 6442.6 6552.5 6565.9 6579.2 7201.8 7235.4 7236.9 7242.0 7281.8 5387.4 6525.5 6547.2 6556.0 6568.8 2749.9 3770.9 3813.8 3823.7 3828.9 7046.6 7304.7 7324.5 7366.7 7380.9 6005.9 7399.1 7402.4 7425.0 7427.1 7286.6 7304.3 7311.9 7312.3 7323.0 7160.6 7199.3 7202.9 7205.3 7219.1 6828.8 7104.4 7105.7 7115.6 7134.1 7281.9 7288.7 7310.7 7321.7 7328.5 4599.6 4612.4 4618.6 4619.0 4629.6 7171.4 7174.1 7176.0 7181.2 7195.7 6687.3 6877.6 6952.3 6971.1 6986.6 6885.2 6925.9 6932.7 6935.1 6954.9 6777.6 6781.8 6788.4 6795.9 6796.5 6757.1 6948.9 6951.6 6959.2 6962.1 6593.5 6699.8 6721.0 6789.1 6863.8 18:14:44 INFO - PROCESS | 6282 | 18:14:44 INFO - PROCESS | 6282 | [#5] yui.html Cycles:180 Average:18975.12 Median:510.75 stddev:27063.21 (5298.7%) stddev-sans-first:27104.32 18:14:44 INFO - PROCESS | 6282 | Values: 694.2 698.1 736.6 797.4 801.9 15565.5 15763.9 15792.4 15821.3 15848.9 14664.5 14721.6 14737.1 14743.0 14761.6 822.5 846.7 977.2 1011.0 1018.8 996.6 1009.0 1010.2 1013.2 1016.7 1058.5 1061.9 1063.5 1067.8 1072.4 857.7 900.4 1063.2 1069.3 1077.4 803.0 809.8 811.3 812.3 812.8 15717.8 15793.3 15803.9 15819.4 15862.1 13222.3 13289.6 13452.7 13455.9 13928.3 10328.3 10392.0 10434.5 10715.9 11072.7 3082.0 3421.6 3630.3 3670.7 3749.9 85030.1 85216.0 87758.0 88660.6 88747.6 9915.9 9991.7 9993.1 10079.6 10142.3 23948.5 23961.5 24013.9 24024.9 24055.5 7832.8 7880.5 7895.3 7899.7 8134.6 4033.5 4036.4 4089.7 4139.0 4182.1 3801.2 3840.1 3844.8 3844.9 3846.7 616.6 688.7 703.5 735.7 752.1 499.6 525.0 607.3 607.9 629.4 8055.2 8125.8 8470.0 8575.7 8720.7 521.9 560.2 578.3 584.3 593.7 3547.9 3666.4 3779.3 4019.5 4118.1 68649.0 85856.6 89264.6 89590.0 91151.5 87265.0 87955.1 89651.6 90683.0 92654.1 72940.0 74324.3 75563.6 76617.2 78962.6 6696.5 7628.6 7814.0 7885.7 7908.9 52981.7 53909.7 53919.7 54021.0 55530.0 46910.3 71855.3 75483.0 76038.0 76845.0 9732.2 10170.4 10526.9 10683.6 10721.8 11034.9 11050.7 11214.9 11385.9 12007.3 8180.3 10599.7 10627.7 10705.3 10832.4 10554.3 10574.4 10665.5 10698.1 10742.4 10387.1 10394.7 10454.5 10492.9 10678.7 8973.3 9178.5 9218.0 9294.4 9592.0 8925.9 8984.4 9040.5 9103.3 9360.0 18:14:44 INFO - PROCESS | 6282 | -------- Summary: end -------- 18:14:44 INFO - PROCESS | 6282 | 18:14:45 INFO - TEST-INFO | 6282: exit 0 18:14:45 INFO - TEST-OK | dromaeo_css | took 1111055ms 18:14:45 INFO - TEST-START | kraken 18:14:45 INFO - operating with platform_type : mac_ 18:14:45 INFO - Initialising browser for kraken test... 18:14:45 INFO - TEST-INFO | started process 6284 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/tmprtvAb3/profile http://localhost:57003/getInfo.html) 18:14:47 INFO - PROCESS | 6284 | __metrics Screen width/height:1600/1200 18:14:47 INFO - PROCESS | 6284 | colorDepth:24 18:14:47 INFO - PROCESS | 6284 | Browser inner width/height: 1024/689 18:14:47 INFO - PROCESS | 6284 | __metrics 18:14:47 INFO - PROCESS | 6284 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 18:14:47 INFO - PROCESS | 6284 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:14:48 INFO - TEST-INFO | 6284: exit 0 18:14:48 INFO - Browser initialized. 18:14:48 INFO - Running cycle 1/1 for kraken test... 18:14:48 INFO - TEST-INFO | started process 6287 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/tmprtvAb3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:14:59 INFO - PROCESS | 6287 | RSS: Main: 156807168 18:14:59 INFO - PROCESS | 6287 | 18:15:02 INFO - PROCESS | 6287 | Cycle 1(1): loaded http://localhost:57003/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57003/tests/kraken/driver.html?testName=audio-beat-detection) 18:15:03 INFO - PROCESS | 6287 | RSS: Main: 212697088 18:15:03 INFO - PROCESS | 6287 | 18:15:05 INFO - PROCESS | 6287 | Cycle 1(1): loaded http://localhost:57003/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57003/tests/kraken/driver.html?testName=audio-dft) 18:15:06 INFO - PROCESS | 6287 | RSS: Main: 223064064 18:15:06 INFO - PROCESS | 6287 | 18:15:09 INFO - PROCESS | 6287 | Cycle 1(1): loaded http://localhost:57003/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57003/tests/kraken/driver.html?testName=audio-fft) 18:15:10 INFO - PROCESS | 6287 | RSS: Main: 213647360 18:15:10 INFO - PROCESS | 6287 | 18:15:12 INFO - PROCESS | 6287 | Cycle 1(1): loaded http://localhost:57003/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57003/tests/kraken/driver.html?testName=audio-oscillator) 18:15:12 INFO - PROCESS | 6287 | RSS: Main: 214519808 18:15:12 INFO - PROCESS | 6287 | 18:15:14 INFO - PROCESS | 6287 | Cycle 1(1): loaded http://localhost:57003/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57003/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:15:15 INFO - PROCESS | 6287 | RSS: Main: 215826432 18:15:15 INFO - PROCESS | 6287 | 18:15:18 INFO - PROCESS | 6287 | Cycle 1(1): loaded http://localhost:57003/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57003/tests/kraken/driver.html?testName=imaging-darkroom) 18:15:18 INFO - PROCESS | 6287 | RSS: Main: 215601152 18:15:18 INFO - PROCESS | 6287 | 18:15:21 INFO - PROCESS | 6287 | Cycle 1(1): loaded http://localhost:57003/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57003/tests/kraken/driver.html?testName=imaging-desaturate) 18:15:22 INFO - PROCESS | 6287 | RSS: Main: 215699456 18:15:22 INFO - PROCESS | 6287 | 18:15:25 INFO - PROCESS | 6287 | Cycle 1(1): loaded http://localhost:57003/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57003/tests/kraken/driver.html?testName=json-parse-financial) 18:15:25 INFO - PROCESS | 6287 | RSS: Main: 215969792 18:15:25 INFO - PROCESS | 6287 | 18:15:27 INFO - PROCESS | 6287 | Cycle 1(1): loaded http://localhost:57003/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57003/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:15:27 INFO - PROCESS | 6287 | RSS: Main: 249708544 18:15:27 INFO - PROCESS | 6287 | 18:15:29 INFO - PROCESS | 6287 | Cycle 1(1): loaded http://localhost:57003/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57003/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:15:30 INFO - PROCESS | 6287 | RSS: Main: 250900480 18:15:30 INFO - PROCESS | 6287 | 18:15:32 INFO - PROCESS | 6287 | Cycle 1(1): loaded http://localhost:57003/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57003/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:15:32 INFO - PROCESS | 6287 | RSS: Main: 255447040 18:15:32 INFO - PROCESS | 6287 | 18:15:35 INFO - PROCESS | 6287 | Cycle 1(1): loaded http://localhost:57003/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57003/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:15:36 INFO - PROCESS | 6287 | RSS: Main: 257196032 18:15:36 INFO - PROCESS | 6287 | 18:15:38 INFO - PROCESS | 6287 | Cycle 1(1): loaded http://localhost:57003/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57003/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:15:39 INFO - PROCESS | 6287 | RSS: Main: 257347584 18:15:39 INFO - PROCESS | 6287 | 18:15:40 INFO - PROCESS | 6287 | Cycle 1(1): loaded http://localhost:57003/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57003/tests/kraken/driver.html?testName=ai-astar) 18:15:41 INFO - PROCESS | 6287 | RSS: Main: 320061440 18:15:41 INFO - PROCESS | 6287 | 18:15:41 INFO - PROCESS | 6287 | __start_tp_report 18:15:41 INFO - PROCESS | 6287 | _x_x_mozilla_page_load 18:15:41 INFO - PROCESS | 6287 | _x_x_mozilla_page_load_details 18:15:41 INFO - PROCESS | 6287 | |i|pagename|runs| 18:15:41 INFO - PROCESS | 6287 | |0;ai-astar;111;109;116;112;112;113;120;111;112;109 18:15:41 INFO - PROCESS | 6287 | |1;audio-beat-detection;156;117;156;150;118;139;116;150;150;119 18:15:41 INFO - PROCESS | 6287 | |2;audio-dft;183;182;184;182;185;184;181;185;182;183 18:15:41 INFO - PROCESS | 6287 | |3;audio-fft;74;76;74;118;56;58;62;80;163;55 18:15:41 INFO - PROCESS | 6287 | |4;audio-oscillator;90;89;135;81;78;83;119;105;117;154 18:15:41 INFO - PROCESS | 6287 | |5;imaging-gaussian-blur;90;87;87;78;135;131;87;85;136;70 18:15:41 INFO - PROCESS | 6287 | |6;imaging-darkroom;92;92;93;93;92;93;102;150;129;92 18:15:41 INFO - PROCESS | 6287 | |7;imaging-desaturate;84;105;143;83;87;85;84;86;85;86 18:15:41 INFO - PROCESS | 6287 | |8;json-parse-financial;55;58;58;57;57;58;58;58;53;54 18:15:41 INFO - PROCESS | 6287 | |9;json-stringify-tinderbox;63;60;78;73;69;67;67;67;67;64 18:15:41 INFO - PROCESS | 6287 | |10;stanford-crypto-aes;79;82;81;82;80;79;80;80;79;100 18:15:41 INFO - PROCESS | 6287 | |11;stanford-crypto-ccm;129;123;129;124;124;129;128;113;130;131 18:15:41 INFO - PROCESS | 6287 | |12;stanford-crypto-pbkdf2;135;127;136;135;134;134;134;134;126;123 18:15:41 INFO - PROCESS | 6287 | |13;stanford-crypto-sha256-iterative;66;66;66;67;92;92;63;53;94;94 18:15:41 INFO - PROCESS | 6287 | __end_tp_report 18:15:41 INFO - PROCESS | 6287 | __start_cc_report 18:15:41 INFO - PROCESS | 6287 | _x_x_mozilla_cycle_collect,1208 18:15:41 INFO - PROCESS | 6287 | __end_cc_report 18:15:41 INFO - PROCESS | 6287 | __startTimestamp1461978941181__endTimestamp 18:15:41 INFO - PROCESS | 6287 | 18:15:41 INFO - PROCESS | 6287 | ------- Summary: start ------- 18:15:41 INFO - PROCESS | 6287 | Number of tests: 14 18:15:41 INFO - PROCESS | 6287 | 18:15:41 INFO - PROCESS | 6287 | [#0] ai-astar Cycles:10 Average:112.50 Median:112.00 stddev:3.31 (3.0%) stddev-sans-first:3.46 18:15:41 INFO - PROCESS | 6287 | Values: 111.0 109.0 116.0 112.0 112.0 113.0 120.0 111.0 112.0 109.0 18:15:41 INFO - PROCESS | 6287 | 18:15:41 INFO - PROCESS | 6287 | [#1] audio-beat-detection Cycles:10 Average:137.10 Median:150.00 stddev:17.51 (11.7%) stddev-sans-first:17.18 18:15:41 INFO - PROCESS | 6287 | Values: 156.0 117.0 156.0 150.0 118.0 139.0 116.0 150.0 150.0 119.0 18:15:41 INFO - PROCESS | 6287 | 18:15:41 INFO - PROCESS | 6287 | [#2] audio-dft Cycles:10 Average:183.10 Median:183.50 stddev:1.37 (0.7%) stddev-sans-first:1.45 18:15:41 INFO - PROCESS | 6287 | Values: 183.0 182.0 184.0 182.0 185.0 184.0 181.0 185.0 182.0 183.0 18:15:41 INFO - PROCESS | 6287 | 18:15:41 INFO - PROCESS | 6287 | [#3] audio-fft Cycles:10 Average:81.60 Median:68.00 stddev:34.00 (50.0%) stddev-sans-first:35.95 18:15:41 INFO - PROCESS | 6287 | Values: 74.0 76.0 74.0 118.0 56.0 58.0 62.0 80.0 163.0 55.0 18:15:41 INFO - PROCESS | 6287 | 18:15:41 INFO - PROCESS | 6287 | [#4] audio-oscillator Cycles:10 Average:105.10 Median:79.50 stddev:25.63 (32.2%) stddev-sans-first:26.59 18:15:41 INFO - PROCESS | 6287 | Values: 90.0 89.0 135.0 81.0 78.0 83.0 119.0 105.0 117.0 154.0 18:15:41 INFO - PROCESS | 6287 | 18:15:41 INFO - PROCESS | 6287 | [#5] imaging-gaussian-blur Cycles:10 Average:98.60 Median:86.00 stddev:25.12 (29.2%) stddev-sans-first:26.45 18:15:41 INFO - PROCESS | 6287 | Values: 90.0 87.0 87.0 78.0 135.0 131.0 87.0 85.0 136.0 70.0 18:15:41 INFO - PROCESS | 6287 | 18:15:41 INFO - PROCESS | 6287 | [#6] imaging-darkroom Cycles:10 Average:102.80 Median:92.00 stddev:20.19 (21.9%) stddev-sans-first:21.04 18:15:41 INFO - PROCESS | 6287 | Values: 92.0 92.0 93.0 93.0 92.0 93.0 102.0 150.0 129.0 92.0 18:15:41 INFO - PROCESS | 6287 | 18:15:41 INFO - PROCESS | 6287 | [#7] imaging-desaturate Cycles:10 Average:92.80 Median:85.00 stddev:18.76 (22.1%) stddev-sans-first:19.63 18:15:41 INFO - PROCESS | 6287 | Values: 84.0 105.0 143.0 83.0 87.0 85.0 84.0 86.0 85.0 86.0 18:15:41 INFO - PROCESS | 6287 | 18:15:41 INFO - PROCESS | 6287 | [#8] json-parse-financial Cycles:10 Average:56.60 Median:58.00 stddev:1.90 (3.3%) stddev-sans-first:1.92 18:15:41 INFO - PROCESS | 6287 | Values: 55.0 58.0 58.0 57.0 57.0 58.0 58.0 58.0 53.0 54.0 18:15:41 INFO - PROCESS | 6287 | 18:15:41 INFO - PROCESS | 6287 | [#9] json-stringify-tinderbox Cycles:10 Average:67.50 Median:67.00 stddev:5.08 (7.6%) stddev-sans-first:5.12 18:15:41 INFO - PROCESS | 6287 | Values: 63.0 60.0 78.0 73.0 69.0 67.0 67.0 67.0 67.0 64.0 18:15:41 INFO - PROCESS | 6287 | 18:15:41 INFO - PROCESS | 6287 | [#10] stanford-crypto-aes Cycles:10 Average:82.20 Median:80.00 stddev:6.36 (7.9%) stddev-sans-first:6.64 18:15:41 INFO - PROCESS | 6287 | Values: 79.0 82.0 81.0 82.0 80.0 79.0 80.0 80.0 79.0 100.0 18:15:41 INFO - PROCESS | 6287 | 18:15:41 INFO - PROCESS | 6287 | [#11] stanford-crypto-ccm Cycles:10 Average:126.00 Median:129.00 stddev:5.35 (4.2%) stddev-sans-first:5.57 18:15:41 INFO - PROCESS | 6287 | Values: 129.0 123.0 129.0 124.0 124.0 129.0 128.0 113.0 130.0 131.0 18:15:41 INFO - PROCESS | 6287 | 18:15:41 INFO - PROCESS | 6287 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:131.80 Median:134.00 stddev:4.61 (3.4%) stddev-sans-first:4.75 18:15:41 INFO - PROCESS | 6287 | Values: 135.0 127.0 136.0 135.0 134.0 134.0 134.0 134.0 126.0 123.0 18:15:41 INFO - PROCESS | 6287 | 18:15:41 INFO - PROCESS | 6287 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:75.30 Median:79.50 stddev:15.76 (19.8%) stddev-sans-first:16.35 18:15:41 INFO - PROCESS | 6287 | Values: 66.0 66.0 66.0 67.0 92.0 92.0 63.0 53.0 94.0 94.0 18:15:41 INFO - PROCESS | 6287 | -------- Summary: end -------- 18:15:41 INFO - PROCESS | 6287 | 18:15:41 INFO - TEST-INFO | 6287: exit 0 18:15:41 INFO - TEST-OK | kraken | took 56763ms 18:15:41 INFO - SUITE-END | took 1167s 18:15:42 INFO - Completed test suite (00:19:28) 18:15:42 INFO - javascript benchmark 18:15:42 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3555.413356796129, 3586.587542432621, 3595.5505561804775, 3645.6172101929296, 3669.5596528416577, 5955.702214889249, 5956.195913551669, 5972.761089556418, 5981.760729570818, 6050.273967123941, 5957.463828255456, 5957.88084238315, 5988.161657367972, 5988.341282458926, 5991.520678345732, 5200.635955483118, 5279.076161671702, 5304.787808487675, 5352.090144675414, 5395.73021348933, 5415.620906536544, 5428.077226871442, 5429.592780541475, 5429.864253393657, 5430.619856610039, 5315.6013299002725, 5378.78484860607, 5393.865153371177, 5409.540189083933, 5411.512963833255, 4794.208955522369, 5402.054640437927, 5416.295881535375, 5422.267993820843, 5458.153986132156, 5246.0, 5300.602454815904, 5307.575393968474, 5374.462553744634, 5374.6506477078865, 5825.0, 5826.1843341931735, 5833.474987251126, 5852.4440178183, 5909.143174239711, 6228.906566401508, 6273.05904114382, 6273.215848018997, 6274.435300822948, 6341.0, 6255.249370075575, 6270.65511396873, 6298.3701629837105, 6306.558540902139, 6326.841828954313, 6057.818265452043, 6079.088136779518, 6086.908696369558, 6104.908426373652, 6113.510919126504, 6241.500679945593, 6328.272248691367, 6419.871602567922, 6430.582012169194, 6452.483801295885, 6275.278342990615, 6282.905756413657, 6287.528435367366, 6291.307956124822, 6311.147995020613, 5274.26160337553, 6194.81415557525, 6285.622862628257, 6306.211723534559, 6312.179416675803, 6194.0708893666315, 6215.658138802319, 6267.592606480564, 6278.780242691484, 6299.0, 6232.065190221503, 6267.059941008794, 6277.7175027123885, 6283.2460104787715, 6289.654069026247, 5032.974835125801, 5056.06462804375, 5057.393112826484, 5063.443021267658, 5063.544281014726, 4445.422095127613, 4486.528914463999, 4556.2937744649635, 4580.221362368406, 4628.861134165981, 6006.159137720722, 6009.038553831366, 6023.186869772525, 6023.397660233942, 6033.3664965178905, 6236.095766113888, 6314.842128946813, 6336.714847831859, 6342.0, 6345.650989195547, 5856.945749764998, 5928.0, 5988.461038506555, 6007.098935159761, 6018.578699491081, 5090.414602320707, 5190.091733946544, 5513.393526712059, 5528.86177845549, 5543.972280138573, 6236.376362363727, 6298.779542715983, 6345.365463453618, 6366.108744775827, 6390.648514331663, 6217.626942383471, 6287.528435367274, 6297.433231009048, 6299.559030867796, 6313.526485513513, 5359.973200133974, 6294.213223347082, 6324.683765811783, 6344.429001389897, 6379.936200637934, 6192.969035154795, 6210.472109870711, 6274.780382686584, 6282.623042617458, 6296.244450665949, 6249.187605611241, 6319.210098737658, 6326.9683651581445, 6333.461655759128, 6335.429811316819, 6117.84705382369, 6264.498840092872, 6281.7173227203975, 6287.119803227643, 6308.116863639002, 6109.755609775737, 6211.409916057967, 6278.6546739929745, 6285.811425657238, 6308.52686048539, 6199.318075011655, 6214.316425193316, 6232.501399888089, 6242.313345531897, 6244.063390491463, 6219.440250377488, 6311.147995020613, 6324.304326523987, 6327.525435592257, 6329.588576742497, 6069.180660610761, 6126.609281623789, 6127.295361033538, 6196.070589411444, 6250.062490626442], "unit": "score", "name": "dojo.html", "value": 5836.614581889351}, {"lowerIsBetter": false, "replicates": [499.2984856276932, 590.3594599859152, 596.7225240263274, 658.7529676371361, 676.164936303665, 32193.51709724353, 41062.0, 41497.792511037405, 41609.58390416099, 41678.58321416785, 44952.32571511422, 45537.31694024584, 45583.54416455834, 45638.0, 45736.77131614346, 9891.703248902508, 10119.898801012007, 10162.390256584591, 10180.541875615616, 10192.490375481233, 9963.0, 10132.696019119438, 10157.339772914736, 10170.0, 10311.0, 10190.184785217165, 10334.896651033469, 10336.224783141295, 10348.741281467986, 10352.0, 10132.696019119438, 10285.74285642865, 10297.021782930648, 10308.175345972304, 10311.742206444824, 10069.496525173712, 10216.335938163995, 10221.642242521477, 10230.897691023069, 10264.384136951807, 43597.12805743868, 43972.0, 44097.55902440999, 44124.55875441236, 44149.55850441487, 2822.463731890934, 3167.4932010878147, 3249.382617302705, 3425.2635683328203, 3603.963960360389, 25534.361640959123, 26332.8683356582, 28696.569551456745, 28816.711832881614, 29167.854160729272, 2885.466188755066, 2889.133260021985, 2895.363020135567, 2901.303687115077, 2959.9260018499494, 418777.0, 421746.0, 422786.0, 422822.0, 425499.0, 71290.00969932158, 75526.86709699359, 76403.23596764072, 76480.61759691277, 76560.0, 79960.0, 80716.0, 80829.19170808217, 81190.0, 81345.0, 18798.906005469886, 18864.622707545772, 18974.81025189758, 19003.85976841394, 19028.143733532026, 14304.427822886968, 14372.49696260626, 14379.209143496999, 14387.208703521197, 14391.0, 23089.307320780405, 23312.251581131484, 23332.76667233306, 23353.649695254586, 23893.402664933517, 9050.683226087187, 9284.72145835626, 9287.399528132133, 9322.182174475913, 9326.927403348565, 969.9224062075017, 994.9154321882721, 1002.9749256268506, 1042.9322094063862, 1138.5104405105883, 28854.70153843082, 29252.0, 29354.605509161163, 29454.410911781644, 30086.24784380408, 1130.7060164357326, 1143.6969203161168, 1145.5131569083105, 1209.7580483903255, 1252.3675543850297, 15191.924040379727, 15425.537233883002, 15830.44593439224, 17056.744148837777, 17433.91283043602, 688032.0, 702177.4891125613, 704152.0, 706099.0, 706998.0, 67056.0, 67432.66283668649, 67523.0, 67674.0, 67855.0, 1447.3052934591244, 1555.7977462929746, 1585.6907902958812, 1587.9682406351808, 1687.384104801763, 25367.112151074623, 30430.543541846448, 30775.0, 30912.536311955788, 31443.528347074356, 53267.73366133145, 54066.459335407715, 54124.91750164896, 54344.18483722668, 54401.455985439636, 426823.0, 428270.0, 428815.0, 429579.0, 430715.0, 35693.28613427665, 47161.29258061063, 47344.763276183396, 48988.755056224494, 49033.75483122562, 48794.26808597803, 49270.01459970709, 50599.0, 50963.49036509736, 51983.74008129935, 37424.6257537432, 38565.42151867668, 38989.41515877208, 39174.804125979186, 39229.803850981705, 37913.81043094767, 37947.62052379441, 37997.62002380051, 38593.61406386013, 38866.4170037444, 38418.0, 38583.0, 38621.0, 39077.41383879187, 39150.2169956605, 30291.0, 34308.31383372368, 34853.65146348504, 34930.301393972484, 35109.47335789914, 25867.466931646464, 25870.87064564665, 25905.48189036171, 26125.869370653025, 26369.0], "unit": "score", "name": "ext.html", "value": 21355.21391381913}, {"lowerIsBetter": false, "replicates": [383.2928247383577, 383.51676887122227, 390.43387088721363, 399.42083978231574, 400.2255635345605, 17166.91416542917, 20009.399718008466, 21205.257815976445, 21395.786042139574, 21441.892790536065, 21915.452113697167, 21922.0, 22189.673013762324, 22500.43748906278, 22821.315360539167, 5805.0, 5946.286445626509, 6031.215941927543, 6053.697315134248, 6097.0, 5745.080787074069, 5921.674307913063, 5952.642841429506, 5953.732082056318, 5956.761729530814, 5659.6321239119325, 5893.38119497453, 5913.201717768111, 5931.881362372772, 5994.340622531518, 5852.67810270435, 5860.619059761123, 5903.996320625504, 5917.792877249319, 5951.851203719898, 5076.060928728197, 5131.486851314876, 5150.716710580917, 5153.716545589991, 5156.381234251914, 26144.73855261442, 26326.0, 26557.33606659849, 26701.332466688487, 26808.0, 2226.25420484138, 2242.7532971373134, 2287.3938406322336, 2440.670509481215, 2781.860906954644, 15275.312610932535, 15283.770743438858, 15387.846121538752, 15556.299966501421, 15628.4530041448, 1817.6273863857878, 1849.1216672080789, 1852.6202128563611, 1861.050864059326, 1973.822355987968, 105353.0, 109155.0, 121265.0, 127324.0, 129541.35229323887, 9460.116973000819, 11379.146564007733, 11514.424278786028, 11670.840894434386, 11715.531378744925, 14523.927380363242, 14595.41618335276, 14672.779908301383, 14703.970722049355, 14722.705545889023, 8992.595333210022, 9141.680041198526, 9167.587458564381, 9199.678011269574, 9265.073492650681, 8270.338372930151, 9348.626054957862, 9364.484953327496, 9379.062093790566, 9493.810123797486, 4308.4399028126145, 4604.562566556172, 4607.539246075433, 4612.677112602086, 4642.489326174118, 1905.323021155279, 1949.4249196486787, 1959.931402400909, 1963.7250784890127, 1964.5481539246055, 948.7485816258559, 995.8954309797512, 1002.0, 1058.090042563395, 1148.3224897310627, 20641.0, 21334.466638333855, 21468.677969830464, 21547.506332690587, 21883.452913677287, 1027.9897201028043, 1029.5367084811865, 1030.7629245273629, 1073.6027669762238, 1089.455272363818, 11035.282706624044, 11339.319640821577, 11439.428028598702, 11462.369569673749, 11510.59712910044, 556527.0, 561509.0, 562224.0, 620429.0, 623536.0, 135059.0, 140120.0, 141878.29060854836, 143856.28071859782, 144417.11165776837, 1051.5268129341828, 1095.64939219449, 1105.4307031878589, 1111.7387413957713, 1117.0393461622998, 18542.629147417247, 18855.811441885955, 19138.425847224604, 19198.8080119197, 19312.4206273812, 46737.53262467332, 54982.72508637431, 55172.72413637906, 55775.721121394134, 58146.54633634193, 77775.61112194402, 81184.59407702924, 81311.0, 82115.5894220549, 82701.58649206956, 7976.760697179094, 8109.878351824609, 8123.106458289702, 8418.452800567944, 8421.07368189511, 9448.95275523618, 10830.891691082988, 12666.556670516487, 13196.14225075367, 13593.048486605843, 9846.901530984598, 11304.0, 11305.0, 11831.526738930346, 11988.76022479563, 11529.942350288195, 11823.467943942715, 11926.522939082339, 11938.403079846146, 12189.146759726735, 11792.941035295113, 12083.0, 12338.938305308417, 12384.938075309567, 12446.315452650191, 8275.462094963808, 8432.114627963976, 8674.696385626472, 8759.781005474913, 8877.0, 11387.943060284977, 11875.76248475043, 11988.340641264465, 12021.519139234682, 12070.879291207328], "unit": "score", "name": "jquery.html", "value": 9987.732171603408}, {"lowerIsBetter": false, "replicates": [1511.8941674082805, 1639.352455779967, 1670.0898010584235, 2007.4579863436873, 2078.6881967704844, 8335.666573337066, 8918.331125165614, 9109.908900910988, 9117.316201284897, 9126.95436522818, 8757.211850933414, 8961.686340978067, 8997.370184087116, 9017.23353514952, 9043.864342034874, 2576.2786419802437, 2601.0, 2605.4137818990766, 2608.7912966962695, 2610.5170543449426, 2539.1366935242013, 2603.505333986546, 2604.869756512176, 2618.266885272117, 2624.790016798661, 2194.6049711052005, 2472.554940110779, 2585.6380106785064, 2622.38373982115, 2623.5933430318237, 2586.0690151545523, 2606.139973808648, 2616.071294690386, 2617.293330800673, 2621.1612284069106, 2554.9872250638628, 2584.6510721052605, 2592.2482480080753, 2594.4681340325187, 2602.037246218892, 9151.908480915172, 9208.217301529377, 9220.585073671633, 9228.169464748205, 9250.213731832802, 5707.514861236758, 5818.8254352369495, 5861.85345366365, 5868.2371291732225, 5873.030949893263, 3045.8781648734025, 3784.6026167252594, 3817.1793064491267, 3846.653801157909, 3846.8461261549783, 1073.9624113156, 1091.1816137896578, 1094.9726256843562, 1108.894655007773, 1127.7913585986537, 12462.81305780414, 12462.940650044666, 12474.93963013145, 12475.001999839991, 12484.250944943242, 4975.676581022222, 5001.474845141208, 5098.1842905135745, 5117.590592752571, 5137.383513978347, 9544.33189676716, 9958.352707074017, 10594.0, 10617.734556636145, 10629.787404251872, 5834.504067154255, 5850.23946886902, 5861.0, 5869.002269614176, 5888.764449421975, 4666.65000124992, 4767.189577771787, 5055.469175736568, 5192.844214673566, 5279.498447647467, 3445.620981692012, 4048.3522636378625, 4087.017796368759, 4114.300568903293, 4134.193832202752, 1348.92580908051, 1349.9392527336292, 1364.6520137364907, 1378.4555100735154, 1385.3073463268365, 1228.7419641875306, 1348.9680394498216, 1396.9441222350993, 1419.9432022719182, 1420.488624095325, 8548.829023419621, 8576.399652024424, 8587.270082043096, 8611.268042216356, 8689.869651955225, 1163.8836116388463, 1189.643806061091, 1194.832723418722, 1213.969650758738, 1268.536984000833, 6548.869022619616, 6620.735170593122, 6737.966310168418, 6741.426978706767, 6747.662616869137, 11209.71975700614, 11363.829542556869, 11473.827892581618, 11511.366874821964, 11520.078393728481, 10508.422036787897, 10739.301945373525, 11186.552537898555, 11245.943770281096, 11293.15301352402, 8476.0, 8617.82764344722, 8645.524496152646, 8686.435381700168, 8716.564171791386, 6999.195092564217, 8373.706920257762, 8458.407911446386, 8483.490990540588, 8508.0, 9699.515024248618, 9881.20950323958, 9902.554385052546, 9929.65246216379, 10000.04999525044, 8163.0, 8538.44500107491, 10064.345817521838, 10252.077313041862, 10332.793344132924, 7771.572563509061, 7830.804229894298, 7867.409944254318, 7894.960525197567, 7903.644336004779, 8504.489730616182, 8516.148385161434, 8585.441946273471, 8586.656533738831, 8588.871166932377, 7615.504992175491, 7760.029996250469, 7840.3727701784865, 7869.48848324857, 7883.251091146332, 6313.305536391085, 6634.83412914681, 7470.0662417197855, 7728.033995750531, 7822.569758663328, 8193.221643943816, 8219.301359384519, 8229.835403291781, 8240.752777416687, 8242.876356854533, 7347.228541003332, 7376.631168441664, 7444.032275804111, 7449.180590134973, 7482.139553951148, 7496.137944136276, 7523.473356865185, 7552.0, 7571.432142589438, 7575.621218939141], "unit": "score", "name": "mootools.html", "value": 5171.626393186732}, {"lowerIsBetter": false, "replicates": [338.12088569718725, 345.6871531264207, 346.5425638157633, 348.3364191215734, 354.286113481335, 6424.972004479284, 6484.1894763154605, 6499.772507962228, 6505.544611877171, 6523.412892839643, 6479.967600162005, 6480.675966201683, 6495.642739649317, 6498.577592456487, 6500.869982600345, 4646.4888862225125, 4729.59798417135, 4788.832390866321, 4827.300041493982, 4879.194932836087, 4804.399450068741, 4820.975895120519, 4823.300621409893, 4823.831165909194, 4891.070696567658, 4827.927581086286, 4834.395700537433, 4842.588379987706, 4848.369711937443, 4856.17445034345, 4627.028324051937, 4689.484156742756, 4788.61691064714, 4812.350332705075, 4816.879578010543, 4106.1992911382295, 4118.176364727066, 4120.608542188487, 4125.50493940726, 4134.772587507686, 6040.335563088057, 6116.113163591299, 6205.379462053758, 6207.099970504297, 6222.97320942044, 5676.148577713335, 5681.857953551153, 5685.54515638752, 5694.544436445074, 5711.143328500717, 5566.66600003997, 6858.530928865604, 6877.9656101719675, 6885.655717214169, 6899.930510770839, 4338.089001309729, 4504.301833215857, 4516.503184649686, 4539.273716205391, 4547.977260113711, 7128.64356782164, 7257.709691612329, 7269.491135620508, 7270.563766174047, 7279.818004549876, 4593.977030114895, 4599.448066232007, 4610.608098311681, 4615.007773328751, 4618.884527886829, 4660.4407471103, 4666.043461090469, 4668.5798278155125, 4670.719756814602, 4681.548719896843, 5494.890102198014, 5501.174823776386, 5508.228847961289, 5511.145772405283, 5518.668879867221, 6651.467882569383, 6876.862462750817, 6893.448524118058, 6894.0, 6946.583205007716, 1603.3907115296347, 1613.903165810055, 1626.3819748495496, 1632.7142750018936, 1637.5414883832545, 987.1855719031684, 997.4065431068502, 1032.4940779018227, 1035.2701345551368, 1057.5346847387125, 5439.428859969726, 6442.61344319333, 6552.50856185788, 6565.868682626417, 6579.243387010555, 7201.819954501075, 7235.384992275715, 7236.851969393226, 7242.0, 7281.781546553612, 5387.434319396485, 6525.510586706016, 6547.181602299713, 6556.0493728410065, 6568.770093046721, 2749.917502474889, 3770.868019619355, 3813.84744610218, 3823.6941044716355, 3828.9042773930873, 7046.577205367695, 7304.7443339483925, 7324.450666199949, 7366.668499917517, 7380.889286660705, 6005.909911351333, 7399.149097853816, 7402.3707984821895, 7425.0, 7427.108746950401, 7286.635668216568, 7304.306090921247, 7311.853762924606, 7312.268773122645, 7322.97478353031, 7160.57036577807, 7199.316064973819, 7202.89195662055, 7205.315495027964, 7219.061522002316, 6828.795136145924, 7104.360607545345, 7105.715771369088, 7115.6086415247655, 7134.072570565793, 7281.871309946967, 7288.744893928687, 7310.707571697072, 7321.670524826289, 7328.450366222662, 4599.586037256663, 4612.377329060668, 4618.63050955916, 4619.0, 4629.606483448944, 7171.390431813355, 7174.067371241706, 7175.964120179366, 7181.210066892533, 7195.6761945713615, 6687.297833727389, 6877.58734475933, 6952.270011648907, 6971.058907047483, 6986.580805151707, 6885.242623311332, 6925.930740692528, 6932.7226910923, 6935.098437203132, 6954.860902781815, 6777.6272305023695, 6781.830454238683, 6788.422984046411, 6795.93204067953, 6796.456283497408, 6757.050749574842, 6948.930510694829, 6951.617661028692, 6959.234484206632, 6962.094927659372, 6593.505487088391, 6699.765508207384, 6721.0, 6789.1174147360525, 6863.759768408082], "unit": "score", "name": "prototype.html", "value": 5068.7217109096755}, {"lowerIsBetter": false, "replicates": [694.1947341084343, 698.0889938630093, 736.6280028585563, 797.4139007829245, 801.9438639295248, 15565.455209067684, 15763.921180394096, 15792.368305267804, 15821.288042038108, 15848.920755396235, 14664.486742963998, 14721.55835324942, 14737.115773053598, 14743.04170228937, 14761.630959225999, 822.4859462835742, 846.6782622603433, 977.1938151025432, 1011.0496133634397, 1018.836986082227, 996.6362277768599, 1009.0111690543272, 1010.151472762879, 1013.2400699475394, 1016.6899095775785, 1058.5025038232018, 1061.861957945466, 1063.4682658670665, 1067.8184708599517, 1072.3726619927352, 857.7083791510885, 900.3517467423445, 1063.191974099682, 1069.3316677076828, 1077.4181941751444, 802.9721955896462, 809.7773112394079, 811.3306522119275, 812.3379445751752, 812.7561731480532, 15717.842821571752, 15793.289301981438, 15803.920980395025, 15819.446319378767, 15862.127582982932, 13222.338883055809, 13289.60131196056, 13452.730945381136, 13455.865441345657, 13928.30358482082, 10328.328658637165, 10392.0, 10434.530446129866, 10715.946420267926, 11072.723181920517, 3081.9691803081905, 3421.5894092709036, 3630.3465376232266, 3670.724695647837, 3749.9250014999548, 85030.14969850346, 85215.99999999937, 87758.0, 88660.55669721674, 88747.55626221892, 9915.851262231072, 9991.700248992542, 9993.10062094415, 10079.647212347532, 10142.290039697298, 23948.52102957931, 23961.52076958486, 24013.879930600586, 24024.87987560051, 24055.518889622108, 7832.804179895548, 7880.487768295043, 7895.289423951872, 7899.723509677134, 8134.59327033646, 4033.495813023372, 4036.4348991141264, 4089.7137200396282, 4139.0066384068205, 4182.121754431603, 3801.201747633028, 3840.0975770693863, 3844.8462061517785, 3844.9038774030314, 3846.7307288489537, 616.6300219868133, 688.7348370877248, 703.4618516834626, 735.724103461202, 752.0862152484757, 499.5529001543598, 525.0103554799231, 607.2803727582829, 607.9391461898927, 629.4083561452312, 8055.234752698484, 8125.837483250302, 8470.0, 8575.656973720981, 8720.651173953098, 521.947805219475, 560.2129008742723, 578.3435800366614, 584.2521572387351, 593.7209511529575, 3547.94678079829, 3666.3767159582935, 3779.281936432069, 4019.457373254632, 4118.135191609736, 68649.0, 85856.57071714726, 89264.5536772312, 89590.0, 91151.54424227837, 87265.0, 87955.08404243649, 89651.55174224217, 90683.0, 92654.07345926455, 72940.0, 74324.25675743281, 75563.62218188983, 76617.23382766101, 78962.60518697485, 6696.497762667722, 7628.578705299063, 7813.960930195312, 7885.723999659985, 7908.881366779618, 52981.73509132584, 53909.730451347496, 53919.73040134774, 54021.0, 55530.0, 46910.29634555416, 71855.28144718695, 75483.0, 76038.0, 76845.0, 9732.221422286058, 10170.440625765654, 10526.947365263124, 10683.57265709363, 10721.839172412265, 11034.889651103385, 11050.723731906766, 11214.943925280648, 11385.886141138482, 12007.279563226235, 8180.304674102768, 10599.682009539727, 10627.681169564925, 10705.304155229886, 10832.404217767784, 10554.261201716114, 10574.387149203169, 10665.520051597541, 10698.14414846826, 10742.355458672504, 10387.117095046704, 10394.688159355232, 10454.477276136011, 10492.895071049192, 10678.73303167427, 8973.327000475121, 9178.495182765013, 9217.953910230406, 9294.442333460014, 9592.0, 8925.866112008196, 8984.371094023356, 9040.502772347583, 9103.317251206054, 9359.953200234228], "unit": "score", "name": "yui.html", "value": 7076.839838114632}], "name": "dromaeo_css", "value": 7832.893599543402}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 109.0, 116.0, 112.0, 112.0, 113.0, 120.0, 111.0, 112.0, 109.0], "unit": "score", "name": "ai-astar", "value": 112.5}, {"lowerIsBetter": true, "replicates": [156.0, 117.0, 156.0, 150.0, 118.0, 139.0, 116.0, 150.0, 150.0, 119.0], "unit": "score", "name": "audio-beat-detection", "value": 137.1}, {"lowerIsBetter": true, "replicates": [183.0, 182.0, 184.0, 182.0, 185.0, 184.0, 181.0, 185.0, 182.0, 183.0], "unit": "score", "name": "audio-dft", "value": 183.1}, {"lowerIsBetter": true, "replicates": [74.0, 76.0, 74.0, 118.0, 56.0, 58.0, 62.0, 80.0, 163.0, 55.0], "unit": "score", "name": "audio-fft", "value": 81.6}, {"lowerIsBetter": true, "replicates": [90.0, 89.0, 135.0, 81.0, 78.0, 83.0, 119.0, 105.0, 117.0, 154.0], "unit": "score", "name": "audio-oscillator", "value": 105.1}, {"lowerIsBetter": true, "replicates": [90.0, 87.0, 87.0, 78.0, 135.0, 131.0, 87.0, 85.0, 136.0, 70.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 98.6}, {"lowerIsBetter": true, "replicates": [92.0, 92.0, 93.0, 93.0, 92.0, 93.0, 102.0, 150.0, 129.0, 92.0], "unit": "score", "name": "imaging-darkroom", "value": 102.8}, {"lowerIsBetter": true, "replicates": [84.0, 105.0, 143.0, 83.0, 87.0, 85.0, 84.0, 86.0, 85.0, 86.0], "unit": "score", "name": "imaging-desaturate", "value": 92.8}, {"lowerIsBetter": true, "replicates": [55.0, 58.0, 58.0, 57.0, 57.0, 58.0, 58.0, 58.0, 53.0, 54.0], "unit": "score", "name": "json-parse-financial", "value": 56.6}, {"lowerIsBetter": true, "replicates": [63.0, 60.0, 78.0, 73.0, 69.0, 67.0, 67.0, 67.0, 67.0, 64.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.5}, {"lowerIsBetter": true, "replicates": [79.0, 82.0, 81.0, 82.0, 80.0, 79.0, 80.0, 80.0, 79.0, 100.0], "unit": "score", "name": "stanford-crypto-aes", "value": 82.2}, {"lowerIsBetter": true, "replicates": [129.0, 123.0, 129.0, 124.0, 124.0, 129.0, 128.0, 113.0, 130.0, 131.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 126.0}, {"lowerIsBetter": true, "replicates": [135.0, 127.0, 136.0, 135.0, 134.0, 134.0, 134.0, 134.0, 126.0, 123.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 131.8}, {"lowerIsBetter": true, "replicates": [66.0, 66.0, 66.0, 67.0, 92.0, 92.0, 63.0, 53.0, 94.0, 94.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 75.3}], "name": "kraken", "value": 1452.9999999999998}]} 18:15:42 INFO - Return code: 0 18:15:42 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 18:15:42 INFO - # TBPL SUCCESS # 18:15:42 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 18:15:42 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 18:15:42 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 18:15:42 INFO - 2016-04-29 18:15:42.475 screenresolution[6291:104576] starting screenresolution argv=screenresolution get 18:15:42 INFO - 2016-04-29 18:15:42.478 screenresolution[6291:104576] Display 0: 1600x1200x32@60 18:15:42 INFO - 2016-04-29 18:15:42.484 screenresolution[6292:104579] starting screenresolution argv=screenresolution list 18:15:42 INFO - Available Modes on Display 0 18:15:42 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 18:15:42 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 18:15:42 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 18:15:42 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 18:15:42 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 18:15:42 INFO - Intel Iris: 18:15:42 INFO - Chipset Model: Intel Iris 18:15:42 INFO - Type: GPU 18:15:42 INFO - Bus: Built-In 18:15:42 INFO - VRAM (Dynamic, Max): 1536 MB 18:15:42 INFO - Vendor: Intel (0x8086) 18:15:42 INFO - Device ID: 0x0a2e 18:15:42 INFO - Revision ID: 0x0009 18:15:42 INFO - Displays: 18:15:42 INFO - Display: 18:15:42 INFO - Resolution: 1600 x 1200 @ 60 Hz 18:15:42 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 18:15:42 INFO - Display Serial Number: 1600x1200 60 18:15:42 INFO - Main Display: Yes 18:15:42 INFO - Mirror: Off 18:15:42 INFO - Online: Yes 18:15:42 INFO - Rotation: Supported 18:15:42 INFO - Return code: 0 18:15:42 INFO - Running post-action listener: _resource_record_post_action 18:15:42 INFO - Running post-run listener: _resource_record_post_run 18:15:43 INFO - Total resource usage - Wall time: 1192s; CPU: 53.0%; Read bytes: 1601024; Write bytes: 505521152; Read time: 24; Write time: 1724 18:15:43 INFO - install - Wall time: 23s; CPU: 54.0%; Read bytes: 196731392; Write bytes: 197032960; Read time: 18305; Write time: 343 18:15:43 INFO - run-tests - Wall time: 1170s; CPU: 53.0%; Read bytes: 1601024; Write bytes: 298530816; Read time: 24; Write time: 1352 18:15:43 INFO - Running post-run listener: _upload_blobber_files 18:15:43 INFO - Blob upload gear active. 18:15:43 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:15: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 18:15: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-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 18:15: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-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 18:15:44 INFO - (blobuploader) - INFO - Open directory for files ... 18:15:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 18:15:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:15:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:15:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 18:15:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:15:45 INFO - (blobuploader) - INFO - Done attempting. 18:15:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 18:15:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:15:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:15:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 18:15:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:15:47 INFO - (blobuploader) - INFO - Done attempting. 18:15:47 INFO - (blobuploader) - INFO - Iteration through files over. 18:15:47 INFO - Return code: 0 18:15:47 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:15:47 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:15:47 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/255d31f78f446fdad655e8d84cf70b16a92b644119cf4c4179eeab2076e1742cdaf1afd1f17f0fd1d48fd0c76fcf14acf4a3f914424355a172c919f860ff9bda", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0fceeef7f2b8d6586a1a2c6b9e84d214056f641af3ae95b5f3fee21de6d80a7de14efd269da3cea73d2ff1a1145573a7b69b5793aabb29baab91434a1c003665"} 18:15:47 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:15:47 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:15:47 INFO - Contents: 18:15:47 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/255d31f78f446fdad655e8d84cf70b16a92b644119cf4c4179eeab2076e1742cdaf1afd1f17f0fd1d48fd0c76fcf14acf4a3f914424355a172c919f860ff9bda", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0fceeef7f2b8d6586a1a2c6b9e84d214056f641af3ae95b5f3fee21de6d80a7de14efd269da3cea73d2ff1a1145573a7b69b5793aabb29baab91434a1c003665"} 18:15:47 INFO - Running post-run listener: copy_logs_to_upload_dir 18:15:47 INFO - Copying logs to upload dir... 18:15:47 INFO - mkdir: /builds/slave/test/build/upload/logs 18:15:47 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1247.708902 ========= master_lag: 1.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-04-29 18:15:48.129819) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-29 18:15:48.135528) ========= 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.SiXXJTN09E/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.didN9QTR83/Listeners TMPDIR=/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/255d31f78f446fdad655e8d84cf70b16a92b644119cf4c4179eeab2076e1742cdaf1afd1f17f0fd1d48fd0c76fcf14acf4a3f914424355a172c919f860ff9bda", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0fceeef7f2b8d6586a1a2c6b9e84d214056f641af3ae95b5f3fee21de6d80a7de14efd269da3cea73d2ff1a1145573a7b69b5793aabb29baab91434a1c003665"} build_url:https://queue.taskcluster.net/v1/task/EvtvSMdoRB-BeTMT9KgmUg/artifacts/public/build/firefox-47.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010538 build_url: 'https://queue.taskcluster.net/v1/task/EvtvSMdoRB-BeTMT9KgmUg/artifacts/public/build/firefox-47.0.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/255d31f78f446fdad655e8d84cf70b16a92b644119cf4c4179eeab2076e1742cdaf1afd1f17f0fd1d48fd0c76fcf14acf4a3f914424355a172c919f860ff9bda", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0fceeef7f2b8d6586a1a2c6b9e84d214056f641af3ae95b5f3fee21de6d80a7de14efd269da3cea73d2ff1a1145573a7b69b5793aabb29baab91434a1c003665"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-29 18:15:48.171928) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 18:15:48.172267) ========= 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.SiXXJTN09E/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.didN9QTR83/Listeners TMPDIR=/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/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.004399 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 18:15:48.223321) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-29 18:15:48.223627) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-29 18:15:48.224759) ========= ========= Total master_lag: 1.19 =========