builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0099 starttime: 1465427627.08 results: success (0) buildid: 20160608141429 builduid: 8dc57391f080448fabb9bf7ba70ae880 revision: ec56d351f9a0677f9ef34a6f6cefbf7addf86145 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-08 16:13:47.076061) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-08 16:13:47.076515) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-08 16:13:47.076816) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-08 16:13:47.107531) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-06-08 16:13:47.107979) ========= 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.7HaBMoVrRl/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.X1g0tiZCmP/Listeners TMPDIR=/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/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-06-08 16:13:47-- 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% 12.6M=0.001s 2016-06-08 16:13:47 (12.6 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.092111 ========= master_lag: 2.05 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-06-08 16:13:49.251747) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 16:13:49.252064) ========= 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.7HaBMoVrRl/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.X1g0tiZCmP/Listeners TMPDIR=/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/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.029543 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 16:13:49.318423) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-08 16:13:49.318834) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev ec56d351f9a0677f9ef34a6f6cefbf7addf86145 --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 ec56d351f9a0677f9ef34a6f6cefbf7addf86145 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.7HaBMoVrRl/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.X1g0tiZCmP/Listeners TMPDIR=/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/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-06-08 16:13:49,392 truncating revision to first 12 chars 2016-06-08 16:13:49,392 Setting DEBUG logging. 2016-06-08 16:13:49,392 attempt 1/10 2016-06-08 16:13:49,392 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/ec56d351f9a0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-08 16:13:50,467 unpacking tar archive at: mozilla-beta-ec56d351f9a0/testing/mozharness/ program finished with exit code 0 elapsedTime=1.345641 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-08 16:13:50.687442) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-08 16:13:50.687970) ========= script_repo_revision: ec56d351f9a0677f9ef34a6f6cefbf7addf86145 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-08 16:13:50.688571) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-08 16:13:50.689018) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-08 16:13:50.707577) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2016-06-08 16:13:50.708181) ========= /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.7HaBMoVrRl/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.X1g0tiZCmP/Listeners TMPDIR=/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/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 16:13:50 INFO - MultiFileLogger online at 20160608 16:13:50 in /builds/slave/test 16:13:50 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 16:13:50 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:13:50 INFO - {'append_to_log': False, 16:13:50 INFO - 'base_work_dir': '/builds/slave/test', 16:13:50 INFO - 'blob_upload_branch': 'Mozilla-Beta', 16:13:50 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:13:50 INFO - 'branch': 'Mozilla-Beta', 16:13:50 INFO - 'buildbot_json_path': 'buildprops.json', 16:13:50 INFO - 'config_files': ('talos/mac_config.py',), 16:13:50 INFO - 'default_actions': ('clobber', 16:13:50 INFO - 'read-buildbot-config', 16:13:50 INFO - 'download-and-extract', 16:13:50 INFO - 'populate-webroot', 16:13:50 INFO - 'create-virtualenv', 16:13:50 INFO - 'install', 16:13:50 INFO - 'run-tests'), 16:13:50 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:13:50 INFO - 'download_minidump_stackwalk': True, 16:13:50 INFO - 'download_symbols': 'ondemand', 16:13:50 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:13:50 INFO - 'tooltool.py': '/tools/tooltool.py', 16:13:50 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:13:50 INFO - '/tools/misc-python/virtualenv.py')}, 16:13:50 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:13:50 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:13:50 INFO - 'installer_path': 'installer.exe', 16:13:50 INFO - 'log_level': 'info', 16:13:50 INFO - 'log_name': 'talos', 16:13:50 INFO - 'log_to_console': True, 16:13:50 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 16:13:50 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 16:13:50 INFO - 'opt_config_files': (), 16:13:50 INFO - 'pip_index': False, 16:13:50 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 16:13:50 INFO - 'cmd': ('bash', 16:13:50 INFO - '-c', 16:13:50 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 16:13:50 INFO - 'enabled': True, 16:13:50 INFO - 'halt_on_failure': False, 16:13:50 INFO - 'name': 'check_screen_resolution'},), 16:13:50 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 16:13:50 INFO - 'cmd': ('bash', 16:13:50 INFO - '-c', 16:13:50 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 16:13:50 INFO - 'enabled': True, 16:13:50 INFO - 'halt_on_failure': False, 16:13:50 INFO - 'name': 'check_screen_resolution'},), 16:13:50 INFO - 'run_cmd_checks_enabled': True, 16:13:50 INFO - 'sps_profile': False, 16:13:50 INFO - 'sps_profile_interval': 0, 16:13:50 INFO - 'suite': 'dromaeojs', 16:13:50 INFO - 'system_bits': '32', 16:13:50 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:13:50 INFO - 'title': 't-yosemite-r7-0099', 16:13:50 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:13:50 INFO - 'use_talos_json': True, 16:13:50 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:13:50 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:13:50 INFO - 'work_dir': 'build'} 16:13:50 INFO - ##### 16:13:50 INFO - ##### Running clobber step. 16:13:50 INFO - ##### 16:13:50 INFO - Running pre-action listener: _resource_record_pre_action 16:13:50 INFO - Running main action method: clobber 16:13:50 INFO - rmtree: /builds/slave/test/build 16:13:50 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:13:52 INFO - Running post-action listener: _resource_record_post_action 16:13:52 INFO - ##### 16:13:52 INFO - ##### Running read-buildbot-config step. 16:13:52 INFO - ##### 16:13:52 INFO - Running pre-action listener: _resource_record_pre_action 16:13:52 INFO - Running main action method: read_buildbot_config 16:13:52 INFO - Using buildbot properties: 16:13:52 INFO - { 16:13:52 INFO - "project": "", 16:13:52 INFO - "product": "firefox", 16:13:52 INFO - "script_repo_revision": "production", 16:13:52 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 16:13:52 INFO - "repository": "", 16:13:52 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 16:13:52 INFO - "buildid": "20160608141429", 16:13:52 INFO - "pgo_build": "False", 16:13:52 INFO - "basedir": "/builds/slave/test", 16:13:52 INFO - "buildnumber": 1, 16:13:52 INFO - "slavename": "t-yosemite-r7-0099", 16:13:52 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 16:13:52 INFO - "platform": "yosemite_r7", 16:13:52 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 16:13:52 INFO - "branch": "mozilla-beta", 16:13:52 INFO - "repo_path": "releases/mozilla-beta", 16:13:52 INFO - "revision": "ec56d351f9a0677f9ef34a6f6cefbf7addf86145", 16:13:52 INFO - "stage_platform": "macosx64", 16:13:52 INFO - "builduid": "8dc57391f080448fabb9bf7ba70ae880", 16:13:52 INFO - "slavebuilddir": "test" 16:13:52 INFO - } 16:13:52 INFO - Found installer url https://queue.taskcluster.net/v1/task/SrroKRRKShivdQ8FW3uzGA/artifacts/public/build/firefox-48.0.en-US.mac.dmg. 16:13:52 INFO - Running post-action listener: _resource_record_post_action 16:13:52 INFO - ##### 16:13:52 INFO - ##### Running download-and-extract step. 16:13:52 INFO - ##### 16:13:52 INFO - Running pre-action listener: _resource_record_pre_action 16:13:52 INFO - Running main action method: download_and_extract 16:13:52 INFO - mkdir: /builds/slave/test/build/tests 16:13:52 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')]} 16:13:52 INFO - https://queue.taskcluster.net/v1/task/SrroKRRKShivdQ8FW3uzGA/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json matches https://queue.taskcluster.net 16:13:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SrroKRRKShivdQ8FW3uzGA/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json 16:13:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SrroKRRKShivdQ8FW3uzGA/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json 16:13:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SrroKRRKShivdQ8FW3uzGA/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json 16:13:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SrroKRRKShivdQ8FW3uzGA/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json'}, attempt #1 16:13:54 INFO - Downloaded 1165 bytes. 16:13:54 INFO - Reading from file /builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json 16:13:54 INFO - Using the following test package requirements: 16:13:54 INFO - {u'common': [u'firefox-48.0.en-US.mac.common.tests.zip'], 16:13:54 INFO - u'cppunittest': [u'firefox-48.0.en-US.mac.common.tests.zip', 16:13:54 INFO - u'firefox-48.0.en-US.mac.cppunittest.tests.zip'], 16:13:54 INFO - u'gtest': [u'firefox-48.0.en-US.mac.common.tests.zip', 16:13:54 INFO - u'firefox-48.0.en-US.mac.gtest.tests.zip'], 16:13:54 INFO - u'jittest': [u'firefox-48.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 16:13:54 INFO - u'mochitest': [u'firefox-48.0.en-US.mac.common.tests.zip', 16:13:54 INFO - u'firefox-48.0.en-US.mac.mochitest.tests.zip'], 16:13:54 INFO - u'mozbase': [u'firefox-48.0.en-US.mac.common.tests.zip'], 16:13:54 INFO - u'reftest': [u'firefox-48.0.en-US.mac.common.tests.zip', 16:13:54 INFO - u'firefox-48.0.en-US.mac.reftest.tests.zip'], 16:13:54 INFO - u'talos': [u'firefox-48.0.en-US.mac.common.tests.zip', 16:13:54 INFO - u'firefox-48.0.en-US.mac.talos.tests.zip'], 16:13:54 INFO - u'web-platform': [u'firefox-48.0.en-US.mac.common.tests.zip', 16:13:54 INFO - u'firefox-48.0.en-US.mac.web-platform.tests.zip'], 16:13:54 INFO - u'xpcshell': [u'firefox-48.0.en-US.mac.common.tests.zip', 16:13:54 INFO - u'firefox-48.0.en-US.mac.xpcshell.tests.zip']} 16:13:54 INFO - Downloading packages: [u'firefox-48.0.en-US.mac.common.tests.zip'] for test suite category: common 16:13:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:13:54 INFO - https://queue.taskcluster.net/v1/task/SrroKRRKShivdQ8FW3uzGA/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 16:13:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SrroKRRKShivdQ8FW3uzGA/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 16:13:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SrroKRRKShivdQ8FW3uzGA/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 16:13:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SrroKRRKShivdQ8FW3uzGA/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip 16:13:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SrroKRRKShivdQ8FW3uzGA/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip'}, attempt #1 16:13:57 INFO - Downloaded 18292399 bytes. 16:13:57 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 16:13:57 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 16:14:00 INFO - Return code: 0 16:14:00 INFO - Downloading packages: [u'firefox-48.0.en-US.mac.common.tests.zip', u'firefox-48.0.en-US.mac.talos.tests.zip'] for test suite category: talos 16:14: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')]} 16:14:00 INFO - https://queue.taskcluster.net/v1/task/SrroKRRKShivdQ8FW3uzGA/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 16:14:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SrroKRRKShivdQ8FW3uzGA/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 16:14:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SrroKRRKShivdQ8FW3uzGA/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 16:14:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SrroKRRKShivdQ8FW3uzGA/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip 16:14:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SrroKRRKShivdQ8FW3uzGA/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip'}, attempt #1 16:14:02 INFO - Downloaded 18292399 bytes. 16:14:02 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 16:14:02 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 16:14:05 INFO - Return code: 0 16:14: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')]} 16:14:05 INFO - https://queue.taskcluster.net/v1/task/SrroKRRKShivdQ8FW3uzGA/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 16:14:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SrroKRRKShivdQ8FW3uzGA/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip 16:14:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SrroKRRKShivdQ8FW3uzGA/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip 16:14:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SrroKRRKShivdQ8FW3uzGA/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip 16:14:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SrroKRRKShivdQ8FW3uzGA/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip'}, attempt #1 16:14:07 INFO - Downloaded 10840145 bytes. 16:14:07 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 16:14:07 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 16:14:07 INFO - Return code: 0 16:14:07 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')]} 16:14:07 INFO - https://queue.taskcluster.net/v1/task/SrroKRRKShivdQ8FW3uzGA/artifacts/public/build/firefox-48.0.en-US.mac.dmg matches https://queue.taskcluster.net 16:14:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SrroKRRKShivdQ8FW3uzGA/artifacts/public/build/firefox-48.0.en-US.mac.dmg 16:14:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SrroKRRKShivdQ8FW3uzGA/artifacts/public/build/firefox-48.0.en-US.mac.dmg 16:14:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SrroKRRKShivdQ8FW3uzGA/artifacts/public/build/firefox-48.0.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0.en-US.mac.dmg 16:14:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SrroKRRKShivdQ8FW3uzGA/artifacts/public/build/firefox-48.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.mac.dmg'}, attempt #1 16:14:10 INFO - Downloaded 86250356 bytes. 16:14:10 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/SrroKRRKShivdQ8FW3uzGA/artifacts/public/build/firefox-48.0.en-US.mac.dmg 16:14:10 INFO - mkdir: /builds/slave/test/properties 16:14:10 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:14:10 INFO - Writing to file /builds/slave/test/properties/build_url 16:14:10 INFO - Contents: 16:14:10 INFO - build_url:https://queue.taskcluster.net/v1/task/SrroKRRKShivdQ8FW3uzGA/artifacts/public/build/firefox-48.0.en-US.mac.dmg 16:14:11 INFO - Running post-action listener: _resource_record_post_action 16:14:11 INFO - Running post-action listener: set_extra_try_arguments 16:14:11 INFO - ##### 16:14:11 INFO - ##### Running populate-webroot step. 16:14:11 INFO - ##### 16:14:11 INFO - Running pre-action listener: _resource_record_pre_action 16:14:11 INFO - Running main action method: populate_webroot 16:14:11 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:14:11 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:14:11 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:14:11 INFO - '--tppagecycles', 16:14:11 INFO - '7'], 16:14:11 INFO - 'tests': ['tsvgm']}}, 16:14:11 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 16:14:11 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:14:11 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:14:11 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 16:14:11 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:14:11 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:14:11 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:14:11 INFO - 'talos_options': ['--disable-e10s'], 16:14:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:14:11 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:14:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:14:11 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:14:11 INFO - 'talos_options': ['--disable-e10s'], 16:14:11 INFO - 'tests': ['damp', 'tps']}, 16:14:11 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:14:11 INFO - 'tests': ['damp', 'tps']}, 16:14:11 INFO - 'g3': {'talos_options': ['--disable-e10s'], 16:14:11 INFO - 'tests': ['dromaeo_dom']}, 16:14:11 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:14:11 INFO - 'other': {'talos_options': ['--disable-e10s'], 16:14:11 INFO - 'tests': ['a11yr', 16:14:11 INFO - 'ts_paint', 16:14:11 INFO - 'tpaint', 16:14:11 INFO - 'sessionrestore', 16:14:11 INFO - 'sessionrestore_no_auto_restore', 16:14:11 INFO - 'tabpaint']}, 16:14:11 INFO - 'other-e10s': {'tests': ['a11yr', 16:14:11 INFO - 'ts_paint', 16:14:11 INFO - 'tpaint', 16:14:11 INFO - 'sessionrestore', 16:14:11 INFO - 'sessionrestore_no_auto_restore', 16:14:11 INFO - 'tabpaint']}, 16:14:11 INFO - 'other-e10s_l64': {'tests': ['a11yr', 16:14:11 INFO - 'ts_paint', 16:14:11 INFO - 'tpaint', 16:14:11 INFO - 'sessionrestore', 16:14:11 INFO - 'sessionrestore_no_auto_restore', 16:14:11 INFO - 'tabpaint']}, 16:14:11 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 16:14:11 INFO - 'ts_paint', 16:14:11 INFO - 'tpaint', 16:14:11 INFO - 'sessionrestore', 16:14:11 INFO - 'sessionrestore_no_auto_restore', 16:14:11 INFO - 'tabpaint']}, 16:14:11 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 16:14:11 INFO - 'tests': ['a11yr', 16:14:11 INFO - 'ts_paint', 16:14:11 INFO - 'tpaint', 16:14:11 INFO - 'sessionrestore', 16:14:11 INFO - 'sessionrestore_no_auto_restore', 16:14:11 INFO - 'tabpaint']}, 16:14:11 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 16:14:11 INFO - 'tests': ['a11yr', 16:14:11 INFO - 'ts_paint', 16:14:11 INFO - 'tpaint', 16:14:11 INFO - 'sessionrestore', 16:14:11 INFO - 'sessionrestore_no_auto_restore', 16:14:11 INFO - 'tabpaint']}, 16:14:11 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 16:14:11 INFO - 'tests': ['tsvgx', 16:14:11 INFO - 'tsvgr_opacity', 16:14:11 INFO - 'tart', 16:14:11 INFO - 'tscrollx', 16:14:11 INFO - 'cart']}, 16:14:11 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:14:11 INFO - 'tsvgr_opacity', 16:14:11 INFO - 'tart', 16:14:11 INFO - 'tscrollx', 16:14:11 INFO - 'cart']}, 16:14:11 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:14:11 INFO - 'talos_options': ['--disable-e10s'], 16:14:11 INFO - 'tests': ['tp5o']}, 16:14:11 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:14:11 INFO - 'tests': ['tp5o']}, 16:14:11 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:14:11 INFO - 'talos_options': ['--disable-e10s', 16:14:11 INFO - '--xperf_path', 16:14:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:14:11 INFO - 'tests': ['tp5n']}, 16:14:11 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:14:11 INFO - 'talos_options': ['--xperf_path', 16:14:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:14:11 INFO - 'tests': ['tp5n']}}, 16:14:11 INFO - 'talos.zip': {'path': '', 16:14:11 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:14:11 INFO - Running post-action listener: _resource_record_post_action 16:14:11 INFO - ##### 16:14:11 INFO - ##### Running create-virtualenv step. 16:14:11 INFO - ##### 16:14:11 INFO - Running pre-action listener: _resource_record_pre_action 16:14:11 INFO - Running main action method: create_virtualenv 16:14:11 INFO - Creating virtualenv /builds/slave/test/build/venv 16:14:11 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 16:14:11 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:14:11 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:14:11 INFO - Using real prefix '/tools/python27' 16:14:11 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:14:12 INFO - Installing distribute.............................................................................................................................................................................................done. 16:14:15 INFO - Installing pip.................done. 16:14:15 INFO - Return code: 0 16:14:15 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:14:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:14:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:14:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:14:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:14:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:14:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:14:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c702a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c712420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f94e0582770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c5a1e00>, '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 0x10c40adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c59cb20>, '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.7HaBMoVrRl/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.X1g0tiZCmP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/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 16:14:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 16:14:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 16:14:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7HaBMoVrRl/Render', 16:14:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:14:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:14:15 INFO - 'HOME': '/Users/cltbld', 16:14:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:14:15 INFO - 'LOGNAME': 'cltbld', 16:14:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:14:15 INFO - 'MOZ_NO_REMOTE': '1', 16:14:15 INFO - 'NO_EM_RESTART': '1', 16:14:15 INFO - 'PAGER': '/bin/cat', 16:14:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:14:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:14:15 INFO - 'PWD': '/builds/slave/test', 16:14:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:14:15 INFO - 'SHELL': '/bin/bash', 16:14:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.X1g0tiZCmP/Listeners', 16:14:15 INFO - 'TMPDIR': '/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/', 16:14:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:14:15 INFO - 'USER': 'cltbld', 16:14:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:14:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:14:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:14:15 INFO - 'XPC_FLAGS': '0x0', 16:14:15 INFO - 'XPC_SERVICE_NAME': '0', 16:14:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:14:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:14:16 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 16:14:16 INFO - Cleaning up... 16:14:16 INFO - Return code: 0 16:14:16 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 16:14:16 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')]} 16:14:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:14:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:14:16 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')]} 16:14:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:14:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:14:16 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 0x10c702a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c712420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f94e0582770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c5a1e00>, '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 0x10c40adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c59cb20>, '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.7HaBMoVrRl/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.X1g0tiZCmP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/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 16:14:16 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 16:14:16 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 16:14:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7HaBMoVrRl/Render', 16:14:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:14:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:14:16 INFO - 'HOME': '/Users/cltbld', 16:14:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:14:16 INFO - 'LOGNAME': 'cltbld', 16:14:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:14:16 INFO - 'MOZ_NO_REMOTE': '1', 16:14:16 INFO - 'NO_EM_RESTART': '1', 16:14:16 INFO - 'PAGER': '/bin/cat', 16:14:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:14:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:14:16 INFO - 'PWD': '/builds/slave/test', 16:14:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:14:16 INFO - 'SHELL': '/bin/bash', 16:14:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.X1g0tiZCmP/Listeners', 16:14:16 INFO - 'TMPDIR': '/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/', 16:14:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:14:16 INFO - 'USER': 'cltbld', 16:14:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:14:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:14:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:14:16 INFO - 'XPC_FLAGS': '0x0', 16:14:16 INFO - 'XPC_SERVICE_NAME': '0', 16:14:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:14:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:14:16 INFO - Downloading/unpacking psutil>=0.7.1 16:14:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:14:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:14:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:14:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:14:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:14:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:14:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:14:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:14:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:14:18 INFO - Installing collected packages: psutil 16:14:18 INFO - Running setup.py install for psutil 16:14:18 INFO - building 'psutil._psutil_osx' extension 16:14:18 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 16:14:19 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 16:14:19 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 16:14:19 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 16:14:19 INFO - building 'psutil._psutil_posix' extension 16:14:19 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 16:14:19 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 16:14:19 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 16:14:19 INFO - ^ 16:14:19 INFO - 1 warning generated. 16:14:19 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 16:14:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:14:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:14:20 INFO - Successfully installed psutil 16:14:20 INFO - Cleaning up... 16:14:20 INFO - Return code: 0 16:14:20 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 16:14:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:14:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:14:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:14:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:14:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:14:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:14:20 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 0x10c702a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c712420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f94e0582770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c5a1e00>, '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 0x10c40adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c59cb20>, '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.7HaBMoVrRl/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.X1g0tiZCmP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/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 16:14:20 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 16:14:20 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 16:14:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7HaBMoVrRl/Render', 16:14:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:14:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:14:20 INFO - 'HOME': '/Users/cltbld', 16:14:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:14:20 INFO - 'LOGNAME': 'cltbld', 16:14:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:14:20 INFO - 'MOZ_NO_REMOTE': '1', 16:14:20 INFO - 'NO_EM_RESTART': '1', 16:14:20 INFO - 'PAGER': '/bin/cat', 16:14:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:14:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:14:20 INFO - 'PWD': '/builds/slave/test', 16:14:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:14:20 INFO - 'SHELL': '/bin/bash', 16:14:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.X1g0tiZCmP/Listeners', 16:14:20 INFO - 'TMPDIR': '/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/', 16:14:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:14:20 INFO - 'USER': 'cltbld', 16:14:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:14:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:14:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:14:20 INFO - 'XPC_FLAGS': '0x0', 16:14:20 INFO - 'XPC_SERVICE_NAME': '0', 16:14:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:14:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:14:20 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 16:14: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 16:14: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 16:14: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 16:14: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 16:14: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 16:14: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 16:14:22 INFO - Downloading mozsystemmonitor-0.0.tar.gz 16:14:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:14:22 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 16:14:22 INFO - Installing collected packages: mozsystemmonitor 16:14:22 INFO - Running setup.py install for mozsystemmonitor 16:14:23 INFO - Successfully installed mozsystemmonitor 16:14:23 INFO - Cleaning up... 16:14:23 INFO - Return code: 0 16:14:23 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:14:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:14:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:14:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:14:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:14:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:14:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:14:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10c702a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c712420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f94e0582770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c5a1e00>, '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 0x10c40adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c59cb20>, '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.7HaBMoVrRl/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.X1g0tiZCmP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/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 16:14:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 16:14:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 16:14:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7HaBMoVrRl/Render', 16:14:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:14:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:14:23 INFO - 'HOME': '/Users/cltbld', 16:14:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:14:23 INFO - 'LOGNAME': 'cltbld', 16:14:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:14:23 INFO - 'MOZ_NO_REMOTE': '1', 16:14:23 INFO - 'NO_EM_RESTART': '1', 16:14:23 INFO - 'PAGER': '/bin/cat', 16:14:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:14:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:14:23 INFO - 'PWD': '/builds/slave/test', 16:14:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:14:23 INFO - 'SHELL': '/bin/bash', 16:14:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.X1g0tiZCmP/Listeners', 16:14:23 INFO - 'TMPDIR': '/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/', 16:14:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:14:23 INFO - 'USER': 'cltbld', 16:14:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:14:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:14:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:14:23 INFO - 'XPC_FLAGS': '0x0', 16:14:23 INFO - 'XPC_SERVICE_NAME': '0', 16:14:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:14:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:14:23 INFO - Downloading/unpacking blobuploader==1.2.4 16:14:23 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 16:14:23 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 16:14:23 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 16:14:23 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 16:14:23 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 16:14:23 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 16:14:25 INFO - Downloading blobuploader-1.2.4.tar.gz 16:14:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:14:25 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:14:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:14:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:14:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:14:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:14:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:14:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:14:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:14:26 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:14:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:14:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:14:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:14:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:14:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:14:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:14:26 INFO - Downloading docopt-0.6.1.tar.gz 16:14:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:14:27 INFO - Installing collected packages: blobuploader, requests, docopt 16:14:27 INFO - Running setup.py install for blobuploader 16:14:27 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:14:27 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:14:27 INFO - Running setup.py install for requests 16:14:27 INFO - Running setup.py install for docopt 16:14:27 INFO - Successfully installed blobuploader requests docopt 16:14:27 INFO - Cleaning up... 16:14:27 INFO - Return code: 0 16:14:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:14: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')]} 16:14:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:14:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:14: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')]} 16:14:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:14:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:14:27 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 0x10c702a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c712420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f94e0582770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c5a1e00>, '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 0x10c40adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c59cb20>, '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.7HaBMoVrRl/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.X1g0tiZCmP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/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 16:14:27 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 16:14:27 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 16:14:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7HaBMoVrRl/Render', 16:14:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:14:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:14:27 INFO - 'HOME': '/Users/cltbld', 16:14:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:14:27 INFO - 'LOGNAME': 'cltbld', 16:14:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:14:27 INFO - 'MOZ_NO_REMOTE': '1', 16:14:27 INFO - 'NO_EM_RESTART': '1', 16:14:27 INFO - 'PAGER': '/bin/cat', 16:14:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:14:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:14:27 INFO - 'PWD': '/builds/slave/test', 16:14:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:14:27 INFO - 'SHELL': '/bin/bash', 16:14:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.X1g0tiZCmP/Listeners', 16:14:27 INFO - 'TMPDIR': '/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/', 16:14:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:14:27 INFO - 'USER': 'cltbld', 16:14:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:14:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:14:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:14:27 INFO - 'XPC_FLAGS': '0x0', 16:14:27 INFO - 'XPC_SERVICE_NAME': '0', 16:14:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:14:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:14:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:14:28 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-QiA0xn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:14:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:14:28 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-PnkS1i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:14:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:14:28 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-NKvcdt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:14:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:14:28 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-P1rJlP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:14:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:14:28 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-sy4y_W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:14:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:14:28 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-bmiM_z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:14:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:14:28 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-WXvfAj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:14:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:14:28 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-vepdeJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:14:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:14:29 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-CIjPHG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:14:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:14:29 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-OXwo4n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:14:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:14:29 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-xTyMN9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:14:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:14:29 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-Igcnpd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:14:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:14:29 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-KM23q9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:14:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:14:29 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-IOXkNJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:14:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:14:29 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-5WZufL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:14:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:14:29 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-1BIAvV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:14:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:14:29 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-8sGsq4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:14:29 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:14:29 INFO - Running setup.py install for manifestparser 16:14:30 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:14:30 INFO - Running setup.py install for mozcrash 16:14:30 INFO - Running setup.py install for mozdebug 16:14:30 INFO - Running setup.py install for mozdevice 16:14:30 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:14:30 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:14:30 INFO - Running setup.py install for mozfile 16:14:30 INFO - Running setup.py install for mozhttpd 16:14:30 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:14:30 INFO - Running setup.py install for mozinfo 16:14:31 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:14:31 INFO - Running setup.py install for mozInstall 16:14:31 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:14:31 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:14:31 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:14:31 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:14:31 INFO - Running setup.py install for mozleak 16:14:31 INFO - Running setup.py install for mozlog 16:14:31 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:14:31 INFO - Running setup.py install for moznetwork 16:14:31 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:14:31 INFO - Running setup.py install for mozprocess 16:14:31 INFO - Running setup.py install for mozprofile 16:14:31 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:14:31 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:14:31 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:14:31 INFO - Running setup.py install for mozrunner 16:14:32 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:14:32 INFO - Running setup.py install for mozscreenshot 16:14:32 INFO - Running setup.py install for moztest 16:14:32 INFO - Running setup.py install for mozversion 16:14:32 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:14:32 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:14:32 INFO - Cleaning up... 16:14:32 INFO - Return code: 0 16:14:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:14:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:14:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:14:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:14:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:14:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:14:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:14:32 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 0x10c702a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c712420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f94e0582770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c5a1e00>, '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 0x10c40adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c59cb20>, '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.7HaBMoVrRl/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.X1g0tiZCmP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/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 16:14:32 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 16:14:32 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 16:14:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7HaBMoVrRl/Render', 16:14:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:14:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:14:32 INFO - 'HOME': '/Users/cltbld', 16:14:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:14:32 INFO - 'LOGNAME': 'cltbld', 16:14:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:14:32 INFO - 'MOZ_NO_REMOTE': '1', 16:14:32 INFO - 'NO_EM_RESTART': '1', 16:14:32 INFO - 'PAGER': '/bin/cat', 16:14:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:14:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:14:32 INFO - 'PWD': '/builds/slave/test', 16:14:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:14:32 INFO - 'SHELL': '/bin/bash', 16:14:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.X1g0tiZCmP/Listeners', 16:14:32 INFO - 'TMPDIR': '/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/', 16:14:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:14:32 INFO - 'USER': 'cltbld', 16:14:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:14:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:14:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:14:32 INFO - 'XPC_FLAGS': '0x0', 16:14:32 INFO - 'XPC_SERVICE_NAME': '0', 16:14:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:14:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:14:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:14:32 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-B6ef_G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:14:32 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)) 16:14:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:14:32 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-5WDyUZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:14:33 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)) 16:14:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:14:33 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-v7I43b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:14:33 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)) 16:14:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:14:33 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-LZjdgu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:14:33 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)) 16:14:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:14:33 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-tztSDr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:14:33 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)) 16:14:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:14:33 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-m_7oAk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:14:33 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)) 16:14:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:14:33 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-lIHxeI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:14:33 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)) 16:14:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:14:33 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-FOZI5I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:14:33 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)) 16:14:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:14:33 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-MrSwJw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:14:33 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)) 16:14:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:14:33 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-7nl8Fi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:14:33 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)) 16:14:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:14:33 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-HRxwwM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:14:34 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)) 16:14:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:14:34 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-k0VMfn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:14:34 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)) 16:14:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:14:34 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-TRWYsc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:14:34 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)) 16:14:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:14:34 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-m5AL5l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:14:34 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)) 16:14:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:14:34 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-2Z4ulM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:14:34 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)) 16:14:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:14:34 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-O803fF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:14:34 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)) 16:14:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:14:34 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-H66mWz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:14:34 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)) 16:14:34 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)) 16:14:34 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)) 16:14:34 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)) 16:14:34 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)) 16:14:34 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)) 16:14:34 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:14:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:14:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:14:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:14:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:14:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:14:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:14:37 INFO - Downloading blessings-1.6.tar.gz 16:14:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:14:37 INFO - Installing collected packages: blessings 16:14:37 INFO - Running setup.py install for blessings 16:14:37 INFO - Successfully installed blessings 16:14:37 INFO - Cleaning up... 16:14:37 INFO - Return code: 0 16:14:37 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:14:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:14:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:14:37 INFO - Reading from file tmpfile_stdout 16:14:37 INFO - Current package versions: 16:14:37 INFO - blessings == 1.6 16:14:37 INFO - blobuploader == 1.2.4 16:14:37 INFO - docopt == 0.6.1 16:14:37 INFO - manifestparser == 1.1 16:14:37 INFO - mozInstall == 1.12 16:14:37 INFO - mozcrash == 0.17 16:14:37 INFO - mozdebug == 0.1 16:14:37 INFO - mozdevice == 0.48 16:14:37 INFO - mozfile == 1.2 16:14:37 INFO - mozhttpd == 0.7 16:14:37 INFO - mozinfo == 0.9 16:14:37 INFO - mozleak == 0.1 16:14:37 INFO - mozlog == 3.1 16:14:37 INFO - moznetwork == 0.27 16:14:37 INFO - mozprocess == 0.22 16:14:37 INFO - mozprofile == 0.28 16:14:37 INFO - mozrunner == 6.11 16:14:37 INFO - mozscreenshot == 0.1 16:14:37 INFO - mozsystemmonitor == 0.0 16:14:37 INFO - moztest == 0.7 16:14:37 INFO - mozversion == 1.4 16:14:37 INFO - psutil == 3.1.1 16:14:37 INFO - requests == 1.2.3 16:14:37 INFO - wsgiref == 0.1.2 16:14:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:14:37 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')]} 16:14:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:14:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:14:37 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')]} 16:14:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:14:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:14:37 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 0x10c702a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c712420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f94e0582770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c5a1e00>, '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 0x10c40adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c59cb20>, '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.7HaBMoVrRl/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.X1g0tiZCmP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/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 16:14:37 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 16:14:37 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 16:14:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7HaBMoVrRl/Render', 16:14:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:14:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:14:37 INFO - 'HOME': '/Users/cltbld', 16:14:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:14:37 INFO - 'LOGNAME': 'cltbld', 16:14:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:14:37 INFO - 'MOZ_NO_REMOTE': '1', 16:14:37 INFO - 'NO_EM_RESTART': '1', 16:14:37 INFO - 'PAGER': '/bin/cat', 16:14:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:14:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:14:37 INFO - 'PWD': '/builds/slave/test', 16:14:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:14:37 INFO - 'SHELL': '/bin/bash', 16:14:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.X1g0tiZCmP/Listeners', 16:14:37 INFO - 'TMPDIR': '/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/', 16:14:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:14:37 INFO - 'USER': 'cltbld', 16:14:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:14:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:14:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:14:37 INFO - 'XPC_FLAGS': '0x0', 16:14:37 INFO - 'XPC_SERVICE_NAME': '0', 16:14:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:14:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:14:37 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)) 16:14:37 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)) 16:14:37 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)) 16:14:37 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)) 16:14:37 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)) 16:14:37 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)) 16:14:37 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)) 16:14:37 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)) 16:14:37 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)) 16:14:37 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)) 16:14:37 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)) 16:14:37 INFO - Cleaning up... 16:14:37 INFO - Return code: 0 16:14:37 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:14:37 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')]} 16:14:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:14:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:14:37 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')]} 16:14:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:14:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:14:37 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 0x10c702a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c712420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f94e0582770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c5a1e00>, '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 0x10c40adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c59cb20>, '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.7HaBMoVrRl/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.X1g0tiZCmP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/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 16:14:37 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 16:14:37 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 16:14:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7HaBMoVrRl/Render', 16:14:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:14:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:14:37 INFO - 'HOME': '/Users/cltbld', 16:14:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:14:37 INFO - 'LOGNAME': 'cltbld', 16:14:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:14:37 INFO - 'MOZ_NO_REMOTE': '1', 16:14:37 INFO - 'NO_EM_RESTART': '1', 16:14:37 INFO - 'PAGER': '/bin/cat', 16:14:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:14:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:14:37 INFO - 'PWD': '/builds/slave/test', 16:14:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:14:37 INFO - 'SHELL': '/bin/bash', 16:14:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.X1g0tiZCmP/Listeners', 16:14:37 INFO - 'TMPDIR': '/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/', 16:14:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:14:37 INFO - 'USER': 'cltbld', 16:14:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:14:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:14:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:14:37 INFO - 'XPC_FLAGS': '0x0', 16:14:37 INFO - 'XPC_SERVICE_NAME': '0', 16:14:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:14:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:14:38 INFO - Downloading/unpacking jsonschema 16:14: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 16:14: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 16:14: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 16:14: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 16:14: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 16:14: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 16:14:40 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:14:40 INFO - Downloading/unpacking functools32 (from jsonschema) 16:14:40 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 16:14:40 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 16:14:40 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 16:14:40 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 16:14:40 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 16:14:40 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 16:14:41 INFO - Downloading functools32-3.2.3-2.tar.gz 16:14:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:14:41 INFO - warning: no files found matching '*.txt' 16:14:41 INFO - no previously-included directories found matching 'build' 16:14:41 INFO - no previously-included directories found matching 'dist' 16:14:41 INFO - no previously-included directories found matching '.git*' 16:14:41 INFO - Installing collected packages: jsonschema, functools32 16:14:41 INFO - Running setup.py install for functools32 16:14:41 INFO - warning: no files found matching '*.txt' 16:14:41 INFO - no previously-included directories found matching 'build' 16:14:41 INFO - no previously-included directories found matching 'dist' 16:14:41 INFO - no previously-included directories found matching '.git*' 16:14:41 INFO - Successfully installed jsonschema functools32 16:14:41 INFO - Cleaning up... 16:14:41 INFO - Return code: 0 16:14:41 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 16:14: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')]} 16:14:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:14:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:14: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')]} 16:14:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:14:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:14: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c702a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c712420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f94e0582770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c5a1e00>, '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 0x10c40adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c59cb20>, '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.7HaBMoVrRl/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.X1g0tiZCmP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/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 16:14: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', 'flake8'] in /builds/slave/test/build 16:14: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 flake8 16:14:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7HaBMoVrRl/Render', 16:14:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:14:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:14:41 INFO - 'HOME': '/Users/cltbld', 16:14:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:14:41 INFO - 'LOGNAME': 'cltbld', 16:14:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:14:41 INFO - 'MOZ_NO_REMOTE': '1', 16:14:41 INFO - 'NO_EM_RESTART': '1', 16:14:41 INFO - 'PAGER': '/bin/cat', 16:14:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:14:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:14:41 INFO - 'PWD': '/builds/slave/test', 16:14:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:14:41 INFO - 'SHELL': '/bin/bash', 16:14:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.X1g0tiZCmP/Listeners', 16:14:41 INFO - 'TMPDIR': '/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/', 16:14:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:14:41 INFO - 'USER': 'cltbld', 16:14:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:14:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:14:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:14:41 INFO - 'XPC_FLAGS': '0x0', 16:14:41 INFO - 'XPC_SERVICE_NAME': '0', 16:14:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:14:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:14:41 INFO - Downloading/unpacking flake8 16:14:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:14:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:14:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:14:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:14:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:14:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:14:44 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 16:14:44 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 16:14: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 16:14: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 16:14: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 16:14: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 16:14: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 16:14: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 16:14:44 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 16:14:44 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 16:14: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 16:14: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 16:14: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 16:14: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 16:14: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 16:14: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 16:14:44 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 16:14: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 16:14: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 16:14: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 16:14: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 16:14: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 16:14: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 16:14:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 16:14:45 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:14:45 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:14:45 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:14:45 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:14:45 INFO - no previously-included directories found matching 'docs/_build' 16:14:45 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 16:14:45 INFO - Running setup.py install for pep8 16:14:45 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:14:45 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:14:45 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:14:45 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:14:45 INFO - no previously-included directories found matching 'docs/_build' 16:14:45 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 16:14:45 INFO - Successfully installed flake8 mccabe pyflakes pep8 16:14:45 INFO - Cleaning up... 16:14:45 INFO - Return code: 0 16:14:45 INFO - Running post-action listener: _resource_record_post_action 16:14:45 INFO - Running post-action listener: _start_resource_monitoring 16:14:45 INFO - Starting resource monitoring. 16:14:45 INFO - ##### 16:14:45 INFO - ##### Running install step. 16:14:45 INFO - ##### 16:14:45 INFO - Running pre-action listener: _resource_record_pre_action 16:14:45 INFO - Running main action method: install 16:14:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:14:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:14:46 INFO - Reading from file tmpfile_stdout 16:14:46 INFO - Detecting whether we're running mozinstall >=1.0... 16:14:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:14:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:14:46 INFO - Reading from file tmpfile_stdout 16:14:46 INFO - Output received: 16:14:46 INFO - Usage: mozinstall [options] installer 16:14:46 INFO - Options: 16:14:46 INFO - -h, --help show this help message and exit 16:14:46 INFO - -d DEST, --destination=DEST 16:14:46 INFO - Directory to install application into. [default: 16:14:46 INFO - "/builds/slave/test"] 16:14:46 INFO - --app=APP Application being installed. [default: firefox] 16:14:46 INFO - mkdir: /builds/slave/test/build/application 16:14:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 16:14:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0.en-US.mac.dmg --destination /builds/slave/test/build/application 16:15:07 INFO - Reading from file tmpfile_stdout 16:15:07 INFO - Output received: 16:15:07 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 16:15:07 INFO - Running post-action listener: _resource_record_post_action 16:15:07 INFO - ##### 16:15:07 INFO - ##### Running run-tests step. 16:15:07 INFO - ##### 16:15:07 INFO - Running pre-action listener: _resource_record_pre_action 16:15:07 INFO - Running main action method: run_tests 16:15:07 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 16:15:07 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 16:15:07 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 16:15:07 INFO - 2016-06-08 16:15:07.738 screenresolution[1636:7354] starting screenresolution argv=screenresolution get 16:15:07 INFO - 2016-06-08 16:15:07.741 screenresolution[1636:7354] Display 0: 1600x1200x32@60 16:15:07 INFO - 2016-06-08 16:15:07.747 screenresolution[1637:7356] starting screenresolution argv=screenresolution list 16:15:07 INFO - Available Modes on Display 0 16:15:07 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 16:15:07 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 16:15:07 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 16:15:07 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 16:15:07 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 16:15:07 INFO - Intel Iris: 16:15:07 INFO - Chipset Model: Intel Iris 16:15:07 INFO - Type: GPU 16:15:07 INFO - Bus: Built-In 16:15:07 INFO - VRAM (Dynamic, Max): 1536 MB 16:15:07 INFO - Vendor: Intel (0x8086) 16:15:07 INFO - Device ID: 0x0a2e 16:15:07 INFO - Revision ID: 0x0009 16:15:07 INFO - Displays: 16:15:07 INFO - Display: 16:15:07 INFO - Resolution: 1600 x 1200 @ 60 Hz 16:15:07 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 16:15:07 INFO - Display Serial Number: 1600x1200 60 16:15:07 INFO - Main Display: Yes 16:15:07 INFO - Mirror: Off 16:15:07 INFO - Online: Yes 16:15:07 INFO - Rotation: Supported 16:15:07 INFO - Return code: 0 16:15:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:15:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:15:07 INFO - Python 2.7.3 16:15:07 INFO - Return code: 0 16:15:07 INFO - grabbing minidump binary from tooltool 16:15:07 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')]} 16:15:07 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 0x10c5a1e00>, '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 0x10c40adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c59cb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:15:07 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 16:15:07 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 16:15:08 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:15:08 INFO - Return code: 0 16:15:08 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 16:15:08 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:15:08 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:15:08 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 16:15:08 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:15:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 16:15:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 16:15:09 INFO - Return code: 0 16:15:09 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/SrroKRRKShivdQ8FW3uzGA/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0099', '--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 16:15:09 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/SrroKRRKShivdQ8FW3uzGA/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0099 --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 16:15:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7HaBMoVrRl/Render', 16:15:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:15:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:15:09 INFO - 'HOME': '/Users/cltbld', 16:15:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:15:09 INFO - 'LOGNAME': 'cltbld', 16:15:09 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:15:09 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 16:15:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:15:09 INFO - 'MOZ_NO_REMOTE': '1', 16:15:09 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:15:09 INFO - 'NO_EM_RESTART': '1', 16:15:09 INFO - 'PAGER': '/bin/cat', 16:15:09 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:15:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:15:09 INFO - 'PWD': '/builds/slave/test', 16:15:09 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:15:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:15:09 INFO - 'SHELL': '/bin/bash', 16:15:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.X1g0tiZCmP/Listeners', 16:15:09 INFO - 'TMPDIR': '/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/', 16:15:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:15:09 INFO - 'USER': 'cltbld', 16:15:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:15:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:15:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:15:09 INFO - 'XPC_FLAGS': '0x0', 16:15:09 INFO - 'XPC_SERVICE_NAME': '0', 16:15:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:15:09 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/SrroKRRKShivdQ8FW3uzGA/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0099', '--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 16:15:09 INFO - mozversion application_buildid: 20160608141429 16:15:09 INFO - mozversion application_changeset: ec56d351f9a0677f9ef34a6f6cefbf7addf86145 16:15:09 INFO - mozversion application_display_name: Firefox 16:15:09 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:15:09 INFO - mozversion application_name: Firefox 16:15:09 INFO - mozversion application_remotingname: firefox 16:15:09 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 16:15:09 INFO - mozversion application_vendor: Mozilla 16:15:09 INFO - mozversion application_version: 48.0 16:15:09 INFO - mozversion platform_buildid: 20160608141429 16:15:09 INFO - mozversion platform_changeset: ec56d351f9a0677f9ef34a6f6cefbf7addf86145 16:15:09 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 16:15:09 INFO - mozversion platform_version: 48.0 16:15:09 INFO - using testdate: 1465427709 16:15:09 INFO - actual date: 1465427709 16:15:09 INFO - starting webserver on 'localhost:49270' 16:15:09 INFO - SUITE-START | Running 2 tests 16:15:09 INFO - TEST-START | dromaeo_css 16:15:09 INFO - operating with platform_type : mac_ 16:15:09 INFO - Initialising browser for dromaeo_css test... 16:15:09 INFO - TEST-INFO | started process 1655 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/tmpFb3Dun/profile http://localhost:49270/getInfo.html) 16:15:11 INFO - PROCESS | 1655 | __metrics Screen width/height:1600/1200 16:15:11 INFO - PROCESS | 1655 | colorDepth:24 16:15:11 INFO - PROCESS | 1655 | Browser inner width/height: 1024/689 16:15:11 INFO - PROCESS | 1655 | __metrics 16:15:11 INFO - PROCESS | 1655 | 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" 16:15:11 ERROR - PROCESS | 1655 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 16:15:12 INFO - TEST-INFO | 1655: exit 0 16:15:12 INFO - Browser initialized. 16:15:12 INFO - Running cycle 1/1 for dromaeo_css test... 16:15:12 INFO - TEST-INFO | started process 1658 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/tmpFb3Dun/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:15:24 INFO - PROCESS | 1658 | RSS: Main: 161677312 16:15:24 INFO - PROCESS | 1658 | 16:16:15 INFO - PROCESS | 1658 | 1465427775901 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] 16:18:26 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49270/tests/dromaeo/cssquery-ext.html) 16:18:27 INFO - PROCESS | 1658 | RSS: Main: 294625280 16:18:27 INFO - PROCESS | 1658 | 16:21:30 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-ext.html (next: http://localhost:49270/tests/dromaeo/cssquery-jquery.html) 16:21:30 INFO - PROCESS | 1658 | RSS: Main: 304660480 16:21:30 INFO - PROCESS | 1658 | 16:24:33 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49270/tests/dromaeo/cssquery-mootools.html) 16:24:33 INFO - PROCESS | 1658 | RSS: Main: 307171328 16:24:33 INFO - PROCESS | 1658 | 16:27:35 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49270/tests/dromaeo/cssquery-prototype.html) 16:27:36 INFO - PROCESS | 1658 | RSS: Main: 301879296 16:27:36 INFO - PROCESS | 1658 | 16:30:39 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49270/tests/dromaeo/cssquery-yui.html) 16:30:40 INFO - PROCESS | 1658 | RSS: Main: 266514432 16:30:40 INFO - PROCESS | 1658 | 16:33:42 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-yui.html (next: http://localhost:49270/tests/dromaeo/cssquery-dojo.html) 16:33:43 INFO - PROCESS | 1658 | RSS: Main: 310157312 16:33:43 INFO - PROCESS | 1658 | 16:33:43 INFO - PROCESS | 1658 | __start_tp_report 16:33:43 INFO - PROCESS | 1658 | _x_x_mozilla_page_load 16:33:43 INFO - PROCESS | 1658 | _x_x_mozilla_page_load_details 16:33:43 INFO - PROCESS | 1658 | |i|pagename|runs| 16:33:43 INFO - PROCESS | 1658 | |0;dojo.html;3503.5970863350713;3562.6793588577025;3565.946510802337;3597.1007248187943;3644.380455322595;5858.20914176586;5866.853328666774;5870.530357571395;5878.359490435683;5933.821985340436;5845.7369418376165;5889.793857214999;5902.586818922677;5903.380145084769;5918.704064796753;5259.658122222043;5289.312389389374;5294.867628309295;5341.30563026806;5384.596155288349;5338.332708411449;5395.325584301962;5402.108652072403;5403.189521571757;5406.189071639246;5309.62832601718;5356;5378.46215378463;5385.81149659762;5406.648567843097;5355.303810504648;5384.138537833967;5394.406615272317;5399.9730001350135;5418.4039755626845;5156.458571849977;5325.281087053237;5332.253484512133;5337.759800808973;5337.786488540453;5716.228309178249;5718.0851063830005;5727.255456790632;5735;5794.652320860761;6302.275238347603;6306.054091886208;6328.65192414417;6334.1765570475545;6342.23893132827;6227.346128656516;6310.936890631081;6337.96831015842;6340.714667839912;6344.016677415008;5933.61431506955;6039.909401358983;6043.909341359883;6043.939560604338;6077.635341879457;6375.968120159369;6411.455026322815;6417.326180751047;6419.646919419477;6429.453496452854;6151.569390142647;6214.40963108504;6294.307626161119;6315.147455093504;6334.904976425358;6290.370962903673;6300.8658441480975;6310.495160387158;6315.242170939425;6317.273513545909;5162.53537181648;6246.094316324107;6267.304929637001;6270.592411493239;6307.274663413767;5249.632525723239;6223.751049958041;6302.243730752248;6320.55756097078;6333.2716737575765;4968.453470118284;4979.427365852974;4987.027529631687;5015.648904576645;5025.623078269071;4487.887802804956;4499.0776890737325;4512.165249428866;4516.774161291988;4530.456345238593;5801.53587712982;5908.20239267702;6002.549808764273;6002.819915402545;6005.609635373687;6231.937680623227;6305.180326557518;6314.62112273265;6324.588901721373;6331.240251169889;6004.489618382399;6020;6023.69881505923;6032.607880487754;6083.452489275986;5365.490278423622;5527.53015993645;5532.944670553243;5534.529564987021;5546.362168350611;6424.293327733945;6478.805635830932;6503.869922601616;6517.8696426072165;6518.478521718251;6309.053641953744;6319.6208227506495;6326.335734747785;6338.461230795434;6339.683015849097;6357.809265722036;6369.076483909715;6492.805215843532;6556.213254409311;6570.145881035435;6231.345708700703;6284.5600807943;6289.96855015722;6324.3991820776955;6326.588771729823;6256.405641464054;6269.279032911274;6293;6294.905576416266;6316.084167795736;6057.273127224761;6237.906431403442;6275.937240627535;6278.0269058296035;6300.464460520907;6152.107944348134;6206.844828879314;6281.466075383643;6288.308286088435;6317.7157027932935;6195.070739389128;6204.3795620437595;6207.596506227081;6216;6225.066240064027;6114.877702446015;6275.090111933653;6288.811335659938;6289.371062893857;6292.748290068529;6125.05232106189;6141.547378150805;6222.62664240147;6226.688665566613;6230.563860529719 16:33:43 INFO - PROCESS | 1658 | |1;ext.html;526.8208809004938;536.8147988943815;577.6736144078595;592.2034863109122;604.0800612330016;31836.840815795917;40207.59792402079;40646.98382540438;40664.79667601658;40701.79649101754;44033.339499907524;44517;44677;44733.55266447343;44767.776161119145;9136.451812891215;9353.812923741556;9868.654597089086;10085.64700235492;10096.141827944597;12062.396880156;12354.876451235508;12369.381530923418;12369.381530923463;12392.876071239263;12120.272783632967;12202.572909948154;12205.328706921116;12217.694557636041;12224.205426647284;11991.700207494796;12053.63839084829;12122.333271670099;12145.69635759113;12177.269363838199;11767;11879.940600296943;11960.940195299056;12007.45966431504;12254.326012069332;42697.57302426967;43041.35437968433;43047.78476107599;43091.35362969558;43110;3333.86473237416;3363.2768954674616;3433.9828300858585;3475.94786078209;3482.1120614243205;27556.586651200247;27647.03235386752;29577.55633665497;30067.69932300671;31459.685403145904;2775.722427757228;2798.9440211195865;2799.7200279972044;2827.9575806362923;2858.056841242385;392081;392819;393020;393179;393849;37977.430338544946;38555.80722096372;38678.61321386806;64110.679446602466;64444.03333949995;36888.893333200045;37079.88760337194;37241.62758372436;37315.813420933264;37316.626833731316;16414.425495107615;16503;16533.50399487993;16533.91733041351;16552.924059936067;12933.676658083623;13037.934810326078;14039.719205615831;14052.85947140536;14073.718525629634;7480.251974802476;8441;8564.073083556275;8598.957005214934;8657.43726657778;3562.4656301554974;3608.8195590220384;3609.4585812127866;3611.1874828163454;3641.7632853864943;895.1496078725237;1035.440861934547;1061.5965932945585;1131.7833329171174;1140.2531341971023;27080.864595676896;31013.534796978063;31551.684483155335;31619.20951976173;31892.521612175835;1101.2786624760795;1128.7347473343757;1131.8358837968613;1190.613050758507;1239.5661518468464;15425.151616660967;15574.922125389301;15593.532194034196;15602.843971560365;15857.682846343008;619476;625632;634891;635681;637372;63720;64343.03485447722;64379.67810161013;64569.354306456335;64650;1356.5387768158873;1565.8590726834411;1596.7125917334758;1599.8640115590072;1606.2209828233065;30477.23806904845;31500.527492088095;31639;31998.68001319957;32310.19224519406;56585;57179.71410142923;57236.56908577319;57316.42683573111;57375;469021;512821;522674;522953;526930;25162.37094072663;25350.873245633655;25556.616650750624;25598.8720056406;28491.860325586746;35581.93254202378;43339.78330108329;48184.75907620439;48510;51112.74443627758;33433.665663343054;35727.82136089303;36179.63820361763;37666.869993900225;37705.245895082495;38149;38222;38510.037249069;38786.80606596949;39118.608813911495;37837.05407364838;38298.04254893539;39220.60779392169;39249.8037509822;39329.606703933736;33600.49599256062;33751;34326;34600.48099278462;34614;21348.573028539653;25585.616215756407;25668.614970775827;25702;25887.482250355264 16:33:43 INFO - PROCESS | 1658 | |2;jquery.html;413.8572192593554;415.8565294973233;419.895026243439;423.5108449740549;428.34677117395967;19022.239110435585;21279.787202127973;21491.462713432153;21543.46141346465;22190.334289971288;9978.251631127676;11942.820857687142;12408.565700200495;12452.564160254371;12491.812622810665;5417.918731219035;5618.12918997554;5674.914876276838;5695.857603559903;5702.059160238556;3625.29306785177;4126.298529250034;5544.362398324184;6940.514164008521;6946.097007389032;6863.931360686379;6897.965510172442;6906.929425938963;6920.792376228696;6948.791536253895;6206.224221972254;6213.788311279302;6226.346233645448;6231.906521402183;6459.321771214002;4133.338665813455;5864.472197502203;6082.787102451437;6125.081237814319;6143.170671959273;13998.440062397493;14074.648133796634;14257.78613320801;14260.928695356457;14313.713725725427;2148.301801914384;2248.392933907836;2253.6281513550243;2333.195047708538;2380.4643955110137;10210.030047145508;10430.21773366993;10718.678439646823;12163.452644631012;15589.766153507706;1804.5669039430572;1826.5251034730932;1863.2081365419779;1898.7531620889333;1917.8465722742146;76413.23586764117;109269;115850;116199;116808.41595792052;10137.442440665835;11614.535418583331;11764.647060588197;11924.940375298069;11998.100142489347;15850;15952.521424357288;15967.441139560293;15971.680566388608;15985.960912540648;9445.858312125323;9484.478353690612;9502.762430939143;9606.519674016272;9660.420374777535;8137.552434616035;9295.584597316356;9616.134547890584;9624.845018597673;9681.854772178423;4908.04293162837;4933.87665308363;4948.8762780930765;4983.451820299764;5002.799888004439;2018.3642152721845;2046.8771873687626;2052.794720527935;2057.8353731701727;2083.364558821318;770.2220757035435;822.1983566023199;827.9875801862977;922.7831459606987;1085.6525911708336;17973.281068757366;20834.79165208359;21384.78615213859;21542.246021389175;21634.78365216359;1011.9241056920613;1017.8422344536609;1036.8237399642078;1043.2905624175633;1050.847627094067;11002.33985960845;11290.830637540443;11312.886871131348;11325.37710425918;11333.8099499553;623762;635030;640441;646802;651195;132556;133881;135874;136443;140809;1042.7914417116608;1067.055655744656;1082.653550863716;1096.7313008313015;1099.0712847643888;18401.263949441873;18573;18576.907115464335;18677.143942574756;18769.34307299238;49784.25323620076;53499.197512036575;54389.72805135949;54865.72567137139;56261.31216063524;79897.6005119994;83906.58046709727;84911.5754421224;85281;86461.30669204003;7028.718851246097;8399.916000840158;8416.579171041301;8514.361422893184;8526.147385261673;9293.907060929574;12313.26120432777;12723.23660580368;13181.143225690683;13242.53651122206;10894.891051089704;11248.775024499628;11573.363465009505;11599.76800464003;11636.650900473;9695.078967498077;10874.836877447004;11077;11419.429028548706;11492.253003555077;10933.56265749361;11411.25826821254;11636.709082273012;11770.3526306054;11832.526698931946;8199.672013119647;8440.282575981111;8488.660453581788;8488.957555212184;8711.47731136134;10041.49792510357;11259.155563332619;11465.770684586429;11511.654650360502;11617.767644647229 16:33:43 INFO - PROCESS | 1658 | |3;mootools.html;1430.5565274764824;1470.176701047413;1653.066017699999;1875.3061367294094;2016.4857961219896;8115.310198633116;8669.69656062038;8820.823583528341;8825.11748825118;8862.689805856797;8306.169383061706;8566.914330856689;8573.52845593492;8577.957110214456;8584.527850968194;2502.7372125926745;2530.367408147963;2533.1767175667887;2534.4297533055005;2536.822422430431;2461.5569197544437;2512.346789834647;2522.3441905104714;2524.368907773057;2524.7096583892903;2284.846152692896;2360.492494113765;2483.7019557653107;2513.4847356291916;2516.9119080832174;2492.501499700067;2518.8236823422367;2528.190978886757;2540.606206038067;2541.7204107548155;2059.5366042640435;2456.7666071723156;2502.199296225209;2503.7996960243136;2503.8873250703764;8580.957095214546;8634.222919937236;8694.478331300143;8699.347548933856;8700.608472618747;5493.890122197534;5645.379008309083;5709;5716.685582292972;5718.142278658193;3627.6553727396117;3685.207680348738;3755.305268525304;3764.2659681362147;3773.0378753417704;1048.963286284984;1064.2975636080228;1065.7868426314767;1077.8167711489066;1078.229066217658;12199.39003049844;12267.141300109086;12271.141020128594;12298.877011229863;12311.322877241748;4721.787519561559;4779.474257831635;4801.255805350176;4801.98580582253;4873.561379475864;9652.613895444103;9652.696885920452;9660.75848103789;9665.130138287588;9672.274579406572;5518.255035570227;5551.417101204396;5557.472040156179;5559.63862348946;5568.554515638739;4546.249868771682;4690.71855688653;4945.530174633404;5139.94631100631;5173.974130129325;3956.090099277182;3966.3058964681063;4033.838646454109;4056.8377264909664;4067.471228740304;1241.1560139105316;1248.7752204603078;1251.6432816647211;1257.6855786053486;1263.5072321794507;946.5456580841235;977.9657711980046;998.510729742421;1000.9349392289623;1004.6835246897203;6047.0627052806;6078.45293923549;6167.259928808482;6221.191245138103;6355.777547785898;461.3633186203018;469.16254485742786;469.98825029373853;470.1701496858048;471.8466498388038;3995.1610161866333;4025.9798701006307;4056.6815784870037;4069.654079403225;4136.772477513706;10485.9475702621;10575.153987680967;10631.893681063246;10730.570777168827;10743.838842417214;10596.735081622866;10596.993285637853;10623.468826558641;10627.04356607909;10634.255602107778;7989.480683755537;8337.624806883827;8353.874691879626;8427.32581393487;8448;5831.562632802472;5851.678157701367;5884.08796636522;5971.641701497924;6024.277086749618;9296.07039296092;9524.571394287412;9682.515874206121;9688.321817472992;9708.368956017835;9321.906780932104;9820.214382849497;9838.65564705232;9840.065193806577;10154.086132248132;6920.134983127109;7050.118735158106;7496.925030749622;7630.236976302325;7777.338926191111;7027.262137475696;8435.198656127657;8487.915120848713;8496.787580310294;8501;7366.1160660718915;7516.586587737727;7569;7644.847103058019;7689.6539655714505;7630.122535908442;7653.387728981556;7683.078030636136;7818.882716759367;7828.256315650005;7117.288271172842;7151;7168.856622867618;7172.748953786592;7173.497855150298;5123.308353372247;5138.177891537336;5267.209918512254;5358.035553600389;5365.248865158803;5413.350397952271;5428.4842939920645;5472.097103977958;5492.258545096521;5546.833594992157 16:33:43 INFO - PROCESS | 1658 | |4;prototype.html;332.75542476279935;337.868231389758;343.8515358701935;343.87792333721546;345.69578770681795;6743.629100399482;6791.185057793065;6981.895271570917;7003.0195772591815;7021.473389495783;6735.831604209885;6738.898916516257;6751.1898572171285;6758.560693554916;6787.694553745081;4011.2178125265586;4821.855344339667;5005.17414626588;5076.111680455924;5084.720340381277;4982.526659967298;5042.420121685998;5060.873478163057;5061.645684802065;5092.79628814847;4985.1774457214515;4991.151504244287;4991.326170966928;5012.69923804571;5017.67385119966;4749.978754567767;4797.28040793882;4941.728204948727;4952.306677065214;4958.132326842824;3738.2897249522503;4242.596953289432;4250.659947204216;4253.447051883235;4261.808218630169;5924.526037916957;6418.19772528434;6429;6430.935690643128;6441.0982462455295;5917.52659787216;5931.911021334683;5991.5206783457215;6060.545459090586;6082.422169893853;6810.523263371566;7122.287771222888;7122.821929451753;7128.358447739728;7172.139343278788;3974.6621537169376;4770.475247722748;4809.951900480985;4813.975930120327;4816.494268101869;7516.962415187889;7604.771856844303;7612.9999999999445;7617.504862183996;7628;4924.60603151747;4943.777530011158;4943.876403089952;4945.060438516671;4950.950490495049;5002.324686167321;5003.874903127451;5005.674631148963;5013.39839219296;5014.674046186986;5747.568932330092;5971.223740913741;5971.671558064261;5985.16207730918;6001.879962400728;7216.061911951413;7227.710891564384;7236.674349654279;7262.636868156676;7276.199618042011;1728.7579738836573;1760.586262228401;1761.1370428489947;1761.2162587648374;1764.0738612228683;1049.6378749331468;1113.1150735165563;1116.190761697779;1141.7944769941491;1152.1392950385068;5696.8006119785605;6427.614343139427;6548.410643042053;6565.967170164214;6611.900821487681;7401.370883474858;7582.507137036075;7595.164531901486;7608.771736847903;7659.693612255559;6892.1729392472225;6907.792766217021;6909.585424874524;6923.4807389446;6923.653817309114;3890.8365986113663;3967.107400834789;4020.8793736187963;4026.7181297309494;4026.9395959060053;7772.65023073963;7901;7920.32677222431;7930.444868859125;7930.722424715107;7743.7676869694;7792.259735325135;7796.4542482026845;7800.024996875391;7803.68785248595;6640.269570347258;7648.847023059619;7870.212978702084;7889.171636978034;7889.763307100796;7198.064251647253;7536.359409450258;7537.982372379659;7540.3213710766295;7614.466987310835;7421.6269990052015;7429.665665044978;7449.106107266946;7449.851002980018;7475.2151024141685;6920.30796920304;7346.045014148127;7908.051033875971;7915.722949696733;7937.880931786143;4709.693869898446;4759.6430267729365;4767.141914455431;4771.069641420028;4777.044591081867;7134.607596582237;7447.366973807287;7542.358899493604;7546.584937828253;7558.58427786455;6280.685965701788;6636.634985075674;7205.495615307088;7231.385332246818;7292.635368231461;5713.971430142823;5997.890390277813;7216.458765592497;7238.855222895618;7239.927600723925;5684.658920464785;7020.403265722471;7065.975433562207;7106.680199390937;7118.537295075804;5017.347744793154;5913.970430147821;7042.7887163385185;7230.819229519304;7233.1681856587165;6814.897776533257;6957.304269573205;6967.198772141269;7098.964505177441;7183.102112235971 16:33:43 INFO - PROCESS | 1658 | |5;yui.html;704.566691484737;717.2039036669297;731.1482123326325;767.501124269225;774.0827119862963;15658.451954181606;15826.129562874037;15874.04755714658;15882.444114455997;15894.841051589481;14466.059706119095;14649.97450178488;14653;14653.560393188194;14657.486987955424;787.1852632525338;804.778685861387;949.0462085603958;975.556121964508;981.7889153831925;964.4936408385583;971.2861047130353;975.5414954971152;978.9363691360074;979.0405402705353;837.1670188162786;1043.1133536493996;1043.7651528406086;1044.9634262800803;1046.691226088302;1017.6082208349765;1025.1542477456092;1025.9794804103876;1027.1320733979776;1032.9845052324222;766.1648802804914;767.0909971683517;767.4052609227838;769.2768797330548;778.241214815556;15329.386824527006;15413.152276624782;15436.45972390961;15455;15479.767803482957;12979.091463597551;13278.734425311537;13369;13405.731885362238;13716.931415342859;10406.687799366031;10487.895121048768;10527.578896844194;10703.732406689816;10795.29830561011;3633.5276414066266;3661.3958696814993;3679.35611268027;3715.2198038411966;3865.0530619998;80214.59892700557;80923.59538202272;81347;81685.18314816835;82999.92500187483;9771.657991970247;9815.950920245354;9976.102150806462;9976.301658883953;10644.414557199274;22587.548249034928;22589.548209036057;22618.547629047327;22629.773702262766;22731.772682273295;7630.809229769189;7768.7669369918995;8057.6374063167295;8184.263416292562;8193.79515512117;4024.5975402460103;4126.546079931205;4141.378793181047;4170.416141740159;4445.911081778347;3675.4486826976167;3732.309522738248;3734.775913445202;3737.1591391936595;3741.139537906297;611.9785807496717;651.205529254309;683.9555428897205;718.6263143165629;740.0490369874685;605.7395320012437;610.9552664942909;614.0727501472808;617.6109051297653;645.3610925184034;8433.662653493915;8539.018012928469;8543.102974187621;8644.654213831502;8801.911980880237;549.3051290118004;610.4719417703654;629.7764293675771;632.9810105696837;654.2770238886058;3795.886123416302;3964.920701585952;4005.7796821175116;4139.523954745183;4281.314989601648;98184.50907745559;98933.50533247432;100496.99503005022;100570.49714751526;100647;81107;83348;83558.16441835504;84823.15176848276;85059.57470212609;74203.62898185475;74452;75163.62418187874;75615.62192189114;77195.61402192953;8070.798230044295;8146.5519396433765;8151;8259.876101858597;8316.251537361666;37912.81043594764;45215;47677.80805479891;48139.27791083207;50629;48096.51903480921;60962.08556871739;67686.6462670734;70564.29435705577;71326.57346853138;9048.823652925077;10081.143102836048;10291.228157888338;10492.632757853744;10536.57853685844;9173.587188576663;11254.606088786853;11638.88361116378;11655.125865559947;11688.590899318484;9091.85581171604;9931.404115752788;10164.33931794431;10184.847227291448;10226.948865255627;11447.942760286145;11647.941760291144;11703.824442633537;11738.765224695288;11977.041836653221;11277.21059525858;11320.716982075513;11345.602903898323;11526;11927.9264866159;9498;9511.809763804547;9650.613975440903;9705.757356065873;9828.4102953823;9372.1565059145;9615.759606009626;9703.854442183232;9897.65358212459;9936.751581210528 16:33:43 INFO - PROCESS | 1658 | __end_tp_report 16:33:43 INFO - PROCESS | 1658 | __start_cc_report 16:33:43 INFO - PROCESS | 1658 | _x_x_mozilla_cycle_collect,1150 16:33:43 INFO - PROCESS | 1658 | __end_cc_report 16:33:43 INFO - PROCESS | 1658 | __startTimestamp1465428823116__endTimestamp 16:33:43 INFO - PROCESS | 1658 | 16:33:43 INFO - PROCESS | 1658 | ------- Summary: start ------- 16:33:43 INFO - PROCESS | 1658 | Number of tests: 6 16:33:43 INFO - PROCESS | 1658 | 16:33:43 INFO - PROCESS | 1658 | [#0] dojo.html Cycles:165 Average:5875.78 Median:6152.11 stddev:632.61 (10.3%) stddev-sans-first:606.56 16:33:43 INFO - PROCESS | 1658 | Values: 3503.6 3562.7 3565.9 3597.1 3644.4 5858.2 5866.9 5870.5 5878.4 5933.8 5845.7 5889.8 5902.6 5903.4 5918.7 5259.7 5289.3 5294.9 5341.3 5384.6 5338.3 5395.3 5402.1 5403.2 5406.2 5309.6 5356.0 5378.5 5385.8 5406.6 5355.3 5384.1 5394.4 5400.0 5418.4 5156.5 5325.3 5332.3 5337.8 5337.8 5716.2 5718.1 5727.3 5735.0 5794.7 6302.3 6306.1 6328.7 6334.2 6342.2 6227.3 6310.9 6338.0 6340.7 6344.0 5933.6 6039.9 6043.9 6043.9 6077.6 6376.0 6411.5 6417.3 6419.6 6429.5 6151.6 6214.4 6294.3 6315.1 6334.9 6290.4 6300.9 6310.5 6315.2 6317.3 5162.5 6246.1 6267.3 6270.6 6307.3 5249.6 6223.8 6302.2 6320.6 6333.3 4968.5 4979.4 4987.0 5015.6 5025.6 4487.9 4499.1 4512.2 4516.8 4530.5 5801.5 5908.2 6002.5 6002.8 6005.6 6231.9 6305.2 6314.6 6324.6 6331.2 6004.5 6020.0 6023.7 6032.6 6083.5 5365.5 5527.5 5532.9 5534.5 5546.4 6424.3 6478.8 6503.9 6517.9 6518.5 6309.1 6319.6 6326.3 6338.5 6339.7 6357.8 6369.1 6492.8 6556.2 6570.1 6231.3 6284.6 6290.0 6324.4 6326.6 6256.4 6269.3 6293.0 6294.9 6316.1 6057.3 6237.9 6275.9 6278.0 6300.5 6152.1 6206.8 6281.5 6288.3 6317.7 6195.1 6204.4 6207.6 6216.0 6225.1 6114.9 6275.1 6288.8 6289.4 6292.7 6125.1 6141.5 6222.6 6226.7 6230.6 16:33:43 INFO - PROCESS | 1658 | 16:33:43 INFO - PROCESS | 1658 | [#1] ext.html Cycles:180 Average:64725.74 Median:19044.97 stddev:139093.05 (730.3%) stddev-sans-first:139399.72 16:33:43 INFO - PROCESS | 1658 | Values: 526.8 536.8 577.7 592.2 604.1 31836.8 40207.6 40647.0 40664.8 40701.8 44033.3 44517.0 44677.0 44733.6 44767.8 9136.5 9353.8 9868.7 10085.6 10096.1 12062.4 12354.9 12369.4 12369.4 12392.9 12120.3 12202.6 12205.3 12217.7 12224.2 11991.7 12053.6 12122.3 12145.7 12177.3 11767.0 11879.9 11960.9 12007.5 12254.3 42697.6 43041.4 43047.8 43091.4 43110.0 3333.9 3363.3 3434.0 3475.9 3482.1 27556.6 27647.0 29577.6 30067.7 31459.7 2775.7 2798.9 2799.7 2828.0 2858.1 392081.0 392819.0 393020.0 393179.0 393849.0 37977.4 38555.8 38678.6 64110.7 64444.0 36888.9 37079.9 37241.6 37315.8 37316.6 16414.4 16503.0 16533.5 16533.9 16552.9 12933.7 13037.9 14039.7 14052.9 14073.7 7480.3 8441.0 8564.1 8599.0 8657.4 3562.5 3608.8 3609.5 3611.2 3641.8 895.1 1035.4 1061.6 1131.8 1140.3 27080.9 31013.5 31551.7 31619.2 31892.5 1101.3 1128.7 1131.8 1190.6 1239.6 15425.2 15574.9 15593.5 15602.8 15857.7 619476.0 625632.0 634891.0 635681.0 637372.0 63720.0 64343.0 64379.7 64569.4 64650.0 1356.5 1565.9 1596.7 1599.9 1606.2 30477.2 31500.5 31639.0 31998.7 32310.2 56585.0 57179.7 57236.6 57316.4 57375.0 469021.0 512821.0 522674.0 522953.0 526930.0 25162.4 25350.9 25556.6 25598.9 28491.9 35581.9 43339.8 48184.8 48510.0 51112.7 33433.7 35727.8 36179.6 37666.9 37705.2 38149.0 38222.0 38510.0 38786.8 39118.6 37837.1 38298.0 39220.6 39249.8 39329.6 33600.5 33751.0 34326.0 34600.5 34614.0 21348.6 25585.6 25668.6 25702.0 25887.5 16:33:43 INFO - PROCESS | 1658 | 16:33:43 INFO - PROCESS | 1658 | [#2] jquery.html Cycles:180 Average:35947.41 Median:21332.29 stddev:106493.41 (499.2%) stddev-sans-first:106758.73 16:33:43 INFO - PROCESS | 1658 | Values: 413.9 415.9 419.9 423.5 428.3 19022.2 21279.8 21491.5 21543.5 22190.3 9978.3 11942.8 12408.6 12452.6 12491.8 5417.9 5618.1 5674.9 5695.9 5702.1 3625.3 4126.3 5544.4 6940.5 6946.1 6863.9 6898.0 6906.9 6920.8 6948.8 6206.2 6213.8 6226.3 6231.9 6459.3 4133.3 5864.5 6082.8 6125.1 6143.2 13998.4 14074.6 14257.8 14260.9 14313.7 2148.3 2248.4 2253.6 2333.2 2380.5 10210.0 10430.2 10718.7 12163.5 15589.8 1804.6 1826.5 1863.2 1898.8 1917.8 76413.2 109269.0 115850.0 116199.0 116808.4 10137.4 11614.5 11764.6 11924.9 11998.1 15850.0 15952.5 15967.4 15971.7 15986.0 9445.9 9484.5 9502.8 9606.5 9660.4 8137.6 9295.6 9616.1 9624.8 9681.9 4908.0 4933.9 4948.9 4983.5 5002.8 2018.4 2046.9 2052.8 2057.8 2083.4 770.2 822.2 828.0 922.8 1085.7 17973.3 20834.8 21384.8 21542.2 21634.8 1011.9 1017.8 1036.8 1043.3 1050.8 11002.3 11290.8 11312.9 11325.4 11333.8 623762.0 635030.0 640441.0 646802.0 651195.0 132556.0 133881.0 135874.0 136443.0 140809.0 1042.8 1067.1 1082.7 1096.7 1099.1 18401.3 18573.0 18576.9 18677.1 18769.3 49784.3 53499.2 54389.7 54865.7 56261.3 79897.6 83906.6 84911.6 85281.0 86461.3 7028.7 8399.9 8416.6 8514.4 8526.1 9293.9 12313.3 12723.2 13181.1 13242.5 10894.9 11248.8 11573.4 11599.8 11636.7 9695.1 10874.8 11077.0 11419.4 11492.3 10933.6 11411.3 11636.7 11770.4 11832.5 8199.7 8440.3 8488.7 8489.0 8711.5 10041.5 11259.2 11465.8 11511.7 11617.8 16:33:43 INFO - PROCESS | 1658 | 16:33:43 INFO - PROCESS | 1658 | [#3] mootools.html Cycles:180 Average:5779.85 Median:5312.62 stddev:3175.79 (59.8%) stddev-sans-first:3167.88 16:33:43 INFO - PROCESS | 1658 | Values: 1430.6 1470.2 1653.1 1875.3 2016.5 8115.3 8669.7 8820.8 8825.1 8862.7 8306.2 8566.9 8573.5 8578.0 8584.5 2502.7 2530.4 2533.2 2534.4 2536.8 2461.6 2512.3 2522.3 2524.4 2524.7 2284.8 2360.5 2483.7 2513.5 2516.9 2492.5 2518.8 2528.2 2540.6 2541.7 2059.5 2456.8 2502.2 2503.8 2503.9 8581.0 8634.2 8694.5 8699.3 8700.6 5493.9 5645.4 5709.0 5716.7 5718.1 3627.7 3685.2 3755.3 3764.3 3773.0 1049.0 1064.3 1065.8 1077.8 1078.2 12199.4 12267.1 12271.1 12298.9 12311.3 4721.8 4779.5 4801.3 4802.0 4873.6 9652.6 9652.7 9660.8 9665.1 9672.3 5518.3 5551.4 5557.5 5559.6 5568.6 4546.2 4690.7 4945.5 5139.9 5174.0 3956.1 3966.3 4033.8 4056.8 4067.5 1241.2 1248.8 1251.6 1257.7 1263.5 946.5 978.0 998.5 1000.9 1004.7 6047.1 6078.5 6167.3 6221.2 6355.8 461.4 469.2 470.0 470.2 471.8 3995.2 4026.0 4056.7 4069.7 4136.8 10485.9 10575.2 10631.9 10730.6 10743.8 10596.7 10597.0 10623.5 10627.0 10634.3 7989.5 8337.6 8353.9 8427.3 8448.0 5831.6 5851.7 5884.1 5971.6 6024.3 9296.1 9524.6 9682.5 9688.3 9708.4 9321.9 9820.2 9838.7 9840.1 10154.1 6920.1 7050.1 7496.9 7630.2 7777.3 7027.3 8435.2 8487.9 8496.8 8501.0 7366.1 7516.6 7569.0 7644.8 7689.7 7630.1 7653.4 7683.1 7818.9 7828.3 7117.3 7151.0 7168.9 7172.7 7173.5 5123.3 5138.2 5267.2 5358.0 5365.2 5413.4 5428.5 5472.1 5492.3 5546.8 16:33:43 INFO - PROCESS | 1658 | 16:33:43 INFO - PROCESS | 1658 | [#4] prototype.html Cycles:180 Average:5895.92 Median:6624.27 stddev:1872.21 (28.3%) stddev-sans-first:1830.31 16:33:43 INFO - PROCESS | 1658 | Values: 332.8 337.9 343.9 343.9 345.7 6743.6 6791.2 6981.9 7003.0 7021.5 6735.8 6738.9 6751.2 6758.6 6787.7 4011.2 4821.9 5005.2 5076.1 5084.7 4982.5 5042.4 5060.9 5061.6 5092.8 4985.2 4991.2 4991.3 5012.7 5017.7 4750.0 4797.3 4941.7 4952.3 4958.1 3738.3 4242.6 4250.7 4253.4 4261.8 5924.5 6418.2 6429.0 6430.9 6441.1 5917.5 5931.9 5991.5 6060.5 6082.4 6810.5 7122.3 7122.8 7128.4 7172.1 3974.7 4770.5 4810.0 4814.0 4816.5 7517.0 7604.8 7613.0 7617.5 7628.0 4924.6 4943.8 4943.9 4945.1 4951.0 5002.3 5003.9 5005.7 5013.4 5014.7 5747.6 5971.2 5971.7 5985.2 6001.9 7216.1 7227.7 7236.7 7262.6 7276.2 1728.8 1760.6 1761.1 1761.2 1764.1 1049.6 1113.1 1116.2 1141.8 1152.1 5696.8 6427.6 6548.4 6566.0 6611.9 7401.4 7582.5 7595.2 7608.8 7659.7 6892.2 6907.8 6909.6 6923.5 6923.7 3890.8 3967.1 4020.9 4026.7 4026.9 7772.7 7901.0 7920.3 7930.4 7930.7 7743.8 7792.3 7796.5 7800.0 7803.7 6640.3 7648.8 7870.2 7889.2 7889.8 7198.1 7536.4 7538.0 7540.3 7614.5 7421.6 7429.7 7449.1 7449.9 7475.2 6920.3 7346.0 7908.1 7915.7 7937.9 4709.7 4759.6 4767.1 4771.1 4777.0 7134.6 7447.4 7542.4 7546.6 7558.6 6280.7 6636.6 7205.5 7231.4 7292.6 5714.0 5997.9 7216.5 7238.9 7239.9 5684.7 7020.4 7066.0 7106.7 7118.5 5017.3 5914.0 7042.8 7230.8 7233.2 6814.9 6957.3 6967.2 7099.0 7183.1 16:33:43 INFO - PROCESS | 1658 | 16:33:43 INFO - PROCESS | 1658 | [#5] yui.html Cycles:180 Average:18710.11 Median:577.52 stddev:26724.07 (4627.4%) stddev-sans-first:26764.84 16:33:43 INFO - PROCESS | 1658 | Values: 704.6 717.2 731.1 767.5 774.1 15658.5 15826.1 15874.0 15882.4 15894.8 14466.1 14650.0 14653.0 14653.6 14657.5 787.2 804.8 949.0 975.6 981.8 964.5 971.3 975.5 978.9 979.0 837.2 1043.1 1043.8 1045.0 1046.7 1017.6 1025.2 1026.0 1027.1 1033.0 766.2 767.1 767.4 769.3 778.2 15329.4 15413.2 15436.5 15455.0 15479.8 12979.1 13278.7 13369.0 13405.7 13716.9 10406.7 10487.9 10527.6 10703.7 10795.3 3633.5 3661.4 3679.4 3715.2 3865.1 80214.6 80923.6 81347.0 81685.2 82999.9 9771.7 9816.0 9976.1 9976.3 10644.4 22587.5 22589.5 22618.5 22629.8 22731.8 7630.8 7768.8 8057.6 8184.3 8193.8 4024.6 4126.5 4141.4 4170.4 4445.9 3675.4 3732.3 3734.8 3737.2 3741.1 612.0 651.2 684.0 718.6 740.0 605.7 611.0 614.1 617.6 645.4 8433.7 8539.0 8543.1 8644.7 8801.9 549.3 610.5 629.8 633.0 654.3 3795.9 3964.9 4005.8 4139.5 4281.3 98184.5 98933.5 100497.0 100570.5 100647.0 81107.0 83348.0 83558.2 84823.2 85059.6 74203.6 74452.0 75163.6 75615.6 77195.6 8070.8 8146.6 8151.0 8259.9 8316.3 37912.8 45215.0 47677.8 48139.3 50629.0 48096.5 60962.1 67686.6 70564.3 71326.6 9048.8 10081.1 10291.2 10492.6 10536.6 9173.6 11254.6 11638.9 11655.1 11688.6 9091.9 9931.4 10164.3 10184.8 10226.9 11447.9 11647.9 11703.8 11738.8 11977.0 11277.2 11320.7 11345.6 11526.0 11927.9 9498.0 9511.8 9650.6 9705.8 9828.4 9372.2 9615.8 9703.9 9897.7 9936.8 16:33:43 INFO - PROCESS | 1658 | -------- Summary: end -------- 16:33:43 INFO - PROCESS | 1658 | 16:33:43 INFO - TEST-INFO | 1658: exit 0 16:33:43 INFO - TEST-OK | dromaeo_css | took 1114253ms 16:33:43 INFO - TEST-START | kraken 16:33:43 INFO - operating with platform_type : mac_ 16:33:43 INFO - Initialising browser for kraken test... 16:33:43 INFO - TEST-INFO | started process 1668 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/tmpuKJT2_/profile http://localhost:49270/getInfo.html) 16:33:45 INFO - PROCESS | 1668 | __metrics Screen width/height:1600/1200 16:33:45 INFO - PROCESS | 1668 | colorDepth:24 16:33:45 INFO - PROCESS | 1668 | Browser inner width/height: 1024/689 16:33:45 INFO - PROCESS | 1668 | __metrics 16:33:45 INFO - PROCESS | 1668 | 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" 16:33:45 ERROR - PROCESS | 1668 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 16:33:46 INFO - TEST-INFO | 1668: exit 0 16:33:46 INFO - Browser initialized. 16:33:46 INFO - Running cycle 1/1 for kraken test... 16:33:46 INFO - TEST-INFO | started process 1671 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/tmpuKJT2_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:33:58 INFO - PROCESS | 1671 | RSS: Main: 161075200 16:33:58 INFO - PROCESS | 1671 | 16:34:01 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-beat-detection) 16:34:01 INFO - PROCESS | 1671 | RSS: Main: 223965184 16:34:01 INFO - PROCESS | 1671 | 16:34:04 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-dft) 16:34:05 INFO - PROCESS | 1671 | RSS: Main: 238792704 16:34:05 INFO - PROCESS | 1671 | 16:34:08 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-fft) 16:34:09 INFO - PROCESS | 1671 | RSS: Main: 323256320 16:34:09 INFO - PROCESS | 1671 | 16:34:11 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-oscillator) 16:34:11 INFO - PROCESS | 1671 | RSS: Main: 230432768 16:34:11 INFO - PROCESS | 1671 | 16:34:13 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:34:14 INFO - PROCESS | 1671 | RSS: Main: 230281216 16:34:14 INFO - PROCESS | 1671 | 16:34:17 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-darkroom) 16:34:17 INFO - PROCESS | 1671 | RSS: Main: 270016512 16:34:17 INFO - PROCESS | 1671 | 16:34:20 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-desaturate) 16:34:21 INFO - PROCESS | 1671 | RSS: Main: 271339520 16:34:21 INFO - PROCESS | 1671 | 16:34:24 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49270/tests/kraken/driver.html?testName=json-parse-financial) 16:34:24 INFO - PROCESS | 1671 | RSS: Main: 268091392 16:34:24 INFO - PROCESS | 1671 | 16:34:26 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49270/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:34:27 INFO - PROCESS | 1671 | RSS: Main: 260349952 16:34:27 INFO - PROCESS | 1671 | 16:34:29 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:34:29 INFO - PROCESS | 1671 | RSS: Main: 267878400 16:34:29 INFO - PROCESS | 1671 | 16:34:31 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:34:32 INFO - PROCESS | 1671 | RSS: Main: 270655488 16:34:32 INFO - PROCESS | 1671 | 16:34:35 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:34:35 INFO - PROCESS | 1671 | RSS: Main: 277909504 16:34:35 INFO - PROCESS | 1671 | 16:34:38 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:34:39 INFO - PROCESS | 1671 | RSS: Main: 274812928 16:34:39 INFO - PROCESS | 1671 | 16:34:40 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49270/tests/kraken/driver.html?testName=ai-astar) 16:34:41 INFO - PROCESS | 1671 | RSS: Main: 335876096 16:34:41 INFO - PROCESS | 1671 | 16:34:41 INFO - PROCESS | 1671 | __start_tp_report 16:34:41 INFO - PROCESS | 1671 | _x_x_mozilla_page_load 16:34:41 INFO - PROCESS | 1671 | _x_x_mozilla_page_load_details 16:34:41 INFO - PROCESS | 1671 | |i|pagename|runs| 16:34:41 INFO - PROCESS | 1671 | |0;ai-astar;113;113;121;114;113;111;115;113;112;134 16:34:41 INFO - PROCESS | 1671 | |1;audio-beat-detection;158;125;176;201;131;140;137;117;169;117 16:34:41 INFO - PROCESS | 1671 | |2;audio-dft;183;188;185;183;186;216;244;185;187;184 16:34:41 INFO - PROCESS | 1671 | |3;audio-fft;75;92;104;197;56;56;55;60;130;55 16:34:41 INFO - PROCESS | 1671 | |4;audio-oscillator;92;93;144;77;78;77;127;61;72;138 16:34:41 INFO - PROCESS | 1671 | |5;imaging-gaussian-blur;107;108;86;84;85;84;87;85;86;83 16:34:41 INFO - PROCESS | 1671 | |6;imaging-darkroom;91;92;91;92;92;92;92;102;88;129 16:34:41 INFO - PROCESS | 1671 | |7;imaging-desaturate;82;84;96;133;141;84;85;83;84;84 16:34:41 INFO - PROCESS | 1671 | |8;json-parse-financial;56;61;61;61;62;61;62;80;58;54 16:34:41 INFO - PROCESS | 1671 | |9;json-stringify-tinderbox;60;63;67;70;69;69;57;63;96;96 16:34:41 INFO - PROCESS | 1671 | |10;stanford-crypto-aes;80;78;80;79;80;78;79;78;81;84 16:34:41 INFO - PROCESS | 1671 | |11;stanford-crypto-ccm;127;127;126;126;123;128;124;128;146;128 16:34:41 INFO - PROCESS | 1671 | |12;stanford-crypto-pbkdf2;162;163;164;211;213;203;155;159;161;162 16:34:41 INFO - PROCESS | 1671 | |13;stanford-crypto-sha256-iterative;65;66;67;67;67;66;66;68;66;66 16:34:41 INFO - PROCESS | 1671 | __end_tp_report 16:34:41 INFO - PROCESS | 1671 | __start_cc_report 16:34:41 INFO - PROCESS | 1671 | _x_x_mozilla_cycle_collect,1991 16:34:41 INFO - PROCESS | 1671 | __end_cc_report 16:34:41 INFO - PROCESS | 1671 | __startTimestamp1465428881113__endTimestamp 16:34:41 INFO - PROCESS | 1671 | 16:34:41 INFO - PROCESS | 1671 | ------- Summary: start ------- 16:34:41 INFO - PROCESS | 1671 | Number of tests: 14 16:34:41 INFO - PROCESS | 1671 | 16:34:41 INFO - PROCESS | 1671 | [#0] ai-astar Cycles:10 Average:115.90 Median:113.50 stddev:6.92 (6.1%) stddev-sans-first:7.26 16:34:41 INFO - PROCESS | 1671 | Values: 113.0 113.0 121.0 114.0 113.0 111.0 115.0 113.0 112.0 134.0 16:34:41 INFO - PROCESS | 1671 | 16:34:41 INFO - PROCESS | 1671 | [#1] audio-beat-detection Cycles:10 Average:147.10 Median:149.00 stddev:27.99 (18.8%) stddev-sans-first:29.41 16:34:41 INFO - PROCESS | 1671 | Values: 158.0 125.0 176.0 201.0 131.0 140.0 137.0 117.0 169.0 117.0 16:34:41 INFO - PROCESS | 1671 | 16:34:41 INFO - PROCESS | 1671 | [#2] audio-dft Cycles:10 Average:194.10 Median:186.50 stddev:20.10 (10.8%) stddev-sans-first:20.92 16:34:41 INFO - PROCESS | 1671 | Values: 183.0 188.0 185.0 183.0 186.0 216.0 244.0 185.0 187.0 184.0 16:34:41 INFO - PROCESS | 1671 | 16:34:41 INFO - PROCESS | 1671 | [#3] audio-fft Cycles:10 Average:88.00 Median:56.00 stddev:46.06 (82.3%) stddev-sans-first:48.62 16:34:41 INFO - PROCESS | 1671 | Values: 75.0 92.0 104.0 197.0 56.0 56.0 55.0 60.0 130.0 55.0 16:34:41 INFO - PROCESS | 1671 | 16:34:41 INFO - PROCESS | 1671 | [#4] audio-oscillator Cycles:10 Average:95.90 Median:77.00 stddev:29.63 (38.5%) stddev-sans-first:31.39 16:34:41 INFO - PROCESS | 1671 | Values: 92.0 93.0 144.0 77.0 78.0 77.0 127.0 61.0 72.0 138.0 16:34:41 INFO - PROCESS | 1671 | 16:34:41 INFO - PROCESS | 1671 | [#5] imaging-gaussian-blur Cycles:10 Average:89.50 Median:85.00 stddev:9.56 (11.2%) stddev-sans-first:7.76 16:34:41 INFO - PROCESS | 1671 | Values: 107.0 108.0 86.0 84.0 85.0 84.0 87.0 85.0 86.0 83.0 16:34:41 INFO - PROCESS | 1671 | 16:34:41 INFO - PROCESS | 1671 | [#6] imaging-darkroom Cycles:10 Average:96.10 Median:92.00 stddev:12.11 (13.2%) stddev-sans-first:12.70 16:34:41 INFO - PROCESS | 1671 | Values: 91.0 92.0 91.0 92.0 92.0 92.0 92.0 102.0 88.0 129.0 16:34:41 INFO - PROCESS | 1671 | 16:34:41 INFO - PROCESS | 1671 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:84.00 stddev:22.25 (26.5%) stddev-sans-first:23.05 16:34:41 INFO - PROCESS | 1671 | Values: 82.0 84.0 96.0 133.0 141.0 84.0 85.0 83.0 84.0 84.0 16:34:41 INFO - PROCESS | 1671 | 16:34:41 INFO - PROCESS | 1671 | [#8] json-parse-financial Cycles:10 Average:61.60 Median:61.00 stddev:7.01 (11.5%) stddev-sans-first:7.14 16:34:41 INFO - PROCESS | 1671 | Values: 56.0 61.0 61.0 61.0 62.0 61.0 62.0 80.0 58.0 54.0 16:34:41 INFO - PROCESS | 1671 | 16:34:41 INFO - PROCESS | 1671 | [#9] json-stringify-tinderbox Cycles:10 Average:71.00 Median:69.00 stddev:13.82 (20.0%) stddev-sans-first:14.08 16:34:41 INFO - PROCESS | 1671 | Values: 60.0 63.0 67.0 70.0 69.0 69.0 57.0 63.0 96.0 96.0 16:34:41 INFO - PROCESS | 1671 | 16:34:41 INFO - PROCESS | 1671 | [#10] stanford-crypto-aes Cycles:10 Average:79.70 Median:80.00 stddev:1.83 (2.3%) stddev-sans-first:1.94 16:34:41 INFO - PROCESS | 1671 | Values: 80.0 78.0 80.0 79.0 80.0 78.0 79.0 78.0 81.0 84.0 16:34:41 INFO - PROCESS | 1671 | 16:34:41 INFO - PROCESS | 1671 | [#11] stanford-crypto-ccm Cycles:10 Average:128.30 Median:127.50 stddev:6.45 (5.1%) stddev-sans-first:6.82 16:34:41 INFO - PROCESS | 1671 | Values: 127.0 127.0 126.0 126.0 123.0 128.0 124.0 128.0 146.0 128.0 16:34:41 INFO - PROCESS | 1671 | 16:34:41 INFO - PROCESS | 1671 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:175.30 Median:163.50 stddev:23.52 (14.4%) stddev-sans-first:24.45 16:34:41 INFO - PROCESS | 1671 | Values: 162.0 163.0 164.0 211.0 213.0 203.0 155.0 159.0 161.0 162.0 16:34:41 INFO - PROCESS | 1671 | 16:34:41 INFO - PROCESS | 1671 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.40 Median:66.50 stddev:0.84 (1.3%) stddev-sans-first:0.73 16:34:41 INFO - PROCESS | 1671 | Values: 65.0 66.0 67.0 67.0 67.0 66.0 66.0 68.0 66.0 66.0 16:34:41 INFO - PROCESS | 1671 | -------- Summary: end -------- 16:34:41 INFO - PROCESS | 1671 | 16:34:41 INFO - TEST-INFO | 1671: exit 0 16:34:41 INFO - TEST-OK | kraken | took 58244ms 16:34:41 INFO - SUITE-END | took 1172s 16:34:42 INFO - Completed test suite (00:19:32) 16:34:42 INFO - javascript benchmark 16:34:42 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3503.5970863350713, 3562.6793588577025, 3565.946510802337, 3597.1007248187943, 3644.380455322595, 5858.20914176586, 5866.853328666774, 5870.530357571395, 5878.359490435683, 5933.821985340436, 5845.7369418376165, 5889.793857214999, 5902.586818922677, 5903.380145084769, 5918.704064796753, 5259.658122222043, 5289.312389389374, 5294.867628309295, 5341.30563026806, 5384.596155288349, 5338.332708411449, 5395.325584301962, 5402.108652072403, 5403.189521571757, 5406.189071639246, 5309.62832601718, 5356.0, 5378.46215378463, 5385.81149659762, 5406.648567843097, 5355.303810504648, 5384.138537833967, 5394.406615272317, 5399.9730001350135, 5418.4039755626845, 5156.458571849977, 5325.281087053237, 5332.253484512133, 5337.759800808973, 5337.786488540453, 5716.228309178249, 5718.0851063830005, 5727.255456790632, 5735.0, 5794.652320860761, 6302.275238347603, 6306.054091886208, 6328.65192414417, 6334.1765570475545, 6342.23893132827, 6227.346128656516, 6310.936890631081, 6337.96831015842, 6340.714667839912, 6344.016677415008, 5933.61431506955, 6039.909401358983, 6043.909341359883, 6043.939560604338, 6077.635341879457, 6375.968120159369, 6411.455026322815, 6417.326180751047, 6419.646919419477, 6429.453496452854, 6151.569390142647, 6214.40963108504, 6294.307626161119, 6315.147455093504, 6334.904976425358, 6290.370962903673, 6300.8658441480975, 6310.495160387158, 6315.242170939425, 6317.273513545909, 5162.53537181648, 6246.094316324107, 6267.304929637001, 6270.592411493239, 6307.274663413767, 5249.632525723239, 6223.751049958041, 6302.243730752248, 6320.55756097078, 6333.2716737575765, 4968.453470118284, 4979.427365852974, 4987.027529631687, 5015.648904576645, 5025.623078269071, 4487.887802804956, 4499.0776890737325, 4512.165249428866, 4516.774161291988, 4530.456345238593, 5801.53587712982, 5908.20239267702, 6002.549808764273, 6002.819915402545, 6005.609635373687, 6231.937680623227, 6305.180326557518, 6314.62112273265, 6324.588901721373, 6331.240251169889, 6004.489618382399, 6020.0, 6023.69881505923, 6032.607880487754, 6083.452489275986, 5365.490278423622, 5527.53015993645, 5532.944670553243, 5534.529564987021, 5546.362168350611, 6424.293327733945, 6478.805635830932, 6503.869922601616, 6517.8696426072165, 6518.478521718251, 6309.053641953744, 6319.6208227506495, 6326.335734747785, 6338.461230795434, 6339.683015849097, 6357.809265722036, 6369.076483909715, 6492.805215843532, 6556.213254409311, 6570.145881035435, 6231.345708700703, 6284.5600807943, 6289.96855015722, 6324.3991820776955, 6326.588771729823, 6256.405641464054, 6269.279032911274, 6293.0, 6294.905576416266, 6316.084167795736, 6057.273127224761, 6237.906431403442, 6275.937240627535, 6278.0269058296035, 6300.464460520907, 6152.107944348134, 6206.844828879314, 6281.466075383643, 6288.308286088435, 6317.7157027932935, 6195.070739389128, 6204.3795620437595, 6207.596506227081, 6216.0, 6225.066240064027, 6114.877702446015, 6275.090111933653, 6288.811335659938, 6289.371062893857, 6292.748290068529, 6125.05232106189, 6141.547378150805, 6222.62664240147, 6226.688665566613, 6230.563860529719], "value": 5837.124379488431, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [526.8208809004938, 536.8147988943815, 577.6736144078595, 592.2034863109122, 604.0800612330016, 31836.840815795917, 40207.59792402079, 40646.98382540438, 40664.79667601658, 40701.79649101754, 44033.339499907524, 44517.0, 44677.0, 44733.55266447343, 44767.776161119145, 9136.451812891215, 9353.812923741556, 9868.654597089086, 10085.64700235492, 10096.141827944597, 12062.396880156, 12354.876451235508, 12369.381530923418, 12369.381530923463, 12392.876071239263, 12120.272783632967, 12202.572909948154, 12205.328706921116, 12217.694557636041, 12224.205426647284, 11991.700207494796, 12053.63839084829, 12122.333271670099, 12145.69635759113, 12177.269363838199, 11767.0, 11879.940600296943, 11960.940195299056, 12007.45966431504, 12254.326012069332, 42697.57302426967, 43041.35437968433, 43047.78476107599, 43091.35362969558, 43110.0, 3333.86473237416, 3363.2768954674616, 3433.9828300858585, 3475.94786078209, 3482.1120614243205, 27556.586651200247, 27647.03235386752, 29577.55633665497, 30067.69932300671, 31459.685403145904, 2775.722427757228, 2798.9440211195865, 2799.7200279972044, 2827.9575806362923, 2858.056841242385, 392081.0, 392819.0, 393020.0, 393179.0, 393849.0, 37977.430338544946, 38555.80722096372, 38678.61321386806, 64110.679446602466, 64444.03333949995, 36888.893333200045, 37079.88760337194, 37241.62758372436, 37315.813420933264, 37316.626833731316, 16414.425495107615, 16503.0, 16533.50399487993, 16533.91733041351, 16552.924059936067, 12933.676658083623, 13037.934810326078, 14039.719205615831, 14052.85947140536, 14073.718525629634, 7480.251974802476, 8441.0, 8564.073083556275, 8598.957005214934, 8657.43726657778, 3562.4656301554974, 3608.8195590220384, 3609.4585812127866, 3611.1874828163454, 3641.7632853864943, 895.1496078725237, 1035.440861934547, 1061.5965932945585, 1131.7833329171174, 1140.2531341971023, 27080.864595676896, 31013.534796978063, 31551.684483155335, 31619.20951976173, 31892.521612175835, 1101.2786624760795, 1128.7347473343757, 1131.8358837968613, 1190.613050758507, 1239.5661518468464, 15425.151616660967, 15574.922125389301, 15593.532194034196, 15602.843971560365, 15857.682846343008, 619476.0, 625632.0, 634891.0, 635681.0, 637372.0, 63720.0, 64343.03485447722, 64379.67810161013, 64569.354306456335, 64650.0, 1356.5387768158873, 1565.8590726834411, 1596.7125917334758, 1599.8640115590072, 1606.2209828233065, 30477.23806904845, 31500.527492088095, 31639.0, 31998.68001319957, 32310.19224519406, 56585.0, 57179.71410142923, 57236.56908577319, 57316.42683573111, 57375.0, 469021.0, 512821.0, 522674.0, 522953.0, 526930.0, 25162.37094072663, 25350.873245633655, 25556.616650750624, 25598.8720056406, 28491.860325586746, 35581.93254202378, 43339.78330108329, 48184.75907620439, 48510.0, 51112.74443627758, 33433.665663343054, 35727.82136089303, 36179.63820361763, 37666.869993900225, 37705.245895082495, 38149.0, 38222.0, 38510.037249069, 38786.80606596949, 39118.608813911495, 37837.05407364838, 38298.04254893539, 39220.60779392169, 39249.8037509822, 39329.606703933736, 33600.49599256062, 33751.0, 34326.0, 34600.48099278462, 34614.0, 21348.573028539653, 25585.616215756407, 25668.614970775827, 25702.0, 25887.482250355264], "value": 19380.95947578782, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [413.8572192593554, 415.8565294973233, 419.895026243439, 423.5108449740549, 428.34677117395967, 19022.239110435585, 21279.787202127973, 21491.462713432153, 21543.46141346465, 22190.334289971288, 9978.251631127676, 11942.820857687142, 12408.565700200495, 12452.564160254371, 12491.812622810665, 5417.918731219035, 5618.12918997554, 5674.914876276838, 5695.857603559903, 5702.059160238556, 3625.29306785177, 4126.298529250034, 5544.362398324184, 6940.514164008521, 6946.097007389032, 6863.931360686379, 6897.965510172442, 6906.929425938963, 6920.792376228696, 6948.791536253895, 6206.224221972254, 6213.788311279302, 6226.346233645448, 6231.906521402183, 6459.321771214002, 4133.338665813455, 5864.472197502203, 6082.787102451437, 6125.081237814319, 6143.170671959273, 13998.440062397493, 14074.648133796634, 14257.78613320801, 14260.928695356457, 14313.713725725427, 2148.301801914384, 2248.392933907836, 2253.6281513550243, 2333.195047708538, 2380.4643955110137, 10210.030047145508, 10430.21773366993, 10718.678439646823, 12163.452644631012, 15589.766153507706, 1804.5669039430572, 1826.5251034730932, 1863.2081365419779, 1898.7531620889333, 1917.8465722742146, 76413.23586764117, 109269.0, 115850.0, 116199.0, 116808.41595792052, 10137.442440665835, 11614.535418583331, 11764.647060588197, 11924.940375298069, 11998.100142489347, 15850.0, 15952.521424357288, 15967.441139560293, 15971.680566388608, 15985.960912540648, 9445.858312125323, 9484.478353690612, 9502.762430939143, 9606.519674016272, 9660.420374777535, 8137.552434616035, 9295.584597316356, 9616.134547890584, 9624.845018597673, 9681.854772178423, 4908.04293162837, 4933.87665308363, 4948.8762780930765, 4983.451820299764, 5002.799888004439, 2018.3642152721845, 2046.8771873687626, 2052.794720527935, 2057.8353731701727, 2083.364558821318, 770.2220757035435, 822.1983566023199, 827.9875801862977, 922.7831459606987, 1085.6525911708336, 17973.281068757366, 20834.79165208359, 21384.78615213859, 21542.246021389175, 21634.78365216359, 1011.9241056920613, 1017.8422344536609, 1036.8237399642078, 1043.2905624175633, 1050.847627094067, 11002.33985960845, 11290.830637540443, 11312.886871131348, 11325.37710425918, 11333.8099499553, 623762.0, 635030.0, 640441.0, 646802.0, 651195.0, 132556.0, 133881.0, 135874.0, 136443.0, 140809.0, 1042.7914417116608, 1067.055655744656, 1082.653550863716, 1096.7313008313015, 1099.0712847643888, 18401.263949441873, 18573.0, 18576.907115464335, 18677.143942574756, 18769.34307299238, 49784.25323620076, 53499.197512036575, 54389.72805135949, 54865.72567137139, 56261.31216063524, 79897.6005119994, 83906.58046709727, 84911.5754421224, 85281.0, 86461.30669204003, 7028.718851246097, 8399.916000840158, 8416.579171041301, 8514.361422893184, 8526.147385261673, 9293.907060929574, 12313.26120432777, 12723.23660580368, 13181.143225690683, 13242.53651122206, 10894.891051089704, 11248.775024499628, 11573.363465009505, 11599.76800464003, 11636.650900473, 9695.078967498077, 10874.836877447004, 11077.0, 11419.429028548706, 11492.253003555077, 10933.56265749361, 11411.25826821254, 11636.709082273012, 11770.3526306054, 11832.526698931946, 8199.672013119647, 8440.282575981111, 8488.660453581788, 8488.957555212184, 8711.47731136134, 10041.49792510357, 11259.155563332619, 11465.770684586429, 11511.654650360502, 11617.767644647229], "value": 9592.405969286716, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1430.5565274764824, 1470.176701047413, 1653.066017699999, 1875.3061367294094, 2016.4857961219896, 8115.310198633116, 8669.69656062038, 8820.823583528341, 8825.11748825118, 8862.689805856797, 8306.169383061706, 8566.914330856689, 8573.52845593492, 8577.957110214456, 8584.527850968194, 2502.7372125926745, 2530.367408147963, 2533.1767175667887, 2534.4297533055005, 2536.822422430431, 2461.5569197544437, 2512.346789834647, 2522.3441905104714, 2524.368907773057, 2524.7096583892903, 2284.846152692896, 2360.492494113765, 2483.7019557653107, 2513.4847356291916, 2516.9119080832174, 2492.501499700067, 2518.8236823422367, 2528.190978886757, 2540.606206038067, 2541.7204107548155, 2059.5366042640435, 2456.7666071723156, 2502.199296225209, 2503.7996960243136, 2503.8873250703764, 8580.957095214546, 8634.222919937236, 8694.478331300143, 8699.347548933856, 8700.608472618747, 5493.890122197534, 5645.379008309083, 5709.0, 5716.685582292972, 5718.142278658193, 3627.6553727396117, 3685.207680348738, 3755.305268525304, 3764.2659681362147, 3773.0378753417704, 1048.963286284984, 1064.2975636080228, 1065.7868426314767, 1077.8167711489066, 1078.229066217658, 12199.39003049844, 12267.141300109086, 12271.141020128594, 12298.877011229863, 12311.322877241748, 4721.787519561559, 4779.474257831635, 4801.255805350176, 4801.98580582253, 4873.561379475864, 9652.613895444103, 9652.696885920452, 9660.75848103789, 9665.130138287588, 9672.274579406572, 5518.255035570227, 5551.417101204396, 5557.472040156179, 5559.63862348946, 5568.554515638739, 4546.249868771682, 4690.71855688653, 4945.530174633404, 5139.94631100631, 5173.974130129325, 3956.090099277182, 3966.3058964681063, 4033.838646454109, 4056.8377264909664, 4067.471228740304, 1241.1560139105316, 1248.7752204603078, 1251.6432816647211, 1257.6855786053486, 1263.5072321794507, 946.5456580841235, 977.9657711980046, 998.510729742421, 1000.9349392289623, 1004.6835246897203, 6047.0627052806, 6078.45293923549, 6167.259928808482, 6221.191245138103, 6355.777547785898, 461.3633186203018, 469.16254485742786, 469.98825029373853, 470.1701496858048, 471.8466498388038, 3995.1610161866333, 4025.9798701006307, 4056.6815784870037, 4069.654079403225, 4136.772477513706, 10485.9475702621, 10575.153987680967, 10631.893681063246, 10730.570777168827, 10743.838842417214, 10596.735081622866, 10596.993285637853, 10623.468826558641, 10627.04356607909, 10634.255602107778, 7989.480683755537, 8337.624806883827, 8353.874691879626, 8427.32581393487, 8448.0, 5831.562632802472, 5851.678157701367, 5884.08796636522, 5971.641701497924, 6024.277086749618, 9296.07039296092, 9524.571394287412, 9682.515874206121, 9688.321817472992, 9708.368956017835, 9321.906780932104, 9820.214382849497, 9838.65564705232, 9840.065193806577, 10154.086132248132, 6920.134983127109, 7050.118735158106, 7496.925030749622, 7630.236976302325, 7777.338926191111, 7027.262137475696, 8435.198656127657, 8487.915120848713, 8496.787580310294, 8501.0, 7366.1160660718915, 7516.586587737727, 7569.0, 7644.847103058019, 7689.6539655714505, 7630.122535908442, 7653.387728981556, 7683.078030636136, 7818.882716759367, 7828.256315650005, 7117.288271172842, 7151.0, 7168.856622867618, 7172.748953786592, 7173.497855150298, 5123.308353372247, 5138.177891537336, 5267.209918512254, 5358.035553600389, 5365.248865158803, 5413.350397952271, 5428.4842939920645, 5472.097103977958, 5492.258545096521, 5546.833594992157], "value": 4608.530505687229, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [332.75542476279935, 337.868231389758, 343.8515358701935, 343.87792333721546, 345.69578770681795, 6743.629100399482, 6791.185057793065, 6981.895271570917, 7003.0195772591815, 7021.473389495783, 6735.831604209885, 6738.898916516257, 6751.1898572171285, 6758.560693554916, 6787.694553745081, 4011.2178125265586, 4821.855344339667, 5005.17414626588, 5076.111680455924, 5084.720340381277, 4982.526659967298, 5042.420121685998, 5060.873478163057, 5061.645684802065, 5092.79628814847, 4985.1774457214515, 4991.151504244287, 4991.326170966928, 5012.69923804571, 5017.67385119966, 4749.978754567767, 4797.28040793882, 4941.728204948727, 4952.306677065214, 4958.132326842824, 3738.2897249522503, 4242.596953289432, 4250.659947204216, 4253.447051883235, 4261.808218630169, 5924.526037916957, 6418.19772528434, 6429.0, 6430.935690643128, 6441.0982462455295, 5917.52659787216, 5931.911021334683, 5991.5206783457215, 6060.545459090586, 6082.422169893853, 6810.523263371566, 7122.287771222888, 7122.821929451753, 7128.358447739728, 7172.139343278788, 3974.6621537169376, 4770.475247722748, 4809.951900480985, 4813.975930120327, 4816.494268101869, 7516.962415187889, 7604.771856844303, 7612.9999999999445, 7617.504862183996, 7628.0, 4924.60603151747, 4943.777530011158, 4943.876403089952, 4945.060438516671, 4950.950490495049, 5002.324686167321, 5003.874903127451, 5005.674631148963, 5013.39839219296, 5014.674046186986, 5747.568932330092, 5971.223740913741, 5971.671558064261, 5985.16207730918, 6001.879962400728, 7216.061911951413, 7227.710891564384, 7236.674349654279, 7262.636868156676, 7276.199618042011, 1728.7579738836573, 1760.586262228401, 1761.1370428489947, 1761.2162587648374, 1764.0738612228683, 1049.6378749331468, 1113.1150735165563, 1116.190761697779, 1141.7944769941491, 1152.1392950385068, 5696.8006119785605, 6427.614343139427, 6548.410643042053, 6565.967170164214, 6611.900821487681, 7401.370883474858, 7582.507137036075, 7595.164531901486, 7608.771736847903, 7659.693612255559, 6892.1729392472225, 6907.792766217021, 6909.585424874524, 6923.4807389446, 6923.653817309114, 3890.8365986113663, 3967.107400834789, 4020.8793736187963, 4026.7181297309494, 4026.9395959060053, 7772.65023073963, 7901.0, 7920.32677222431, 7930.444868859125, 7930.722424715107, 7743.7676869694, 7792.259735325135, 7796.4542482026845, 7800.024996875391, 7803.68785248595, 6640.269570347258, 7648.847023059619, 7870.212978702084, 7889.171636978034, 7889.763307100796, 7198.064251647253, 7536.359409450258, 7537.982372379659, 7540.3213710766295, 7614.466987310835, 7421.6269990052015, 7429.665665044978, 7449.106107266946, 7449.851002980018, 7475.2151024141685, 6920.30796920304, 7346.045014148127, 7908.051033875971, 7915.722949696733, 7937.880931786143, 4709.693869898446, 4759.6430267729365, 4767.141914455431, 4771.069641420028, 4777.044591081867, 7134.607596582237, 7447.366973807287, 7542.358899493604, 7546.584937828253, 7558.58427786455, 6280.685965701788, 6636.634985075674, 7205.495615307088, 7231.385332246818, 7292.635368231461, 5713.971430142823, 5997.890390277813, 7216.458765592497, 7238.855222895618, 7239.927600723925, 5684.658920464785, 7020.403265722471, 7065.975433562207, 7106.680199390937, 7118.537295075804, 5017.347744793154, 5913.970430147821, 7042.7887163385185, 7230.819229519304, 7233.1681856587165, 6814.897776533257, 6957.304269573205, 6967.198772141269, 7098.964505177441, 7183.102112235971], "value": 5278.483695722928, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [704.566691484737, 717.2039036669297, 731.1482123326325, 767.501124269225, 774.0827119862963, 15658.451954181606, 15826.129562874037, 15874.04755714658, 15882.444114455997, 15894.841051589481, 14466.059706119095, 14649.97450178488, 14653.0, 14653.560393188194, 14657.486987955424, 787.1852632525338, 804.778685861387, 949.0462085603958, 975.556121964508, 981.7889153831925, 964.4936408385583, 971.2861047130353, 975.5414954971152, 978.9363691360074, 979.0405402705353, 837.1670188162786, 1043.1133536493996, 1043.7651528406086, 1044.9634262800803, 1046.691226088302, 1017.6082208349765, 1025.1542477456092, 1025.9794804103876, 1027.1320733979776, 1032.9845052324222, 766.1648802804914, 767.0909971683517, 767.4052609227838, 769.2768797330548, 778.241214815556, 15329.386824527006, 15413.152276624782, 15436.45972390961, 15455.0, 15479.767803482957, 12979.091463597551, 13278.734425311537, 13369.0, 13405.731885362238, 13716.931415342859, 10406.687799366031, 10487.895121048768, 10527.578896844194, 10703.732406689816, 10795.29830561011, 3633.5276414066266, 3661.3958696814993, 3679.35611268027, 3715.2198038411966, 3865.0530619998, 80214.59892700557, 80923.59538202272, 81347.0, 81685.18314816835, 82999.92500187483, 9771.657991970247, 9815.950920245354, 9976.102150806462, 9976.301658883953, 10644.414557199274, 22587.548249034928, 22589.548209036057, 22618.547629047327, 22629.773702262766, 22731.772682273295, 7630.809229769189, 7768.7669369918995, 8057.6374063167295, 8184.263416292562, 8193.79515512117, 4024.5975402460103, 4126.546079931205, 4141.378793181047, 4170.416141740159, 4445.911081778347, 3675.4486826976167, 3732.309522738248, 3734.775913445202, 3737.1591391936595, 3741.139537906297, 611.9785807496717, 651.205529254309, 683.9555428897205, 718.6263143165629, 740.0490369874685, 605.7395320012437, 610.9552664942909, 614.0727501472808, 617.6109051297653, 645.3610925184034, 8433.662653493915, 8539.018012928469, 8543.102974187621, 8644.654213831502, 8801.911980880237, 549.3051290118004, 610.4719417703654, 629.7764293675771, 632.9810105696837, 654.2770238886058, 3795.886123416302, 3964.920701585952, 4005.7796821175116, 4139.523954745183, 4281.314989601648, 98184.50907745559, 98933.50533247432, 100496.99503005022, 100570.49714751526, 100647.0, 81107.0, 83348.0, 83558.16441835504, 84823.15176848276, 85059.57470212609, 74203.62898185475, 74452.0, 75163.62418187874, 75615.62192189114, 77195.61402192953, 8070.798230044295, 8146.5519396433765, 8151.0, 8259.876101858597, 8316.251537361666, 37912.81043594764, 45215.0, 47677.80805479891, 48139.27791083207, 50629.0, 48096.51903480921, 60962.08556871739, 67686.6462670734, 70564.29435705577, 71326.57346853138, 9048.823652925077, 10081.143102836048, 10291.228157888338, 10492.632757853744, 10536.57853685844, 9173.587188576663, 11254.606088786853, 11638.88361116378, 11655.125865559947, 11688.590899318484, 9091.85581171604, 9931.404115752788, 10164.33931794431, 10184.847227291448, 10226.948865255627, 11447.942760286145, 11647.941760291144, 11703.824442633537, 11738.765224695288, 11977.041836653221, 11277.21059525858, 11320.716982075513, 11345.602903898323, 11526.0, 11927.9264866159, 9498.0, 9511.809763804547, 9650.613975440903, 9705.757356065873, 9828.4102953823, 9372.1565059145, 9615.759606009626, 9703.854442183232, 9897.65358212459, 9936.751581210528], "value": 7089.674033480455, "unit": "score"}], "name": "dromaeo_css", "value": 7563.204341486728, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 113.0, 121.0, 114.0, 113.0, 111.0, 115.0, 113.0, 112.0, 134.0], "value": 115.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 125.0, 176.0, 201.0, 131.0, 140.0, 137.0, 117.0, 169.0, 117.0], "value": 147.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 188.0, 185.0, 183.0, 186.0, 216.0, 244.0, 185.0, 187.0, 184.0], "value": 194.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 92.0, 104.0, 197.0, 56.0, 56.0, 55.0, 60.0, 130.0, 55.0], "value": 88.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 93.0, 144.0, 77.0, 78.0, 77.0, 127.0, 61.0, 72.0, 138.0], "value": 95.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 108.0, 86.0, 84.0, 85.0, 84.0, 87.0, 85.0, 86.0, 83.0], "value": 89.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 92.0, 91.0, 92.0, 92.0, 92.0, 92.0, 102.0, 88.0, 129.0], "value": 96.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 84.0, 96.0, 133.0, 141.0, 84.0, 85.0, 83.0, 84.0, 84.0], "value": 95.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 61.0, 61.0, 61.0, 62.0, 61.0, 62.0, 80.0, 58.0, 54.0], "value": 61.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 63.0, 67.0, 70.0, 69.0, 69.0, 57.0, 63.0, 96.0, 96.0], "value": 71.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 78.0, 80.0, 79.0, 80.0, 78.0, 79.0, 78.0, 81.0, 84.0], "value": 79.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [127.0, 127.0, 126.0, 126.0, 123.0, 128.0, 124.0, 128.0, 146.0, 128.0], "value": 128.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 163.0, 164.0, 211.0, 213.0, 203.0, 155.0, 159.0, 161.0, 162.0], "value": 175.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 67.0, 67.0, 67.0, 66.0, 66.0, 68.0, 66.0, 66.0], "value": 66.4, "unit": "score"}], "name": "kraken", "value": 1504.5000000000002, "alertThreshold": 2.0}]} 16:34:42 INFO - Return code: 0 16:34:42 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 16:34:42 ERROR - # TBPL SUCCESS # 16:34:42 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 16:34:42 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 16:34:42 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 16:34:42 INFO - 2016-06-08 16:34:42.437 screenresolution[1675:9648] starting screenresolution argv=screenresolution get 16:34:42 INFO - 2016-06-08 16:34:42.439 screenresolution[1675:9648] Display 0: 1600x1200x32@60 16:34:42 INFO - 2016-06-08 16:34:42.445 screenresolution[1676:9651] starting screenresolution argv=screenresolution list 16:34:42 INFO - Available Modes on Display 0 16:34:42 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 16:34:42 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 16:34:42 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 16:34:42 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 16:34:42 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 16:34:42 INFO - Intel Iris: 16:34:42 INFO - Chipset Model: Intel Iris 16:34:42 INFO - Type: GPU 16:34:42 INFO - Bus: Built-In 16:34:42 INFO - VRAM (Dynamic, Max): 1536 MB 16:34:42 INFO - Vendor: Intel (0x8086) 16:34:42 INFO - Device ID: 0x0a2e 16:34:42 INFO - Revision ID: 0x0009 16:34:42 INFO - Displays: 16:34:42 INFO - Display: 16:34:42 INFO - Resolution: 1600 x 1200 @ 60 Hz 16:34:42 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 16:34:42 INFO - Display Serial Number: 1600x1200 60 16:34:42 INFO - Main Display: Yes 16:34:42 INFO - Mirror: Off 16:34:42 INFO - Online: Yes 16:34:42 INFO - Rotation: Supported 16:34:42 INFO - Return code: 0 16:34:42 INFO - Running post-action listener: _resource_record_post_action 16:34:42 INFO - Running post-run listener: _resource_record_post_run 16:34:43 INFO - Total resource usage - Wall time: 1196s; CPU: 52.0%; Read bytes: 37147136; Write bytes: 494704640; Read time: 381; Write time: 1874 16:34:43 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 182981120; Write bytes: 178128896; Read time: 16479; Write time: 435 16:34:43 INFO - run-tests - Wall time: 1175s; CPU: 52.0%; Read bytes: 36188672; Write bytes: 297242624; Read time: 364; Write time: 1389 16:34:43 INFO - Running post-run listener: _upload_blobber_files 16:34:43 INFO - Blob upload gear active. 16:34:43 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:34: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 16:34: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'] 16:34: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 16:34:44 INFO - (blobuploader) - INFO - Open directory for files ... 16:34:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 16:34:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:34:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:34:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 16:34:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:34:45 INFO - (blobuploader) - INFO - Done attempting. 16:34:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 16:34:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:34:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:34:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 16:34:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:34:47 INFO - (blobuploader) - INFO - Done attempting. 16:34:47 INFO - (blobuploader) - INFO - Iteration through files over. 16:34:47 INFO - Return code: 0 16:34:47 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:34:47 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:34:47 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/495bd224623863ff7e6d41ddf51a60ec1d2d4bdfb58b04acc903bd4cadfe88dc4e8cfb9c28d4fcaaed5e8af6caab10adb36e7512de0922adce395cc43c80ba69", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7ab69fb3855d2b8c02afd737c39778b61ee3220c84776016932b953280855bec840fd822cc4dc28d920c5a679d1b0491e09fc7cdc5900e60313327a03634e121"} 16:34:47 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:34:47 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:34:47 INFO - Contents: 16:34:47 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/495bd224623863ff7e6d41ddf51a60ec1d2d4bdfb58b04acc903bd4cadfe88dc4e8cfb9c28d4fcaaed5e8af6caab10adb36e7512de0922adce395cc43c80ba69", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7ab69fb3855d2b8c02afd737c39778b61ee3220c84776016932b953280855bec840fd822cc4dc28d920c5a679d1b0491e09fc7cdc5900e60313327a03634e121"} 16:34:47 INFO - Running post-run listener: copy_logs_to_upload_dir 16:34:47 INFO - Copying logs to upload dir... 16:34:47 INFO - mkdir: /builds/slave/test/build/upload/logs 16:34:47 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1256.399292 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2016-06-08 16:34:47.147729) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-08 16:34:47.151200) ========= 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.7HaBMoVrRl/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.X1g0tiZCmP/Listeners TMPDIR=/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/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/495bd224623863ff7e6d41ddf51a60ec1d2d4bdfb58b04acc903bd4cadfe88dc4e8cfb9c28d4fcaaed5e8af6caab10adb36e7512de0922adce395cc43c80ba69", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7ab69fb3855d2b8c02afd737c39778b61ee3220c84776016932b953280855bec840fd822cc4dc28d920c5a679d1b0491e09fc7cdc5900e60313327a03634e121"} build_url:https://queue.taskcluster.net/v1/task/SrroKRRKShivdQ8FW3uzGA/artifacts/public/build/firefox-48.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011072 build_url: 'https://queue.taskcluster.net/v1/task/SrroKRRKShivdQ8FW3uzGA/artifacts/public/build/firefox-48.0.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/495bd224623863ff7e6d41ddf51a60ec1d2d4bdfb58b04acc903bd4cadfe88dc4e8cfb9c28d4fcaaed5e8af6caab10adb36e7512de0922adce395cc43c80ba69", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7ab69fb3855d2b8c02afd737c39778b61ee3220c84776016932b953280855bec840fd822cc4dc28d920c5a679d1b0491e09fc7cdc5900e60313327a03634e121"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-08 16:34:47.185884) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 16:34:47.186214) ========= 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.7HaBMoVrRl/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.X1g0tiZCmP/Listeners TMPDIR=/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/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.005139 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 16:34:47.234712) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-08 16:34:47.235028) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-08 16:34:47.235423) ========= ========= Total master_lag: 2.22 =========