builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-052 starttime: 1494021671.94 results: success (0) revision: ff83fde8be946eabcf27ea97d4676f601c122194 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-05 15:01:11.943854) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-05 15:01:11.944347) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-05 15:01:11.944619) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-05 15:01:11.962042) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-05 15:01:11.962437) ========= 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: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=826874ccc97bd7bf541b4875000001d5-1494021671.550139-2105730831 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-05-05 15:01:12-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 50.1M=0s 2017-05-05 15:01:12 (50.1 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.129762 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-05 15:01:12.106962) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-05 15:01:12.110328) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=826874ccc97bd7bf541b4875000001d5-1494021671.550139-2105730831 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020115 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-05 15:01:12.160171) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-05 15:01:12.163539) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev ff83fde8be946eabcf27ea97d4676f601c122194 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo mozilla-central --rev ff83fde8be946eabcf27ea97d4676f601c122194 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=826874ccc97bd7bf541b4875000001d5-1494021671.550139-2105730831 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-05-05 15:01:12,649 truncating revision to first 12 chars 2017-05-05 15:01:12,649 Setting DEBUG logging. 2017-05-05 15:01:12,649 attempt 1/10 2017-05-05 15:01:12,649 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/ff83fde8be94?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-05 15:01:13,034 unpacking tar archive at: mozilla-central-ff83fde8be94/testing/mozharness/ program finished with exit code 0 elapsedTime=0.786169 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-05 15:01:12.963126) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-05 15:01:12.966479) ========= script_repo_revision: ff83fde8be946eabcf27ea97d4676f601c122194 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-05 15:01:12.966842) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-05 15:01:12.967095) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-05 15:01:12.978051) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2017-05-05 15:01:12.978405) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=826874ccc97bd7bf541b4875000001d5-1494021671.550139-2105730831 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:01:13 INFO - MultiFileLogger online at 20170505 15:01:13 in /builds/slave/test 15:01:13 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 15:01:13 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:01:13 INFO - {'append_to_log': False, 15:01:13 INFO - 'base_work_dir': '/builds/slave/test', 15:01:13 INFO - 'blob_upload_branch': 'Firefox', 15:01:13 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:01:13 INFO - 'branch': 'Firefox', 15:01:13 INFO - 'buildbot_json_path': 'buildprops.json', 15:01:13 INFO - 'config_files': ('talos/linux_config.py',), 15:01:13 INFO - 'default_actions': ('clobber', 15:01:13 INFO - 'read-buildbot-config', 15:01:13 INFO - 'download-and-extract', 15:01:13 INFO - 'populate-webroot', 15:01:13 INFO - 'create-virtualenv', 15:01:13 INFO - 'install', 15:01:13 INFO - 'run-tests'), 15:01:13 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:01:13 INFO - 'download_minidump_stackwalk': True, 15:01:13 INFO - 'download_symbols': 'ondemand', 15:01:13 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:01:13 INFO - 'tooltool.py': '/tools/tooltool.py', 15:01:13 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:01:13 INFO - '/tools/misc-python/virtualenv.py')}, 15:01:13 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:01:13 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:01:13 INFO - 'gecko_profile': False, 15:01:13 INFO - 'gecko_profile_interval': 0, 15:01:13 INFO - 'installer_path': 'installer.exe', 15:01:13 INFO - 'log_level': 'info', 15:01:13 INFO - 'log_name': 'talos', 15:01:13 INFO - 'log_to_console': True, 15:01:13 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:01:13 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:01:13 INFO - 'opt_config_files': (), 15:01:13 INFO - 'pip_index': False, 15:01:13 INFO - 'suite': 'dromaeojs', 15:01:13 INFO - 'system_bits': '32', 15:01:13 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:01:13 INFO - 'title': 'talos-linux64-ix-052', 15:01:13 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:01:13 INFO - 'use_talos_json': True, 15:01:13 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:01:13 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:01:13 INFO - 'work_dir': 'build'} 15:01:13 INFO - [mozharness: 2017-05-05 22:01:13.554632Z] Running clobber step. 15:01:13 INFO - Running pre-action listener: _resource_record_pre_action 15:01:13 INFO - Running main action method: clobber 15:01:13 INFO - rmtree: /builds/slave/test/build 15:01:13 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:01:15 INFO - Running post-action listener: _resource_record_post_action 15:01:15 INFO - [mozharness: 2017-05-05 22:01:15.146356Z] Finished clobber step (success) 15:01:15 INFO - [mozharness: 2017-05-05 22:01:15.146456Z] Running read-buildbot-config step. 15:01:15 INFO - Running pre-action listener: _resource_record_pre_action 15:01:15 INFO - Running main action method: read_buildbot_config 15:01:15 INFO - Using buildbot properties: 15:01:15 INFO - { 15:01:15 INFO - "project": "", 15:01:15 INFO - "product": "firefox", 15:01:15 INFO - "who": "kwierso@gmail.com", 15:01:15 INFO - "installer_path": "public/build/target.tar.bz2", 15:01:15 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 15:01:15 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 15:01:15 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 15:01:15 INFO - "stage_platform": "linux64-pgo", 15:01:15 INFO - "basedir": "/builds/slave/test", 15:01:15 INFO - "buildnumber": 168, 15:01:15 INFO - "platform": "ubuntu64_hw", 15:01:15 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 15:01:15 INFO - "slavebuilddir": "test", 15:01:15 INFO - "taskId": "J1odgg2ITGWDl6sS7XJBRQ", 15:01:15 INFO - "branch": "mozilla-central", 15:01:15 INFO - "script_repo_revision": "production", 15:01:15 INFO - "revision": "ff83fde8be946eabcf27ea97d4676f601c122194", 15:01:15 INFO - "slavename": "talos-linux64-ix-052", 15:01:15 INFO - "repo_path": "mozilla-central" 15:01:15 INFO - } 15:01:15 INFO - Finding installer, test and symbols from parent task. 15:01:15 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/J1odgg2ITGWDl6sS7XJBRQ'}, attempt #1 15:01:15 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/J1odgg2ITGWDl6sS7XJBRQ'}, attempt #1 15:01:16 INFO - Task dependencies: aCGisYsrQDiwGShbAkUgJg 15:01:16 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/aCGisYsrQDiwGShbAkUgJg'}, attempt #1 15:01:16 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/aCGisYsrQDiwGShbAkUgJg/artifacts/public/build/target.tar.bz2 15:01:16 INFO - Set test_url: https://queue.taskcluster.net/v1/task/aCGisYsrQDiwGShbAkUgJg/artifacts/public/build/test_packages.json 15:01:16 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/aCGisYsrQDiwGShbAkUgJg/artifacts/public/build/target.crashreporter-symbols.zip 15:01:16 INFO - Running post-action listener: _resource_record_post_action 15:01:16 INFO - [mozharness: 2017-05-05 22:01:16.546296Z] Finished read-buildbot-config step (success) 15:01:16 INFO - [mozharness: 2017-05-05 22:01:16.546515Z] Running download-and-extract step. 15:01:16 INFO - Running pre-action listener: _resource_record_pre_action 15:01:16 INFO - Running main action method: download_and_extract 15:01:16 INFO - mkdir: /builds/slave/test/build/tests 15:01: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:01:16 INFO - trying https://queue.taskcluster.net/v1/task/aCGisYsrQDiwGShbAkUgJg/artifacts/public/build/target.test_packages.json 15:01:16 INFO - Downloading https://queue.taskcluster.net/v1/task/aCGisYsrQDiwGShbAkUgJg/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 15:01:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/aCGisYsrQDiwGShbAkUgJg/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 15:01:17 INFO - Downloaded 986 bytes. 15:01:17 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 15:01:17 INFO - Using the following test package requirements: 15:01:17 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 15:01:17 INFO - u'common': [u'target.common.tests.zip'], 15:01:17 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 15:01:17 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 15:01:17 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 15:01:17 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 15:01:17 INFO - u'mozbase': [u'target.common.tests.zip'], 15:01:17 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 15:01:17 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 15:01:17 INFO - u'web-platform': [u'target.common.tests.zip', 15:01:17 INFO - u'target.web-platform.tests.zip'], 15:01:17 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 15:01:17 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 15:01:17 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/aCGisYsrQDiwGShbAkUgJg/artifacts/public/build/target.common.tests.zip 15:01:17 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/aCGisYsrQDiwGShbAkUgJg/artifacts/public/build/target.common.tests.zip'}, attempt #1 15:01:17 INFO - Fetch https://queue.taskcluster.net/v1/task/aCGisYsrQDiwGShbAkUgJg/artifacts/public/build/target.common.tests.zip into memory 15:01:18 INFO - Content-Length response header: 60561851 15:01:18 INFO - Bytes received: 60561851 15:01:28 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 15:01:28 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/aCGisYsrQDiwGShbAkUgJg/artifacts/public/build/target.common.tests.zip 15:01:28 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/aCGisYsrQDiwGShbAkUgJg/artifacts/public/build/target.common.tests.zip'}, attempt #1 15:01:28 INFO - Fetch https://queue.taskcluster.net/v1/task/aCGisYsrQDiwGShbAkUgJg/artifacts/public/build/target.common.tests.zip into memory 15:01:29 INFO - Content-Length response header: 60561851 15:01:29 INFO - Bytes received: 60561851 15:01:40 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/aCGisYsrQDiwGShbAkUgJg/artifacts/public/build/target.talos.tests.zip 15:01:40 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/aCGisYsrQDiwGShbAkUgJg/artifacts/public/build/target.talos.tests.zip'}, attempt #1 15:01:40 INFO - Fetch https://queue.taskcluster.net/v1/task/aCGisYsrQDiwGShbAkUgJg/artifacts/public/build/target.talos.tests.zip into memory 15:01:40 INFO - Content-Length response header: 14408697 15:01:40 INFO - Bytes received: 14408697 15:01: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:01:41 INFO - trying https://queue.taskcluster.net/v1/task/aCGisYsrQDiwGShbAkUgJg/artifacts/public/build/target.tar.bz2 15:01:41 INFO - Downloading https://queue.taskcluster.net/v1/task/aCGisYsrQDiwGShbAkUgJg/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 15:01:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/aCGisYsrQDiwGShbAkUgJg/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 15:01:42 INFO - Downloaded 63980526 bytes. 15:01:42 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/aCGisYsrQDiwGShbAkUgJg/artifacts/public/build/target.tar.bz2 15:01:42 INFO - mkdir: /builds/slave/test/properties 15:01:42 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:01:42 INFO - Writing to file /builds/slave/test/properties/build_url 15:01:42 INFO - Contents: 15:01:42 INFO - build_url:https://queue.taskcluster.net/v1/task/aCGisYsrQDiwGShbAkUgJg/artifacts/public/build/target.tar.bz2 15:01:42 INFO - Running post-action listener: _resource_record_post_action 15:01:42 INFO - Running post-action listener: set_extra_try_arguments 15:01:42 INFO - [mozharness: 2017-05-05 22:01:42.267446Z] Finished download-and-extract step (success) 15:01:42 INFO - [mozharness: 2017-05-05 22:01:42.267543Z] Running populate-webroot step. 15:01:42 INFO - Running pre-action listener: _resource_record_pre_action 15:01:42 INFO - Running main action method: populate_webroot 15:01:42 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:01:42 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:01:42 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:01:42 INFO - '--tppagecycles', 15:01:42 INFO - '7'], 15:01:42 INFO - 'tests': ['tsvgm']}}, 15:01:42 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:01:42 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:01:42 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:01:42 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:01:42 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:01:42 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:01:42 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 15:01:42 INFO - 'talos_options': ['--disable-e10s'], 15:01:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:01:42 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 15:01:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:01:42 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 15:01:42 INFO - 'talos_options': ['--disable-e10s'], 15:01:42 INFO - 'tests': ['damp', 'tps']}, 15:01:42 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 15:01:42 INFO - 'tests': ['damp', 'tps']}, 15:01:42 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:01:42 INFO - 'tests': ['dromaeo_dom']}, 15:01:42 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:01:42 INFO - 'g4': {'talos_options': ['--disable-e10s'], 15:01:42 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 15:01:42 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 15:01:42 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:01:42 INFO - 'tests': ['a11yr', 15:01:42 INFO - 'ts_paint', 15:01:42 INFO - 'tpaint', 15:01:42 INFO - 'sessionrestore', 15:01:42 INFO - 'sessionrestore_no_auto_restore', 15:01:42 INFO - 'tabpaint']}, 15:01:42 INFO - 'other-e10s': {'tests': ['a11yr', 15:01:42 INFO - 'ts_paint', 15:01:42 INFO - 'tpaint', 15:01:42 INFO - 'sessionrestore', 15:01:42 INFO - 'sessionrestore_no_auto_restore', 15:01:42 INFO - 'tabpaint']}, 15:01:42 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:01:42 INFO - 'ts_paint', 15:01:42 INFO - 'tpaint', 15:01:42 INFO - 'sessionrestore', 15:01:42 INFO - 'sessionrestore_no_auto_restore', 15:01:42 INFO - 'tabpaint']}, 15:01:42 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:01:42 INFO - 'ts_paint', 15:01:42 INFO - 'tpaint', 15:01:42 INFO - 'sessionrestore', 15:01:42 INFO - 'sessionrestore_no_auto_restore', 15:01:42 INFO - 'tabpaint']}, 15:01:42 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:01:42 INFO - 'tests': ['a11yr', 15:01:42 INFO - 'ts_paint', 15:01:42 INFO - 'tpaint', 15:01:42 INFO - 'sessionrestore', 15:01:42 INFO - 'sessionrestore_no_auto_restore', 15:01:42 INFO - 'tabpaint']}, 15:01:42 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:01:42 INFO - 'tests': ['a11yr', 15:01:42 INFO - 'ts_paint', 15:01:42 INFO - 'tpaint', 15:01:42 INFO - 'sessionrestore', 15:01:42 INFO - 'sessionrestore_no_auto_restore', 15:01:42 INFO - 'tabpaint']}, 15:01:42 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 15:01:42 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 15:01:42 INFO - 'bloom_basic_ref']}, 15:01:42 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:01:42 INFO - 'tests': ['tsvgx', 15:01:42 INFO - 'tsvgr_opacity', 15:01:42 INFO - 'tart', 15:01:42 INFO - 'tscrollx', 15:01:42 INFO - 'cart', 15:01:42 INFO - 'tsvg_static']}, 15:01:42 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:01:42 INFO - 'tsvgr_opacity', 15:01:42 INFO - 'tart', 15:01:42 INFO - 'tscrollx', 15:01:42 INFO - 'cart', 15:01:42 INFO - 'tsvg_static']}, 15:01:42 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 15:01:42 INFO - 'talos_options': ['--disable-e10s'], 15:01:42 INFO - 'tests': ['tp5o']}, 15:01:42 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 15:01:42 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 15:01:42 INFO - 'talos_options': ['--disable-e10s', 15:01:42 INFO - '--xperf_path', 15:01:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:01:42 INFO - 'tests': ['tp5n']}, 15:01:42 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 15:01:42 INFO - 'talos_options': ['--xperf_path', 15:01:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:01:42 INFO - 'tests': ['tp5n']}}, 15:01:42 INFO - 'talos.zip': {'path': '', 15:01:42 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:01:42 INFO - Running post-action listener: _resource_record_post_action 15:01:42 INFO - [mozharness: 2017-05-05 22:01:42.281340Z] Finished populate-webroot step (success) 15:01:42 INFO - [mozharness: 2017-05-05 22:01:42.281448Z] Running create-virtualenv step. 15:01:42 INFO - Running pre-action listener: _resource_record_pre_action 15:01:42 INFO - Running main action method: create_virtualenv 15:01:42 INFO - Creating virtualenv /builds/slave/test/build/venv 15:01:42 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 15:01:42 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:01:42 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:01:42 INFO - Using real prefix '/usr' 15:01:42 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:01:42 INFO - Installing distribute.............................................................................................................................................................................................done. 15:01:44 INFO - Installing pip.................done. 15:01:44 INFO - Return code: 0 15:01:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 15:01:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 15:01:45 INFO - Reading from file tmpfile_stdout 15:01:45 INFO - Output received: 15:01:45 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 15:01:45 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:01:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:01:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:01:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:01:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:01:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:01:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:01:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f561f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f93a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21f4310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21f1400>, '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 0x21f23b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21f2840>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1494021671.550139-2105730831', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:01:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 15:01:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 15:01:45 INFO - Using env: {'DISPLAY': ':0', 15:01:45 INFO - 'HOME': '/home/cltbld', 15:01:45 INFO - 'LANG': 'en_US.UTF-8', 15:01:45 INFO - 'LANGUAGE': 'en_US:en', 15:01:45 INFO - 'LOGNAME': 'cltbld', 15:01:45 INFO - 'MAIL': '/var/mail/cltbld', 15:01:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:01:45 INFO - 'MOZ_NO_REMOTE': '1', 15:01:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:01:45 INFO - 'NO_EM_RESTART': '1', 15:01:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:01:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:01:45 INFO - 'PWD': '/builds/slave/test', 15:01:45 INFO - 'SHELL': '/bin/bash', 15:01:45 INFO - 'SHLVL': '1', 15:01:45 INFO - 'TERM': 'linux', 15:01:45 INFO - 'TMOUT': '86400', 15:01:45 INFO - 'USER': 'cltbld', 15:01:45 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1494021671.550139-2105730831', 15:01:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:01:45 INFO - '_': '/tools/buildbot/bin/python'} 15:01:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:01:45 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 15:01:45 INFO - Cleaning up... 15:01:45 INFO - Return code: 0 15:01:45 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:01:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:01:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:01:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:01:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:01:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:01:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:01:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f561f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f93a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21f4310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21f1400>, '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 0x21f23b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21f2840>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1494021671.550139-2105730831', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:01:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 15:01:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 15:01:45 INFO - Using env: {'DISPLAY': ':0', 15:01:45 INFO - 'HOME': '/home/cltbld', 15:01:45 INFO - 'LANG': 'en_US.UTF-8', 15:01:45 INFO - 'LANGUAGE': 'en_US:en', 15:01:45 INFO - 'LOGNAME': 'cltbld', 15:01:45 INFO - 'MAIL': '/var/mail/cltbld', 15:01:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:01:45 INFO - 'MOZ_NO_REMOTE': '1', 15:01:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:01:45 INFO - 'NO_EM_RESTART': '1', 15:01:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:01:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:01:45 INFO - 'PWD': '/builds/slave/test', 15:01:45 INFO - 'SHELL': '/bin/bash', 15:01:45 INFO - 'SHLVL': '1', 15:01:45 INFO - 'TERM': 'linux', 15:01:45 INFO - 'TMOUT': '86400', 15:01:45 INFO - 'USER': 'cltbld', 15:01:45 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1494021671.550139-2105730831', 15:01:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:01:45 INFO - '_': '/tools/buildbot/bin/python'} 15:01:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:01:45 INFO - Downloading/unpacking psutil>=3.1.1 15:01:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:01:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:01:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:01:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:01:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:01:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:01:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:01:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:01:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:01:46 INFO - Installing collected packages: psutil 15:01:46 INFO - Running setup.py install for psutil 15:01:46 INFO - building 'psutil._psutil_linux' extension 15:01:46 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 15:01:46 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 15:01:46 INFO - building 'psutil._psutil_posix' extension 15:01:46 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 15:01:47 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 15:01:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:01:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:01:47 INFO - Successfully installed psutil 15:01:47 INFO - Cleaning up... 15:01:47 INFO - Return code: 0 15:01:47 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:01:47 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:01:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:01:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:01:47 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:01:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:01:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:01:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f561f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f93a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21f4310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21f1400>, '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 0x21f23b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21f2840>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1494021671.550139-2105730831', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:01:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 15:01:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 15:01:47 INFO - Using env: {'DISPLAY': ':0', 15:01:47 INFO - 'HOME': '/home/cltbld', 15:01:47 INFO - 'LANG': 'en_US.UTF-8', 15:01:47 INFO - 'LANGUAGE': 'en_US:en', 15:01:47 INFO - 'LOGNAME': 'cltbld', 15:01:47 INFO - 'MAIL': '/var/mail/cltbld', 15:01:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:01:47 INFO - 'MOZ_NO_REMOTE': '1', 15:01:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:01:47 INFO - 'NO_EM_RESTART': '1', 15:01:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:01:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:01:47 INFO - 'PWD': '/builds/slave/test', 15:01:47 INFO - 'SHELL': '/bin/bash', 15:01:47 INFO - 'SHLVL': '1', 15:01:47 INFO - 'TERM': 'linux', 15:01:47 INFO - 'TMOUT': '86400', 15:01:47 INFO - 'USER': 'cltbld', 15:01:47 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1494021671.550139-2105730831', 15:01:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:01:47 INFO - '_': '/tools/buildbot/bin/python'} 15:01:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:01:47 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:01:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:01:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:01:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:01:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:01:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:01:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:01:48 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:01:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:01:48 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:01:48 INFO - Installing collected packages: mozsystemmonitor 15:01:48 INFO - Running setup.py install for mozsystemmonitor 15:01:48 INFO - Successfully installed mozsystemmonitor 15:01:48 INFO - Cleaning up... 15:01:48 INFO - Return code: 0 15:01:48 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:01:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:01:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:01:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:01:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:01:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:01:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:01:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f561f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f93a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21f4310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21f1400>, '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 0x21f23b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21f2840>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1494021671.550139-2105730831', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:01:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 15:01:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 15:01:48 INFO - Using env: {'DISPLAY': ':0', 15:01:48 INFO - 'HOME': '/home/cltbld', 15:01:48 INFO - 'LANG': 'en_US.UTF-8', 15:01:48 INFO - 'LANGUAGE': 'en_US:en', 15:01:48 INFO - 'LOGNAME': 'cltbld', 15:01:48 INFO - 'MAIL': '/var/mail/cltbld', 15:01:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:01:48 INFO - 'MOZ_NO_REMOTE': '1', 15:01:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:01:48 INFO - 'NO_EM_RESTART': '1', 15:01:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:01:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:01:48 INFO - 'PWD': '/builds/slave/test', 15:01:48 INFO - 'SHELL': '/bin/bash', 15:01:48 INFO - 'SHLVL': '1', 15:01:48 INFO - 'TERM': 'linux', 15:01:48 INFO - 'TMOUT': '86400', 15:01:48 INFO - 'USER': 'cltbld', 15:01:48 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1494021671.550139-2105730831', 15:01:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:01:48 INFO - '_': '/tools/buildbot/bin/python'} 15:01:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:01:48 INFO - Downloading/unpacking jsonschema==2.5.1 15:01:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:01:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:01:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:01:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:01:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:01:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:01:49 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:01:49 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:01:49 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 15:01:49 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 15:01:49 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 15:01:49 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 15:01:49 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 15:01:49 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 15:01:50 INFO - Downloading functools32-3.2.3-2.tar.gz 15:01:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:01:50 INFO - warning: no files found matching '*.txt' 15:01:50 INFO - no previously-included directories found matching 'build' 15:01:50 INFO - no previously-included directories found matching 'dist' 15:01:50 INFO - no previously-included directories found matching '.git*' 15:01:50 INFO - Installing collected packages: jsonschema, functools32 15:01:50 INFO - Running setup.py install for functools32 15:01:50 INFO - warning: no files found matching '*.txt' 15:01:50 INFO - no previously-included directories found matching 'build' 15:01:50 INFO - no previously-included directories found matching 'dist' 15:01:50 INFO - no previously-included directories found matching '.git*' 15:01:50 INFO - Successfully installed jsonschema functools32 15:01:50 INFO - Cleaning up... 15:01:50 INFO - Return code: 0 15:01:50 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 15:01:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:01:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:01:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:01:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:01:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:01:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:01:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f561f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f93a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21f4310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21f1400>, '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 0x21f23b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21f2840>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1494021671.550139-2105730831', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:01:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 15:01:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 15:01:50 INFO - Using env: {'DISPLAY': ':0', 15:01:50 INFO - 'HOME': '/home/cltbld', 15:01:50 INFO - 'LANG': 'en_US.UTF-8', 15:01:50 INFO - 'LANGUAGE': 'en_US:en', 15:01:50 INFO - 'LOGNAME': 'cltbld', 15:01:50 INFO - 'MAIL': '/var/mail/cltbld', 15:01:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:01:50 INFO - 'MOZ_NO_REMOTE': '1', 15:01:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:01:50 INFO - 'NO_EM_RESTART': '1', 15:01:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:01:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:01:50 INFO - 'PWD': '/builds/slave/test', 15:01:50 INFO - 'SHELL': '/bin/bash', 15:01:50 INFO - 'SHLVL': '1', 15:01:50 INFO - 'TERM': 'linux', 15:01:50 INFO - 'TMOUT': '86400', 15:01:50 INFO - 'USER': 'cltbld', 15:01:50 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1494021671.550139-2105730831', 15:01:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:01:50 INFO - '_': '/tools/buildbot/bin/python'} 15:01:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:01:50 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 15:01:50 INFO - Cleaning up... 15:01:50 INFO - Return code: 0 15:01:50 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:01:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:01:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:01:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:01:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:01:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:01:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:01:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1f561f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f93a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21f4310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21f1400>, '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 0x21f23b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21f2840>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1494021671.550139-2105730831', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:01:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 15:01:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 15:01:50 INFO - Using env: {'DISPLAY': ':0', 15:01:50 INFO - 'HOME': '/home/cltbld', 15:01:50 INFO - 'LANG': 'en_US.UTF-8', 15:01:50 INFO - 'LANGUAGE': 'en_US:en', 15:01:50 INFO - 'LOGNAME': 'cltbld', 15:01:50 INFO - 'MAIL': '/var/mail/cltbld', 15:01:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:01:50 INFO - 'MOZ_NO_REMOTE': '1', 15:01:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:01:50 INFO - 'NO_EM_RESTART': '1', 15:01:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:01:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:01:50 INFO - 'PWD': '/builds/slave/test', 15:01:50 INFO - 'SHELL': '/bin/bash', 15:01:50 INFO - 'SHLVL': '1', 15:01:50 INFO - 'TERM': 'linux', 15:01:50 INFO - 'TMOUT': '86400', 15:01:50 INFO - 'USER': 'cltbld', 15:01:50 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1494021671.550139-2105730831', 15:01:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:01:50 INFO - '_': '/tools/buildbot/bin/python'} 15:01:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:01:50 INFO - Downloading/unpacking blobuploader==1.2.4 15:01:50 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 15:01:50 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 15:01:50 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 15:01:50 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 15:01:50 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 15:01:50 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 15:01:51 INFO - Downloading blobuploader-1.2.4.tar.gz 15:01:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:01:51 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:01:51 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 15:01:51 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 15:01:51 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 15:01:51 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 15:01:51 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 15:01:51 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 15:01:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:01:52 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:01:52 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 15:01:52 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 15:01:52 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 15:01:52 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 15:01:52 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 15:01:52 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 15:01:52 INFO - Downloading docopt-0.6.1.tar.gz 15:01:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:01:52 INFO - Installing collected packages: blobuploader, requests, docopt 15:01:52 INFO - Running setup.py install for blobuploader 15:01:52 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:01:52 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:01:52 INFO - Running setup.py install for requests 15:01:52 INFO - Running setup.py install for docopt 15:01:53 INFO - Successfully installed blobuploader requests docopt 15:01:53 INFO - Cleaning up... 15:01:53 INFO - Return code: 0 15:01:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:01:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:01:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:01:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:01:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:01:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:01:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:01:53 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 0x1f561f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f93a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21f4310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21f1400>, '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 0x21f23b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21f2840>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1494021671.550139-2105730831', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:01:53 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 15:01:53 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 15:01:53 INFO - Using env: {'DISPLAY': ':0', 15:01:53 INFO - 'HOME': '/home/cltbld', 15:01:53 INFO - 'LANG': 'en_US.UTF-8', 15:01:53 INFO - 'LANGUAGE': 'en_US:en', 15:01:53 INFO - 'LOGNAME': 'cltbld', 15:01:53 INFO - 'MAIL': '/var/mail/cltbld', 15:01:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:01:53 INFO - 'MOZ_NO_REMOTE': '1', 15:01:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:01:53 INFO - 'NO_EM_RESTART': '1', 15:01:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:01:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:01:53 INFO - 'PWD': '/builds/slave/test', 15:01:53 INFO - 'SHELL': '/bin/bash', 15:01:53 INFO - 'SHLVL': '1', 15:01:53 INFO - 'TERM': 'linux', 15:01:53 INFO - 'TMOUT': '86400', 15:01:53 INFO - 'USER': 'cltbld', 15:01:53 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1494021671.550139-2105730831', 15:01:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:01:53 INFO - '_': '/tools/buildbot/bin/python'} 15:01:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:01:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:01:53 INFO - Running setup.py (path:/tmp/pip-MbcSv6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:01:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:01:53 INFO - Running setup.py (path:/tmp/pip-1ZZkbs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:01:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:01:53 INFO - Running setup.py (path:/tmp/pip-hHfVIe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:01:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:01:53 INFO - Running setup.py (path:/tmp/pip-vL1O_v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:01:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:01:53 INFO - Running setup.py (path:/tmp/pip-2lknVR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:01:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:01:53 INFO - Running setup.py (path:/tmp/pip-VcUFkf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:01:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:01:53 INFO - Running setup.py (path:/tmp/pip-fo2ILN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:01:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:01:53 INFO - Running setup.py (path:/tmp/pip-EMztCd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:01:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:01:53 INFO - Running setup.py (path:/tmp/pip-IYp5HT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:01:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:01:53 INFO - Running setup.py (path:/tmp/pip-vXCnYA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:01:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:01:54 INFO - Running setup.py (path:/tmp/pip-BJaktd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:01:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:01:54 INFO - Running setup.py (path:/tmp/pip-0SjkZT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:01:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:01:54 INFO - Running setup.py (path:/tmp/pip-kXh33r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:01:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:01:54 INFO - Running setup.py (path:/tmp/pip-2WPcpq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:01:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:01:54 INFO - Running setup.py (path:/tmp/pip-7B1zHJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:01:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:01:54 INFO - Running setup.py (path:/tmp/pip-D_1LqH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:01:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:01:54 INFO - Running setup.py (path:/tmp/pip-_VFH8V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:01:54 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:01:54 INFO - Running setup.py install for manifestparser 15:01:54 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:01:54 INFO - Running setup.py install for mozcrash 15:01:54 INFO - Running setup.py install for mozdebug 15:01:54 INFO - Running setup.py install for mozdevice 15:01:54 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:01:54 INFO - Running setup.py install for mozfile 15:01:55 INFO - Running setup.py install for mozhttpd 15:01:55 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:01:55 INFO - Running setup.py install for mozinfo 15:01:55 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:01:55 INFO - Running setup.py install for mozInstall 15:01:55 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:01:55 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:01:55 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:01:55 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:01:55 INFO - Running setup.py install for mozleak 15:01:55 INFO - Running setup.py install for mozlog 15:01:55 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:01:55 INFO - Running setup.py install for moznetwork 15:01:55 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:01:55 INFO - Running setup.py install for mozprocess 15:01:55 INFO - Running setup.py install for mozprofile 15:01:55 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:01:55 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:01:55 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:01:55 INFO - Running setup.py install for mozrunner 15:01:55 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:01:55 INFO - Running setup.py install for mozscreenshot 15:01:56 INFO - Running setup.py install for moztest 15:01:56 INFO - Running setup.py install for mozversion 15:01:56 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:01:56 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:01:56 INFO - Cleaning up... 15:01:56 INFO - Return code: 0 15:01:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:01:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:01:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:01:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:01:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:01:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:01:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:01:56 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 0x1f561f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f93a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21f4310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21f1400>, '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 0x21f23b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21f2840>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1494021671.550139-2105730831', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:01:56 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 15:01:56 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 15:01:56 INFO - Using env: {'DISPLAY': ':0', 15:01:56 INFO - 'HOME': '/home/cltbld', 15:01:56 INFO - 'LANG': 'en_US.UTF-8', 15:01:56 INFO - 'LANGUAGE': 'en_US:en', 15:01:56 INFO - 'LOGNAME': 'cltbld', 15:01:56 INFO - 'MAIL': '/var/mail/cltbld', 15:01:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:01:56 INFO - 'MOZ_NO_REMOTE': '1', 15:01:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:01:56 INFO - 'NO_EM_RESTART': '1', 15:01:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:01:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:01:56 INFO - 'PWD': '/builds/slave/test', 15:01:56 INFO - 'SHELL': '/bin/bash', 15:01:56 INFO - 'SHLVL': '1', 15:01:56 INFO - 'TERM': 'linux', 15:01:56 INFO - 'TMOUT': '86400', 15:01:56 INFO - 'USER': 'cltbld', 15:01:56 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1494021671.550139-2105730831', 15:01:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:01:56 INFO - '_': '/tools/buildbot/bin/python'} 15:01:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:01:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:01:56 INFO - Running setup.py (path:/tmp/pip-YOcecB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:01:56 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)) 15:01:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:01:56 INFO - Running setup.py (path:/tmp/pip-97RMiu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:01:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 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)) 15:01:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:01:56 INFO - Running setup.py (path:/tmp/pip-Lo3lty-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:01:56 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)) 15:01:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:01:56 INFO - Running setup.py (path:/tmp/pip-cKnFdl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:01:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.50 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)) 15:01:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:01:56 INFO - Running setup.py (path:/tmp/pip-veOJ7u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:01:56 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)) 15:01:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:01:56 INFO - Running setup.py (path:/tmp/pip-J3G63e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:01:56 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)) 15:01:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:01:56 INFO - Running setup.py (path:/tmp/pip-FAy45j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:01:57 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)) 15:01:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:01:57 INFO - Running setup.py (path:/tmp/pip-7Oa5v2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:01:57 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)) 15:01:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:01:57 INFO - Running setup.py (path:/tmp/pip-o8bnEX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:01:57 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)) 15:01:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:01:57 INFO - Running setup.py (path:/tmp/pip-MF7gFT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:01:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 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)) 15:01:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:01:57 INFO - Running setup.py (path:/tmp/pip-qK7D5v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:01:57 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)) 15:01:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:01:57 INFO - Running setup.py (path:/tmp/pip-f7L4Iy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:01:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 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)) 15:01:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:01:57 INFO - Running setup.py (path:/tmp/pip-CC7Gr9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:01:57 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)) 15:01:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:01:57 INFO - Running setup.py (path:/tmp/pip-lYWbZV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:01:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 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)) 15:01:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:01:57 INFO - Running setup.py (path:/tmp/pip-svp7MS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:01:57 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)) 15:01:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:01:57 INFO - Running setup.py (path:/tmp/pip-XPePpp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:01:57 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 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)) 15:01:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:01:57 INFO - Running setup.py (path:/tmp/pip-Zf4IWH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:01:57 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)) 15:01:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:01:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:01:57 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)) 15:01:57 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.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:01:57 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.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:01:57 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:01:57 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 15:01:57 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 15:01:57 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 15:01:57 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 15:01:57 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 15:01:57 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 15:01:58 INFO - Downloading blessings-1.6.tar.gz 15:01:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:01:58 INFO - Installing collected packages: blessings 15:01:58 INFO - Running setup.py install for blessings 15:01:59 INFO - Successfully installed blessings 15:01:59 INFO - Cleaning up... 15:01:59 INFO - Return code: 0 15:01:59 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:01:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:01:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:01:59 INFO - Reading from file tmpfile_stdout 15:01:59 INFO - Current package versions: 15:01:59 INFO - argparse == 1.2.1 15:01:59 INFO - blessings == 1.6 15:01:59 INFO - blobuploader == 1.2.4 15:01:59 INFO - docopt == 0.6.1 15:01:59 INFO - functools32 == 3.2.3-2 15:01:59 INFO - jsonschema == 2.5.1 15:01:59 INFO - manifestparser == 1.1 15:01:59 INFO - mozInstall == 1.12 15:01:59 INFO - mozcrash == 1.0 15:01:59 INFO - mozdebug == 0.1 15:01:59 INFO - mozdevice == 0.50 15:01:59 INFO - mozfile == 1.2 15:01:59 INFO - mozhttpd == 0.7 15:01:59 INFO - mozinfo == 0.9 15:01:59 INFO - mozleak == 0.1 15:01:59 INFO - mozlog == 3.4 15:01:59 INFO - moznetwork == 0.27 15:01:59 INFO - mozprocess == 0.25 15:01:59 INFO - mozprofile == 0.28 15:01:59 INFO - mozrunner == 6.13 15:01:59 INFO - mozscreenshot == 0.1 15:01:59 INFO - mozsystemmonitor == 0.3 15:01:59 INFO - moztest == 0.8 15:01:59 INFO - mozversion == 1.4 15:01:59 INFO - psutil == 3.1.1 15:01:59 INFO - requests == 1.2.3 15:01:59 INFO - wsgiref == 0.1.2 15:01:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:01:59 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:01:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:01:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:01:59 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:01:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:01:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:01:59 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 0x1f561f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f93a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21f4310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21f1400>, '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 0x21f23b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21f2840>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1494021671.550139-2105730831', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:01:59 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 15:01:59 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 15:01:59 INFO - Using env: {'DISPLAY': ':0', 15:01:59 INFO - 'HOME': '/home/cltbld', 15:01:59 INFO - 'LANG': 'en_US.UTF-8', 15:01:59 INFO - 'LANGUAGE': 'en_US:en', 15:01:59 INFO - 'LOGNAME': 'cltbld', 15:01:59 INFO - 'MAIL': '/var/mail/cltbld', 15:01:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:01:59 INFO - 'MOZ_NO_REMOTE': '1', 15:01:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:01:59 INFO - 'NO_EM_RESTART': '1', 15:01:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:01:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:01:59 INFO - 'PWD': '/builds/slave/test', 15:01:59 INFO - 'SHELL': '/bin/bash', 15:01:59 INFO - 'SHLVL': '1', 15:01:59 INFO - 'TERM': 'linux', 15:01:59 INFO - 'TMOUT': '86400', 15:01:59 INFO - 'USER': 'cltbld', 15:01:59 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1494021671.550139-2105730831', 15:01:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:01:59 INFO - '_': '/tools/buildbot/bin/python'} 15:01:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:01:59 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)) 15:01:59 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)) 15:01:59 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)) 15:01:59 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)) 15:01:59 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)) 15:01:59 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)) 15:01:59 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)) 15:01:59 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)) 15:01:59 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)) 15:01:59 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)) 15:01:59 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)) 15:01:59 INFO - Cleaning up... 15:01:59 INFO - Return code: 0 15:01:59 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:01:59 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:01:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:01:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:01:59 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:01:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:01:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:01:59 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 0x1f561f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f93a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21f4310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21f1400>, '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 0x21f23b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21f2840>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1494021671.550139-2105730831', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:01:59 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 15:01:59 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 15:01:59 INFO - Using env: {'DISPLAY': ':0', 15:01:59 INFO - 'HOME': '/home/cltbld', 15:01:59 INFO - 'LANG': 'en_US.UTF-8', 15:01:59 INFO - 'LANGUAGE': 'en_US:en', 15:01:59 INFO - 'LOGNAME': 'cltbld', 15:01:59 INFO - 'MAIL': '/var/mail/cltbld', 15:01:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:01:59 INFO - 'MOZ_NO_REMOTE': '1', 15:01:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:01:59 INFO - 'NO_EM_RESTART': '1', 15:01:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:01:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:01:59 INFO - 'PWD': '/builds/slave/test', 15:01:59 INFO - 'SHELL': '/bin/bash', 15:01:59 INFO - 'SHLVL': '1', 15:01:59 INFO - 'TERM': 'linux', 15:01:59 INFO - 'TMOUT': '86400', 15:01:59 INFO - 'USER': 'cltbld', 15:01:59 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1494021671.550139-2105730831', 15:01:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:01:59 INFO - '_': '/tools/buildbot/bin/python'} 15:01:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:01:59 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:01:59 INFO - Cleaning up... 15:01:59 INFO - Return code: 0 15:01:59 INFO - Running post-action listener: _resource_record_post_action 15:01:59 INFO - Running post-action listener: _start_resource_monitoring 15:01:59 INFO - Starting resource monitoring. 15:01:59 INFO - [mozharness: 2017-05-05 22:01:59.779343Z] Finished create-virtualenv step (success) 15:01:59 INFO - [mozharness: 2017-05-05 22:01:59.779863Z] Running install step. 15:01:59 INFO - Running pre-action listener: _resource_record_pre_action 15:01:59 INFO - Running main action method: install 15:01:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:01:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:01:59 INFO - Reading from file tmpfile_stdout 15:01:59 INFO - Detecting whether we're running mozinstall >=1.0... 15:01:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:01:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:02:00 INFO - Reading from file tmpfile_stdout 15:02:00 INFO - Output received: 15:02:00 INFO - Usage: mozinstall [options] installer 15:02:00 INFO - Options: 15:02:00 INFO - -h, --help show this help message and exit 15:02:00 INFO - -d DEST, --destination=DEST 15:02:00 INFO - Directory to install application into. [default: 15:02:00 INFO - "/builds/slave/test"] 15:02:00 INFO - --app=APP Application being installed. [default: firefox] 15:02:00 INFO - mkdir: /builds/slave/test/build/application 15:02:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 15:02:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 15:02:16 INFO - Reading from file tmpfile_stdout 15:02:16 INFO - Output received: 15:02:16 INFO - /builds/slave/test/build/application/firefox/firefox 15:02:16 INFO - Running post-action listener: _resource_record_post_action 15:02:16 INFO - [mozharness: 2017-05-05 22:02:16.368472Z] Finished install step (success) 15:02:16 INFO - [mozharness: 2017-05-05 22:02:16.368745Z] Running run-tests step. 15:02:16 INFO - Running pre-action listener: _resource_record_pre_action 15:02:16 INFO - Running main action method: run_tests 15:02:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:02:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:02:16 INFO - Python 2.7.3 15:02:16 INFO - Return code: 0 15:02:16 INFO - grabbing minidump binary from tooltool 15:02: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:02:16 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/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21f1400>, '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 0x21f23b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21f2840>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:02:16 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/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 15:02:16 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/linux64/releng.manifest -o -c /builds/tooltool_cache 15:02:16 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 15:02:16 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:02:16 INFO - Return code: 0 15:02:16 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:02:16 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:02:16 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:02:16 INFO - ENV: RUST_BACKTRACE is now 1 15:02:16 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:02:16 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:02:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/aCGisYsrQDiwGShbAkUgJg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-052', '--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 15:02:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/aCGisYsrQDiwGShbAkUgJg/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-052 --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 15:02:16 INFO - Using env: {'DISPLAY': ':0', 15:02:16 INFO - 'HOME': '/home/cltbld', 15:02:16 INFO - 'LANG': 'en_US.UTF-8', 15:02:16 INFO - 'LANGUAGE': 'en_US:en', 15:02:16 INFO - 'LOGNAME': 'cltbld', 15:02:16 INFO - 'MAIL': '/var/mail/cltbld', 15:02:16 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:02:16 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:02:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:02:16 INFO - 'MOZ_NO_REMOTE': '1', 15:02:16 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:02:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:02:16 INFO - 'NO_EM_RESTART': '1', 15:02:16 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:02:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:02:16 INFO - 'PWD': '/builds/slave/test', 15:02:16 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:02:16 INFO - 'RUST_BACKTRACE': '1', 15:02:16 INFO - 'SHELL': '/bin/bash', 15:02:16 INFO - 'SHLVL': '1', 15:02:16 INFO - 'TERM': 'linux', 15:02:16 INFO - 'TMOUT': '86400', 15:02:16 INFO - 'USER': 'cltbld', 15:02:16 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1494021671.550139-2105730831', 15:02:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:02:16 INFO - '_': '/tools/buildbot/bin/python'} 15:02:16 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/aCGisYsrQDiwGShbAkUgJg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-052', '--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 15:02:16 INFO - mozversion application_buildid: 20170505210647 15:02:16 INFO - mozversion application_changeset: ff83fde8be946eabcf27ea97d4676f601c122194 15:02:16 INFO - mozversion application_display_name: Nightly 15:02:16 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:02:16 INFO - mozversion application_name: Firefox 15:02:16 INFO - mozversion application_remotingname: firefox 15:02:16 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 15:02:16 INFO - mozversion application_vendor: Mozilla 15:02:16 INFO - mozversion application_version: 55.0a1 15:02:16 INFO - mozversion platform_buildid: 20170505210647 15:02:16 INFO - mozversion platform_changeset: ff83fde8be946eabcf27ea97d4676f601c122194 15:02:16 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 15:02:16 INFO - mozversion platform_version: 55.0a1 15:02:16 INFO - using testdate: 1494021736 15:02:16 INFO - actual date: 1494021736 15:02:16 INFO - starting webserver on 'localhost:38853' 15:02:16 INFO - SUITE-START | Running 2 tests 15:02:16 INFO - TEST-START | dromaeo_css 15:02:16 INFO - operating with platform_type : linux_ 15:02:16 INFO - Initialising browser for dromaeo_css test... 15:02:16 INFO - TEST-INFO | started process 26604 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplvXL9a/profile http://localhost:38853/getInfo.html) 15:02:20 INFO - PID 26604 | __metrics Screen width/height:1600/1200 15:02:20 INFO - PID 26604 | colorDepth:24 15:02:20 INFO - PID 26604 | Browser inner width/height: 1024/695 15:02:20 INFO - PID 26604 | __metrics 15:02:21 INFO - PID 26604 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 15:02:21 INFO - PID 26604 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 334: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:02:22 INFO - TEST-INFO | 26604: exit 0 15:02:22 INFO - Browser initialized. 15:02:22 INFO - Running cycle 1/1 for dromaeo_css test... 15:02:22 INFO - TEST-INFO | started process 26699 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplvXL9a/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:02:34 INFO - PID 26699 | RSS: Main: 169144320 15:02:34 INFO - PID 26699 | 15:05:36 INFO - PID 26699 | Cycle 1(1): loaded http://localhost:38853/tests/dromaeo/cssquery-dojo.html (next: http://localhost:38853/tests/dromaeo/cssquery-ext.html) 15:05:38 INFO - PID 26699 | RSS: Main: 317186048 15:05:38 INFO - PID 26699 | 15:08:40 INFO - PID 26699 | Cycle 1(1): loaded http://localhost:38853/tests/dromaeo/cssquery-ext.html (next: http://localhost:38853/tests/dromaeo/cssquery-jquery.html) 15:08:41 INFO - PID 26699 | RSS: Main: 239644672 15:08:41 INFO - PID 26699 | 15:11:42 INFO - PID 26699 | Cycle 1(1): loaded http://localhost:38853/tests/dromaeo/cssquery-jquery.html (next: http://localhost:38853/tests/dromaeo/cssquery-mootools.html) 15:11:43 INFO - PID 26699 | RSS: Main: 203055104 15:11:43 INFO - PID 26699 | 15:14:45 INFO - PID 26699 | Cycle 1(1): loaded http://localhost:38853/tests/dromaeo/cssquery-mootools.html (next: http://localhost:38853/tests/dromaeo/cssquery-prototype.html) 15:14:45 INFO - PID 26699 | RSS: Main: 186130432 15:14:45 INFO - PID 26699 | 15:17:48 INFO - PID 26699 | Cycle 1(1): loaded http://localhost:38853/tests/dromaeo/cssquery-prototype.html (next: http://localhost:38853/tests/dromaeo/cssquery-yui.html) 15:17:49 INFO - PID 26699 | RSS: Main: 186863616 15:17:49 INFO - PID 26699 | 15:20:50 INFO - PID 26699 | Cycle 1(1): loaded http://localhost:38853/tests/dromaeo/cssquery-yui.html (next: http://localhost:38853/tests/dromaeo/cssquery-dojo.html) 15:20:51 INFO - PID 26699 | RSS: Main: 280387584 15:20:51 INFO - PID 26699 | 15:20:51 INFO - PID 26699 | __start_tp_report 15:20:51 INFO - PID 26699 | _x_x_mozilla_page_load 15:20:51 INFO - PID 26699 | _x_x_mozilla_page_load_details 15:20:51 INFO - PID 26699 | |i|pagename|runs| 15:20:51 INFO - PID 26699 | |0;dojo.html;3252.528383384409;3276.6231883333394;3292.2592416706243;3299.7030267275954;3301.966810693223;5420.512153906147;5543.1408131739545;5604.80383186588;5674.906783574052;5685.289338832646;5537.556995440365;5566.053770858964;5573.665580065199;5726.799562015331;5779.3642699303045;4997.450280469155;5007.549320561149;5024.397072351323;5055.671381360218;5067.949320506785;4975.651704380694;5066.620003499752;5095.490450954912;5172.948270517284;5228.372595288552;4905.3132561441425;5134.563562097226;5135.845924622267;5170.819021334254;5172.19830926207;5007.774650140716;5042.243663450475;5045.41977672565;5106.489351064901;5117.53942145205;5125.897482050375;5142.151544995071;5147.794088236466;5148.382194136728;5155.484451554852;5655.8586035349035;5663.943360566383;5683.488486036235;5693.743781529841;5695.743691533849;6184.783532576338;6193.4425901669065;6193.4425901669065;6196.225471816023;6210.347913469111;6007.609505382136;6085.847853803691;6106.023036314168;6122.326544080192;6238.251409830849;5650.29371328584;5705;5744.798932037442;5782.739776710058;5788.044972579477;6304.369563043659;6331.525135614847;6336.20797400325;6356.14192084072;6361.522885783585;6108.633481991006;6111.816645500642;6124.35694252106;6125.509959203253;6133.233345831771;5970.701464926737;6046.2139921809885;6054.576179667381;6118.832384214075;6123.571350005457;5878.735456904449;6164.075388691643;6181.011038233861;6186.876262474725;6195.256569211723;6005.249343832021;6029.246344206974;6069.119977603223;6114.397440808724;6123.720072747168;4658.627309815207;4662.953370466252;4665.5567721066445;4692.5307469253485;4719.834805781781;4158.334666453353;4162.958370416257;4170.35359519275;4170.812313445902;4210.989362552965;5575.944240557624;5605.187247849039;5605.495505404451;5618.185363122406;5743;6089.908651370233;6112.633242005494;6113.296970848321;6114.541409394314;6114.969425152845;5628.943710562924;5700.344460387026;5705.400932902068;5706.657600543981;5756.050251708505;5365.785368585213;5366.248725178478;5369.060414427459;5370.409254981949;5410.810621628224;6464.127342808754;6475.158229430144;6478.4169424752;6481;6484.416402523795;5952.345242023461;6054.545909056927;6202.689865506797;6204.658743768956;6219.626822390671;6247.625142491283;6331.493480521455;6413.647249401328;6415.871682566416;6428.164338635947;6045.183900173421;6059.121427393092;6068.478616545584;6074.0281554951;6107.511399088151;6115.502909186769;6162.198914141133;6168.475679567287;6174.8147555573405;6175.2589689237575;5775.8556036099435;5852.531797456279;5984.491318237824;5984.910226346521;6009.7896573621465;6063.393660634078;6067.332593414809;6071.5446341523675;6075.058365953284;6075.605085669417;6029.75880964774;6030.336662967158;6031.939680603138;6035.758569657164;6048.0625503047095;5758.222639943554;5857.9121313179485;5890.793822216202;5944.6730429826775;6058.485028772604;5913.05391137416;5927.199828023334;5933.614315069507;5944.524438045032;5945.881082378241 15:20:51 INFO - PID 26699 | |1;ext.html;713.9143302803665;793.41287447289;813.4671789977565;1140.1676775953554;1160.965171044868;29585.55621665674;30218.54672179919;30228.09315720529;30239.092827215165;33620.49569256457;38080;38582;38642.42036369457;38666.420003699895;38678.61321386785;7167.784966451002;7292.8906066409045;7299.087614048244;7303.137699886522;7305.780826575211;5647.632903861257;5803.332616749086;7292.525985810932;7377.188509263977;7397;7143.42852571793;7329.633518324089;7343.816404589875;7349.5590264584025;7357.521761085539;7330.890036649428;7392.815179620498;7396.630168491554;7398.593077380769;7403.407727381797;5616.606837521375;5789.189513468118;7243.456740744413;7328.596927169004;7334.229905859861;34283.657163428295;35052.6494735052;35136.64863351385;35233.64766352329;35266.82366588151;3458.654134586546;3467.0292318150705;3495.94756078659;3500.177458297298;3501.037214765934;28917.56623650647;29019.564706529418;29037.41925161485;29042.854785725936;29057.564136537756;3601.333753255656;3665.5601327840563;3875.670568001723;3876.8643097491454;3890.5720370759195;176688;176760;176770.11614941971;177911;178030;47350.28974565384;47427;47513;47531.76234118876;47595.76202119036;48702.75648621805;48762.75618621955;48932.51067489351;49048.509514905105;49055.75472122688;15323.23383830804;15387.692246155015;15416.075035497906;15422.460213892684;15434.382624694887;12437.62687119388;12452.626421207378;12467.625971220878;12482;12489.125761196628;12040.518379264906;12323.445444955;12343;13746.518871839438;14125.576232713034;4830.694670408822;5494.230807686927;5606.327240731139;5739.110437882135;5749.655020698771;1070.8072546941469;1085.218642577343;1110.8444817725524;1114.916381271408;1124.7413094988035;26246.21261362162;26537.86731066332;26592.867035665084;26608.60087098695;26670.5999410009;1131.264677959333;1166.1487114406532;1171;1172.267332916927;1190.922590031645;13362.53231136925;13484.325783710776;13696.520621778389;13767.655808604864;13812.1022133561;250554;253548;253996;254151;254326;53502;53739.462605374225;53764.19353709697;53815.730921345144;53857.46142538603;1462.5831637983124;1476.9113853168844;1511.508759653117;1515.0606623893257;1515.4089904937084;23840.284791456284;25086.74913250844;25209;25234.36914077163;25259.242222733348;35478;35685.28629427345;35698.46452303165;35728.464073039446;35728.64271357253;222175;222887;223012;223218;224020;33071.66928330782;33382.499262510595;33402.4989625151;33422;33430.83284583561;34233.82883085569;39937;40717.1856562873;42820.1435971285;42929.57070429381;30074.248143795703;30580;30695.2326191847;30911.536326954665;31441.685583143877;30095.69904300929;30206.697933020387;30584.541231881984;31165.220869478446;31248.843755781076;35059.298814024085;35487;35543.28913421769;35582.14744502951;35880.64119358773;29389.412211756073;29739.40521189521;30022.3995520084;30024;30339.241518962204;23988.40028999289;24316.392090197885;24717.25848224556;24963;25007.624885626366 15:20:51 INFO - PID 26699 | |2;jquery.html;376.52369752263377;450.96843220974523;454.5545365541769;460.7396820796248;464.4380299837196;19041.143148558313;19175.32886348978;19688.21247150114;20004.69992950107;20187.697184542245;21521.892390538065;21551.245706400277;21791.346259612237;22192.8890355548;22212;5535.944640553604;5673.517750991171;5677.148427735831;5681.346645135821;5683.232763576926;5297.973510132444;5445.156000819879;5474.671519708831;5489.505944464997;5492.038893193695;5452.40023597404;5454.836354909359;5456.563474921997;5456.7544460499175;5469.781208751645;5383.192521121843;5529.640573362719;5561.165825126263;5565.499105080562;5566.638168519034;5001.524855138756;5020.497950204986;5069;5071.391433028023;5072.771725272335;24148.63777043346;24435.26694199177;24516;24561.14036008749;24750.133745318828;2085.7914208579173;2100.4433825036376;2118.8622739521884;2119.5231073008604;2120.363890832744;15965.680686386324;16609.169541522875;16650;16707.749383759252;16732.916335418246;2087.217293514932;2118.0892216346965;2165.53441010182;2173.8913054347217;2174.065151984646;97182;98505;98994.0100598992;99175;100560.94390560959;11068.723281918017;12213;12281.324527150913;12426.378681065911;12652.493900244071;16035.19824008795;16055.357785688675;16960.321587136375;17771.111444427985;17779.288828446977;8191.754247372588;8243.752687419386;8401.831963360699;8406.117357677478;8475.406721529556;7405.8889116663295;7414.480986330905;7420.85158296831;7577.052868391451;7598.81002974919;7838.21617838223;7843.490173138728;7879.724209652634;7935.365170786438;8111.513309201467;2104.3266154830612;2177.6406892862815;2188.4528867783056;2252.695886055394;2253.876036817958;1030.7989941961396;1057.9949048403894;1062.1184416934082;1065.1798115451058;1071.3518321415431;19113.904430478036;20813;21210.893945530483;21215.68176477354;21259.46851328698;1055.5566662001977;1064.350746044912;1065.7069305940772;1068.2575609951164;1077.9622713205001;10777.353358798497;11389.658310250707;11436.656900293005;11466.48400821965;11504;510057;511170;517282;529334;532362;93203;94588.52705736565;94998;96179;97620.58327958487;1138.8918052784973;1185.199990006742;1197.0423661071281;1199.7660456210956;1202.5971299614553;16661.91669041647;17010.48968530946;17317.393891213746;17573.912130439265;17839.197236124666;43882;44770.328445074;45484.77257613691;45541;45697.54302457066;57191.71404142953;57480.71259643675;57740.4225957735;57985.420145798;62946.37053629405;9413.764655883384;9532.046795320413;9598.760030999281;9632.133108020313;10041.548130334006;14408.13551186932;14932.328045237773;15246.923765381101;15427.9200455967;15905.443309484113;12432.440540175532;12450.501979920702;12586.056045796418;12757.362131893553;12918.806217906551;11572.18994670365;11877.703057423634;12073.517059317881;12133.453994570089;13067.150635209062;12542.686432839251;12608.432620532281;12710.618681439571;13025.218486890817;13795;9594.280428967715;9706.592544080928;9776.071273229032;9898.50507474609;9941.65204217849;12492.625221243377;12549.498020079094;12734.490620375082;13081.280529570964;14120.576382708536 15:20:51 INFO - PID 26699 | |3;mootools.html;1325.9270740109293;1376.6420730610039;1409.9436022559098;1423.4804296431791;1423.9715205695886;10653.680389588315;11108.16688748343;11116.499757510912;11134.554617815287;11159.107271418286;10880.238383313152;11029.393383363911;11412.372319522423;11419.885801141985;11421.885781142186;2199.8570092943987;2220.18963078476;2223.7665045170265;2237.3847192022163;2242.7308722953267;1983.5338695406567;2276.1805749930013;2310.87290199039;2339.6841426407473;2340.847844890077;1892.3376818113618;2145.4743587821004;2290.6678531612906;2292.942676433086;2293.8738369389675;2288.8397812153157;2312.0867257433306;2317.1774020222747;2324.035525257025;2325.2210509479346;2174.9782502174935;2188.927425561479;2274.465500607356;2289.8053665438456;2294.52962142762;10718.785624287548;10742.086922611586;10831.566737330497;10842.403667798268;10848.945755271174;6329.746810127589;6493.610383377012;6498.837529061764;6535.836604084936;6537.5750576212395;3643.4352675335367;3895.02624343914;3933.6853051756075;3979.96520904564;4012.558618551957;1120.4341807387218;1157.0859021373105;1157.3692337675986;1242.0188051439352;1271.6375832887582;15675.059496430136;15786.447474338458;15793.92103039489;15806.60483487922;15809.92095039529;4970;5118.334616499831;5195.064888320138;5367.543758780547;5397.8380648580605;11735.4132293385;11744.119191060534;11748.236364636272;11756;11765.588204412805;6366.554341196164;6376;6378.712957916905;6379.681015949277;6386.393292637192;5913.822585322448;6011.789587364421;6051.425114614105;6067.635941843503;6114.57197996136;4139.97930010348;4192.727472714264;4203.705740598129;4241.706279584694;4294.935575966363;1101.8512500812449;1118.9160812939062;1119.4682525800342;1142.5601143559788;1152.6369193703956;718.3247747117797;731.436793668872;738.2654259012318;747.8766003609452;773.3658400111967;5600;5660.660360378391;5711.371749107595;5729.742161602738;5961.344252132262;866.8868591575152;884.8805411269525;894.5750768384966;899.964001439935;921.5806807902388;3561.0919215600375;3570.732195085379;3574.160072382988;3578.6600272974547;3634.6910512606196;14738.484153054591;15359.308831102628;15379.538613841603;15385.153816539974;15388.769168462482;14684.118952862862;15019;15319.540413787381;15351.462698805488;15361.923190383977;9329.393589416666;9355.719328420158;9572.61709531625;9595.568199430903;9620.71137865865;6325.905111423241;6371.745130194926;6383.265924418752;6422.550421470452;6493.253275873335;13116.08187426871;13242.139260948008;13307.201567905957;13783.586492405244;13947;13700.65748356299;13802.309884505936;14038.227897465737;14075.507357242448;14199.432022718975;8394.748157555283;8472.534010629228;8476.957615212132;8557.315414766928;8578.270846978077;10824.837627435438;10993.560257589606;10998.175136864607;11002.33985960845;11003.284786488852;9285.210757085724;9418.670346537838;9438.669646562337;9662.3236373456;9718.70843874685;9226.261899048195;9259.67591134307;9324.627014919328;9344.15902568772;9443.952780236055;7609.429292802951;7757.883631745642;7770.53376797394;7777.688892444466;7780.144184139627;5543.25166102571;5589.385167631476;5616.494515493625;5746.310442746897;5862.853428664147;5659.122835960433;5767.048437007847;5774.769009239583;5874.882502349844;5947.405259474018 15:20:51 INFO - PID 26699 | |4;prototype.html;399.8180827723385;401.09953155166653;402.24779662032006;402.25181163036746;413.099443213794;5693.601447898649;5694.800681976131;5718.857028574277;5732.570057245707;5739.368669446363;5436.836894893149;5554.1391084381885;5579;5588.86027849304;5604.887902241963;4398.362237475564;4401.405810215612;4402.701203145072;4403.788958036534;4431.911361772763;4413.227685155101;4422.226110430678;4423.977880110595;4425.137098265839;4449.688521803475;4084.7344922579937;4212.115455754295;4223.64099051581;4245.745255284677;4418.447694038246;4222.2611043067645;4225.746175444906;4226.154769046203;4245.469316335458;4247.617714405703;3692.9630703693156;3703.2223233121076;3735.1782607826235;3740.3267411865854;3758;5344.22508736235;5471.647191707564;5517.144842549411;5550.5282051025715;5553.667799320416;4947.332110165117;4954.355933728628;4959.975200124012;4988.476209997971;4989.875253118665;5930.614510056876;5940.851478713023;5967.522598192134;5969.283685957669;5971.671558064305;4123.402106694542;4157.3140431828715;4171.290880550314;4190.8533201337805;4207.97896010518;5927.555433342516;6085.2697676278685;6151.846203844895;6200.565960382775;6252.781152659635;4050.25070361984;4088.345864661699;4105.85629502966;4107.466029416217;4121.62905338521;4003.279409706281;4058.573849745734;4154.854580089743;4159.7920103994675;4168.353500367399;4746.501617330199;4759.8814278644495;4760.428748550127;4767.570918617272;4772.546608072227;5900.822975310747;5908.527317814651;5923.17075609415;5929.555283353766;5951.5238780897425;1428.0788891165141;1459.9050711966026;1465.8241011078526;1474.2555009720238;1474.8451412601737;975.3903810118676;978.2614126334572;986.7977064701719;993.8459538771502;998.8851282102651;5727.28408948873;5756.366799652035;5771.509421699203;5776.277965254343;5779.15686068768;6011.218541589566;6028.397160284024;6082.391760823971;6095.988323853117;6117.959946809053;5635.690037048002;5713.342965558931;5738.397468265855;5751.252337196222;5781.774017003484;3210.229544909205;3225.177579717157;3230.1601583588435;3233.531137984979;3245.8052516849066;6291.905621415683;6293.905591416133;6367.649779262092;6416.582922110048;6430;6184.567080304336;6209.006558950547;6215.34738852423;6218.689065546704;6267.2479302484;6185.257769067741;6368.936310636835;6395.904061439082;6406.4554512866;6431.74273029083;6052.364501727431;6053.243344581927;6081.148639190428;6086.269647642312;6117.265928088658;6018.1875446815875;6039.406553100898;6042.0332746760305;6047.365026672136;6063.120847477179;6197;6359.8092057238355;6418.133551970611;6456.386643268882;6469.191351081115;4136.482939632546;4140.15126898991;4140.3168477200925;4145.585441455831;4151.875443736692;6057.454829065406;6086.239220097488;6191.721372538336;6191.84520386994;6201.844953876009;5915.763369465173;5982.551308651781;6009.399060093956;6019.428154325332;6024.9397506026135;5958.344582096052;5973.850653733692;5977.3126090500145;6001.609895356963;6003.8198854034445;5849.970750146222;5894.587378883609;5922.940770592411;5965.28416590012;6010.579259451796;5953.7023148843255;5964.701764911824;5980.551458640706;5985.952458319864;5994.430529099728;5742.885142297047;5829.300483941955;5861.856937897069;5874.324452687824;5878.706064696663 15:20:51 INFO - PID 26699 | |5;yui.html;860.7331727164583;867.717991652713;872.3752807086554;878.5299864572455;894.6913314906357;16702.248398822067;16833.83166168338;17002.234899429524;17021.574460638476;17026.574335641584;16922.153892305396;18147.818521814777;18570.16434260458;18744.156512956917;18962.62074758504;949.9715008549738;978.8238117138912;980.1570649241646;980.2060331131806;980.6861804222651;1032.1123833503182;1035.1098055672117;1035.7824856780085;1036.0520124086452;1036.440322225997;1078.8759292681364;1079.8542196803448;1080.0873262093519;1081.621432498623;1081.9296745711542;1069.8983596558314;1070.42197213505;1070.7644318249972;1070.9464526773709;1071;792.4334101117729;794.1383598795314;794.2692722695134;794.7575989323254;795.645937557787;15183.924080379527;15475.380984760595;15475.922620386826;15698.293576789072;15827.446039388682;15814.920925395414;16144.273507692182;16344.836551634451;16434.178291085398;16654.75017874733;14003.859961400358;14049.157050576998;14186.290685465789;14236.928815355857;14265.002899594065;3366.0406784066668;3381.746369022333;3388.457846744509;3395.575553055868;3398.235397035672;94386;95096.52451737766;95271;95599;103087.48456257746;13960.650983725489;14041.5085472008;14191.574252772434;14285.85714142866;14300.642483937776;25039.87480062588;25215.495690086464;25603;25887.870560647076;26136.34659133499;7893.526388416713;7962.6416811243635;8029.598520073973;8070.959645201737;8092.150324215991;3993.341098718737;4090.4682391288943;4106.3429851224255;4114.238865809834;4129.442525259112;4245.61789438952;4340.739555626673;4341.806003349041;4344.109457561192;4371.147626212858;833.4124442268186;847.4449235750593;849.9915000850036;850.4472093139509;851.646566674823;709.0569542508451;711.9501634885612;718.0808565036762;737.3658653557936;747.5738828867493;10901.618443354444;11096.778064438828;11154.386508741934;11753.823692644617;12748.80876786849;679.7858674517511;681.8636272745471;686.6944209826679;689.3864460630043;706.3078183380316;5228.189630607262;5229.607779416483;5322.361316642027;5360.624756267024;5430.755615997289;84397;84715;85340;86982;88689;67726.322736772;67749.3225067753;72014.63992680002;72815.63592182111;72929.6353518229;58622.563708797235;59436;60874.6052684179;62322;63583.36416635867;11913.821292680443;12932.806007909701;12980.415881285553;12987.610371688865;13034;30826.53760193554;31581.526277105404;31855.681443185273;32928.83535582403;33142.502862457564;38174.23651526898;38290;38522.22955540929;38597.421038685;39385.606143938196;15534.300956457213;15572.29924653416;15692;15750.369985200463;16010.119443430724;18140.637187256445;18180.636387271916;18430.907845460686;18452.63094738071;18696.34562790296;17020.148992550075;17028.233729481955;17236.741448878027;17341.65316693684;17692.965308989114;16295.429659961845;16618.916905415397;16738.748918766472;17175.484735457958;17249.741253881453;14216.147031178163;14296.499622513162;14314.141151530941;14359.282035898372;14720.043197192577;10379.11777498921;10387.117095047006;10493.47532623381;10524.36853788775;10545.9472702636;10958.616448424267;11041.227114102257;11544.365059921785;11601.883981160081;11765.52937882475 15:20:51 INFO - PID 26699 | __end_tp_report 15:20:51 INFO - PID 26699 | __start_cc_report 15:20:51 INFO - PID 26699 | _x_x_mozilla_cycle_collect,1542 15:20:51 INFO - PID 26699 | __end_cc_report 15:20:51 INFO - PID 26699 | __startTimestamp1494022851138__endTimestamp 15:20:51 INFO - PID 26699 | 15:20:51 INFO - PID 26699 | ------- Summary: start ------- 15:20:51 INFO - PID 26699 | Number of tests: 6 15:20:51 INFO - PID 26699 | 15:20:51 INFO - PID 26699 | [#0] dojo.html Cycles:165 Average:5670.32 Median:5927.20 stddev:673.16 (11.4%) stddev-sans-first:647.96 15:20:51 INFO - PID 26699 | Values: 3252.5 3276.6 3292.3 3299.7 3302.0 5420.5 5543.1 5604.8 5674.9 5685.3 5537.6 5566.1 5573.7 5726.8 5779.4 4997.5 5007.5 5024.4 5055.7 5067.9 4975.7 5066.6 5095.5 5172.9 5228.4 4905.3 5134.6 5135.8 5170.8 5172.2 5007.8 5042.2 5045.4 5106.5 5117.5 5125.9 5142.2 5147.8 5148.4 5155.5 5655.9 5663.9 5683.5 5693.7 5695.7 6184.8 6193.4 6193.4 6196.2 6210.3 6007.6 6085.8 6106.0 6122.3 6238.3 5650.3 5705.0 5744.8 5782.7 5788.0 6304.4 6331.5 6336.2 6356.1 6361.5 6108.6 6111.8 6124.4 6125.5 6133.2 5970.7 6046.2 6054.6 6118.8 6123.6 5878.7 6164.1 6181.0 6186.9 6195.3 6005.2 6029.2 6069.1 6114.4 6123.7 4658.6 4663.0 4665.6 4692.5 4719.8 4158.3 4163.0 4170.4 4170.8 4211.0 5575.9 5605.2 5605.5 5618.2 5743.0 6089.9 6112.6 6113.3 6114.5 6115.0 5628.9 5700.3 5705.4 5706.7 5756.1 5365.8 5366.2 5369.1 5370.4 5410.8 6464.1 6475.2 6478.4 6481.0 6484.4 5952.3 6054.5 6202.7 6204.7 6219.6 6247.6 6331.5 6413.6 6415.9 6428.2 6045.2 6059.1 6068.5 6074.0 6107.5 6115.5 6162.2 6168.5 6174.8 6175.3 5775.9 5852.5 5984.5 5984.9 6009.8 6063.4 6067.3 6071.5 6075.1 6075.6 6029.8 6030.3 6031.9 6035.8 6048.1 5758.2 5857.9 5890.8 5944.7 6058.5 5913.1 5927.2 5933.6 5944.5 5945.9 15:20:51 INFO - PID 26699 | 15:20:51 INFO - PID 26699 | [#1] ext.html Cycles:180 Average:37672.80 Median:32256.68 stddev:57244.82 (177.5%) stddev-sans-first:57338.14 15:20:51 INFO - PID 26699 | Values: 713.9 793.4 813.5 1140.2 1161.0 29585.6 30218.5 30228.1 30239.1 33620.5 38080.0 38582.0 38642.4 38666.4 38678.6 7167.8 7292.9 7299.1 7303.1 7305.8 5647.6 5803.3 7292.5 7377.2 7397.0 7143.4 7329.6 7343.8 7349.6 7357.5 7330.9 7392.8 7396.6 7398.6 7403.4 5616.6 5789.2 7243.5 7328.6 7334.2 34283.7 35052.6 35136.6 35233.6 35266.8 3458.7 3467.0 3495.9 3500.2 3501.0 28917.6 29019.6 29037.4 29042.9 29057.6 3601.3 3665.6 3875.7 3876.9 3890.6 176688.0 176760.0 176770.1 177911.0 178030.0 47350.3 47427.0 47513.0 47531.8 47595.8 48702.8 48762.8 48932.5 49048.5 49055.8 15323.2 15387.7 15416.1 15422.5 15434.4 12437.6 12452.6 12467.6 12482.0 12489.1 12040.5 12323.4 12343.0 13746.5 14125.6 4830.7 5494.2 5606.3 5739.1 5749.7 1070.8 1085.2 1110.8 1114.9 1124.7 26246.2 26537.9 26592.9 26608.6 26670.6 1131.3 1166.1 1171.0 1172.3 1190.9 13362.5 13484.3 13696.5 13767.7 13812.1 250554.0 253548.0 253996.0 254151.0 254326.0 53502.0 53739.5 53764.2 53815.7 53857.5 1462.6 1476.9 1511.5 1515.1 1515.4 23840.3 25086.7 25209.0 25234.4 25259.2 35478.0 35685.3 35698.5 35728.5 35728.6 222175.0 222887.0 223012.0 223218.0 224020.0 33071.7 33382.5 33402.5 33422.0 33430.8 34233.8 39937.0 40717.2 42820.1 42929.6 30074.2 30580.0 30695.2 30911.5 31441.7 30095.7 30206.7 30584.5 31165.2 31248.8 35059.3 35487.0 35543.3 35582.1 35880.6 29389.4 29739.4 30022.4 30024.0 30339.2 23988.4 24316.4 24717.3 24963.0 25007.6 15:20:51 INFO - PID 26699 | 15:20:51 INFO - PID 26699 | [#2] jquery.html Cycles:180 Average:31256.17 Median:11984.49 stddev:85897.67 (716.7%) stddev-sans-first:86107.35 15:20:51 INFO - PID 26699 | Values: 376.5 451.0 454.6 460.7 464.4 19041.1 19175.3 19688.2 20004.7 20187.7 21521.9 21551.2 21791.3 22192.9 22212.0 5535.9 5673.5 5677.1 5681.3 5683.2 5298.0 5445.2 5474.7 5489.5 5492.0 5452.4 5454.8 5456.6 5456.8 5469.8 5383.2 5529.6 5561.2 5565.5 5566.6 5001.5 5020.5 5069.0 5071.4 5072.8 24148.6 24435.3 24516.0 24561.1 24750.1 2085.8 2100.4 2118.9 2119.5 2120.4 15965.7 16609.2 16650.0 16707.7 16732.9 2087.2 2118.1 2165.5 2173.9 2174.1 97182.0 98505.0 98994.0 99175.0 100560.9 11068.7 12213.0 12281.3 12426.4 12652.5 16035.2 16055.4 16960.3 17771.1 17779.3 8191.8 8243.8 8401.8 8406.1 8475.4 7405.9 7414.5 7420.9 7577.1 7598.8 7838.2 7843.5 7879.7 7935.4 8111.5 2104.3 2177.6 2188.5 2252.7 2253.9 1030.8 1058.0 1062.1 1065.2 1071.4 19113.9 20813.0 21210.9 21215.7 21259.5 1055.6 1064.4 1065.7 1068.3 1078.0 10777.4 11389.7 11436.7 11466.5 11504.0 510057.0 511170.0 517282.0 529334.0 532362.0 93203.0 94588.5 94998.0 96179.0 97620.6 1138.9 1185.2 1197.0 1199.8 1202.6 16661.9 17010.5 17317.4 17573.9 17839.2 43882.0 44770.3 45484.8 45541.0 45697.5 57191.7 57480.7 57740.4 57985.4 62946.4 9413.8 9532.0 9598.8 9632.1 10041.5 14408.1 14932.3 15246.9 15427.9 15905.4 12432.4 12450.5 12586.1 12757.4 12918.8 11572.2 11877.7 12073.5 12133.5 13067.2 12542.7 12608.4 12710.6 13025.2 13795.0 9594.3 9706.6 9776.1 9898.5 9941.7 12492.6 12549.5 12734.5 13081.3 14120.6 15:20:51 INFO - PID 26699 | 15:20:51 INFO - PID 26699 | [#3] mootools.html Cycles:180 Average:6941.81 Median:3565.91 stddev:4541.09 (127.3%) stddev-sans-first:4534.22 15:20:51 INFO - PID 26699 | Values: 1325.9 1376.6 1409.9 1423.5 1424.0 10653.7 11108.2 11116.5 11134.6 11159.1 10880.2 11029.4 11412.4 11419.9 11421.9 2199.9 2220.2 2223.8 2237.4 2242.7 1983.5 2276.2 2310.9 2339.7 2340.8 1892.3 2145.5 2290.7 2292.9 2293.9 2288.8 2312.1 2317.2 2324.0 2325.2 2175.0 2188.9 2274.5 2289.8 2294.5 10718.8 10742.1 10831.6 10842.4 10848.9 6329.7 6493.6 6498.8 6535.8 6537.6 3643.4 3895.0 3933.7 3980.0 4012.6 1120.4 1157.1 1157.4 1242.0 1271.6 15675.1 15786.4 15793.9 15806.6 15809.9 4970.0 5118.3 5195.1 5367.5 5397.8 11735.4 11744.1 11748.2 11756.0 11765.6 6366.6 6376.0 6378.7 6379.7 6386.4 5913.8 6011.8 6051.4 6067.6 6114.6 4140.0 4192.7 4203.7 4241.7 4294.9 1101.9 1118.9 1119.5 1142.6 1152.6 718.3 731.4 738.3 747.9 773.4 5600.0 5660.7 5711.4 5729.7 5961.3 866.9 884.9 894.6 900.0 921.6 3561.1 3570.7 3574.2 3578.7 3634.7 14738.5 15359.3 15379.5 15385.2 15388.8 14684.1 15019.0 15319.5 15351.5 15361.9 9329.4 9355.7 9572.6 9595.6 9620.7 6325.9 6371.7 6383.3 6422.6 6493.3 13116.1 13242.1 13307.2 13783.6 13947.0 13700.7 13802.3 14038.2 14075.5 14199.4 8394.7 8472.5 8477.0 8557.3 8578.3 10824.8 10993.6 10998.2 11002.3 11003.3 9285.2 9418.7 9438.7 9662.3 9718.7 9226.3 9259.7 9324.6 9344.2 9444.0 7609.4 7757.9 7770.5 7777.7 7780.1 5543.3 5589.4 5616.5 5746.3 5862.9 5659.1 5767.0 5774.8 5874.9 5947.4 15:20:51 INFO - PID 26699 | 15:20:51 INFO - PID 26699 | [#4] prototype.html Cycles:180 Average:4971.29 Median:5753.81 stddev:1503.72 (26.1%) stddev-sans-first:1468.27 15:20:51 INFO - PID 26699 | Values: 399.8 401.1 402.2 402.3 413.1 5693.6 5694.8 5718.9 5732.6 5739.4 5436.8 5554.1 5579.0 5588.9 5604.9 4398.4 4401.4 4402.7 4403.8 4431.9 4413.2 4422.2 4424.0 4425.1 4449.7 4084.7 4212.1 4223.6 4245.7 4418.4 4222.3 4225.7 4226.2 4245.5 4247.6 3693.0 3703.2 3735.2 3740.3 3758.0 5344.2 5471.6 5517.1 5550.5 5553.7 4947.3 4954.4 4960.0 4988.5 4989.9 5930.6 5940.9 5967.5 5969.3 5971.7 4123.4 4157.3 4171.3 4190.9 4208.0 5927.6 6085.3 6151.8 6200.6 6252.8 4050.3 4088.3 4105.9 4107.5 4121.6 4003.3 4058.6 4154.9 4159.8 4168.4 4746.5 4759.9 4760.4 4767.6 4772.5 5900.8 5908.5 5923.2 5929.6 5951.5 1428.1 1459.9 1465.8 1474.3 1474.8 975.4 978.3 986.8 993.8 998.9 5727.3 5756.4 5771.5 5776.3 5779.2 6011.2 6028.4 6082.4 6096.0 6118.0 5635.7 5713.3 5738.4 5751.3 5781.8 3210.2 3225.2 3230.2 3233.5 3245.8 6291.9 6293.9 6367.6 6416.6 6430.0 6184.6 6209.0 6215.3 6218.7 6267.2 6185.3 6368.9 6395.9 6406.5 6431.7 6052.4 6053.2 6081.1 6086.3 6117.3 6018.2 6039.4 6042.0 6047.4 6063.1 6197.0 6359.8 6418.1 6456.4 6469.2 4136.5 4140.2 4140.3 4145.6 4151.9 6057.5 6086.2 6191.7 6191.8 6201.8 5915.8 5982.6 6009.4 6019.4 6024.9 5958.3 5973.9 5977.3 6001.6 6003.8 5850.0 5894.6 5922.9 5965.3 6010.6 5953.7 5964.7 5980.6 5986.0 5994.4 5742.9 5829.3 5861.9 5874.3 5878.7 15:20:51 INFO - PID 26699 | 15:20:51 INFO - PID 26699 | [#5] yui.html Cycles:180 Average:18549.54 Median:22001.25 stddev:23545.72 (107.0%) stddev-sans-first:23574.31 15:20:51 INFO - PID 26699 | Values: 860.7 867.7 872.4 878.5 894.7 16702.2 16833.8 17002.2 17021.6 17026.6 16922.2 18147.8 18570.2 18744.2 18962.6 950.0 978.8 980.2 980.2 980.7 1032.1 1035.1 1035.8 1036.1 1036.4 1078.9 1079.9 1080.1 1081.6 1081.9 1069.9 1070.4 1070.8 1070.9 1071.0 792.4 794.1 794.3 794.8 795.6 15183.9 15475.4 15475.9 15698.3 15827.4 15814.9 16144.3 16344.8 16434.2 16654.8 14003.9 14049.2 14186.3 14236.9 14265.0 3366.0 3381.7 3388.5 3395.6 3398.2 94386.0 95096.5 95271.0 95599.0 103087.5 13960.7 14041.5 14191.6 14285.9 14300.6 25039.9 25215.5 25603.0 25887.9 26136.3 7893.5 7962.6 8029.6 8071.0 8092.2 3993.3 4090.5 4106.3 4114.2 4129.4 4245.6 4340.7 4341.8 4344.1 4371.1 833.4 847.4 850.0 850.4 851.6 709.1 712.0 718.1 737.4 747.6 10901.6 11096.8 11154.4 11753.8 12748.8 679.8 681.9 686.7 689.4 706.3 5228.2 5229.6 5322.4 5360.6 5430.8 84397.0 84715.0 85340.0 86982.0 88689.0 67726.3 67749.3 72014.6 72815.6 72929.6 58622.6 59436.0 60874.6 62322.0 63583.4 11913.8 12932.8 12980.4 12987.6 13034.0 30826.5 31581.5 31855.7 32928.8 33142.5 38174.2 38290.0 38522.2 38597.4 39385.6 15534.3 15572.3 15692.0 15750.4 16010.1 18140.6 18180.6 18430.9 18452.6 18696.3 17020.1 17028.2 17236.7 17341.7 17693.0 16295.4 16618.9 16738.7 17175.5 17249.7 14216.1 14296.5 14314.1 14359.3 14720.0 10379.1 10387.1 10493.5 10524.4 10545.9 10958.6 11041.2 11544.4 11601.9 11765.5 15:20:51 INFO - PID 26699 | -------- Summary: end -------- 15:20:51 INFO - PID 26699 | 15:20:51 INFO - TEST-INFO | 26699: exit 0 15:20:51 INFO - TEST-OK | dromaeo_css | took 1115339ms 15:20:51 INFO - TEST-START | kraken 15:20:51 INFO - operating with platform_type : linux_ 15:20:51 INFO - Initialising browser for kraken test... 15:20:52 INFO - TEST-INFO | started process 27035 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpy4KYFJ/profile http://localhost:38853/getInfo.html) 15:20:55 INFO - PID 27035 | __metrics Screen width/height:1600/1200 15:20:55 INFO - PID 27035 | colorDepth:24 15:20:55 INFO - PID 27035 | Browser inner width/height: 1024/695 15:20:55 INFO - PID 27035 | __metrics 15:20:56 INFO - PID 27035 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 15:20:56 INFO - PID 27035 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 334: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:20:57 INFO - TEST-INFO | 27035: exit 0 15:20:57 INFO - Browser initialized. 15:20:57 INFO - Running cycle 1/1 for kraken test... 15:20:57 INFO - TEST-INFO | started process 27132 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpy4KYFJ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:21:09 INFO - PID 27132 | RSS: Main: 168386560 15:21:09 INFO - PID 27132 | 15:21:11 INFO - PID 27132 | Cycle 1(1): loaded http://localhost:38853/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:38853/tests/kraken/driver.html?testName=audio-beat-detection) 15:21:12 INFO - PID 27132 | RSS: Main: 234553344 15:21:12 INFO - PID 27132 | 15:21:15 INFO - PID 27132 | Cycle 1(1): loaded http://localhost:38853/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:38853/tests/kraken/driver.html?testName=audio-dft) 15:21:16 INFO - PID 27132 | RSS: Main: 196009984 15:21:16 INFO - PID 27132 | 15:21:19 INFO - PID 27132 | Cycle 1(1): loaded http://localhost:38853/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:38853/tests/kraken/driver.html?testName=audio-fft) 15:21:19 INFO - PID 27132 | RSS: Main: 276111360 15:21:19 INFO - PID 27132 | 15:21:21 INFO - PID 27132 | Cycle 1(1): loaded http://localhost:38853/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:38853/tests/kraken/driver.html?testName=audio-oscillator) 15:21:22 INFO - PID 27132 | RSS: Main: 187023360 15:21:22 INFO - PID 27132 | 15:21:24 INFO - PID 27132 | Cycle 1(1): loaded http://localhost:38853/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:38853/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:21:25 INFO - PID 27132 | RSS: Main: 190619648 15:21:25 INFO - PID 27132 | 15:21:28 INFO - PID 27132 | Cycle 1(1): loaded http://localhost:38853/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:38853/tests/kraken/driver.html?testName=imaging-darkroom) 15:21:28 INFO - PID 27132 | RSS: Main: 250638336 15:21:28 INFO - PID 27132 | 15:21:32 INFO - PID 27132 | Cycle 1(1): loaded http://localhost:38853/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:38853/tests/kraken/driver.html?testName=imaging-desaturate) 15:21:32 INFO - PID 27132 | RSS: Main: 271855616 15:21:32 INFO - PID 27132 | 15:21:35 INFO - PID 27132 | Cycle 1(1): loaded http://localhost:38853/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:38853/tests/kraken/driver.html?testName=json-parse-financial) 15:21:35 INFO - PID 27132 | RSS: Main: 288178176 15:21:35 INFO - PID 27132 | 15:21:37 INFO - PID 27132 | Cycle 1(1): loaded http://localhost:38853/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:38853/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:21:38 INFO - PID 27132 | RSS: Main: 214499328 15:21:38 INFO - PID 27132 | 15:21:39 INFO - PID 27132 | Cycle 1(1): loaded http://localhost:38853/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:38853/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:21:40 INFO - PID 27132 | RSS: Main: 219578368 15:21:40 INFO - PID 27132 | 15:21:42 INFO - PID 27132 | Cycle 1(1): loaded http://localhost:38853/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:38853/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:21:42 INFO - PID 27132 | RSS: Main: 229011456 15:21:42 INFO - PID 27132 | 15:21:45 INFO - PID 27132 | Cycle 1(1): loaded http://localhost:38853/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:38853/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:21:46 INFO - PID 27132 | RSS: Main: 237625344 15:21:46 INFO - PID 27132 | 15:21:49 INFO - PID 27132 | Cycle 1(1): loaded http://localhost:38853/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:38853/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:21:49 INFO - PID 27132 | RSS: Main: 232255488 15:21:49 INFO - PID 27132 | 15:21:51 INFO - PID 27132 | Cycle 1(1): loaded http://localhost:38853/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:38853/tests/kraken/driver.html?testName=ai-astar) 15:21:51 INFO - PID 27132 | RSS: Main: 282685440 15:21:51 INFO - PID 27132 | 15:21:51 INFO - PID 27132 | __start_tp_report 15:21:51 INFO - PID 27132 | _x_x_mozilla_page_load 15:21:51 INFO - PID 27132 | _x_x_mozilla_page_load_details 15:21:51 INFO - PID 27132 | |i|pagename|runs| 15:21:51 INFO - PID 27132 | |0;ai-astar;112;109;111;109;108;112;112;109;110;110 15:21:51 INFO - PID 27132 | |1;audio-beat-detection;150;117;117;181;121;122;124;116;139;117 15:21:51 INFO - PID 27132 | |2;audio-dft;161;161;162;163;161;163;161;159;163;160 15:21:51 INFO - PID 27132 | |3;audio-fft;72;75;76;105;75;74;74;74;96;75 15:21:51 INFO - PID 27132 | |4;audio-oscillator;82;82;103;81;82;81;94;81;82;106 15:21:51 INFO - PID 27132 | |5;imaging-gaussian-blur;113;113;114;113;113;113;113;113;112;112 15:21:51 INFO - PID 27132 | |6;imaging-darkroom;147;147;146;146;146;146;146;147;146;147 15:21:51 INFO - PID 27132 | |7;imaging-desaturate;94;94;94;93;93;94;94;94;94;93 15:21:51 INFO - PID 27132 | |8;json-parse-financial;44;45;45;44;47;46;46;46;45;45 15:21:51 INFO - PID 27132 | |9;json-stringify-tinderbox;54;54;55;54;55;54;55;54;54;55 15:21:51 INFO - PID 27132 | |10;stanford-crypto-aes;88;82;80;80;80;80;82;80;86;80 15:21:51 INFO - PID 27132 | |11;stanford-crypto-ccm;127;127;130;138;125;125;127;134;168;131 15:21:51 INFO - PID 27132 | |12;stanford-crypto-pbkdf2;178;187;187;184;187;186;181;182;181;185 15:21:51 INFO - PID 27132 | |13;stanford-crypto-sha256-iterative;66;65;67;66;64;67;65;77;65;63 15:21:51 INFO - PID 27132 | __end_tp_report 15:21:51 INFO - PID 27132 | __start_cc_report 15:21:51 INFO - PID 27132 | _x_x_mozilla_cycle_collect,1861 15:21:51 INFO - PID 27132 | __end_cc_report 15:21:51 INFO - PID 27132 | __startTimestamp1494022911815__endTimestamp 15:21:51 INFO - PID 27132 | 15:21:51 INFO - PID 27132 | ------- Summary: start ------- 15:21:51 INFO - PID 27132 | Number of tests: 14 15:21:51 INFO - PID 27132 | 15:21:51 INFO - PID 27132 | [#0] ai-astar Cycles:10 Average:110.20 Median:110.50 stddev:1.48 (1.3%) stddev-sans-first:1.41 15:21:51 INFO - PID 27132 | Values: 112.0 109.0 111.0 109.0 108.0 112.0 112.0 109.0 110.0 110.0 15:21:51 INFO - PID 27132 | 15:21:51 INFO - PID 27132 | [#1] audio-beat-detection Cycles:10 Average:130.40 Median:123.00 stddev:20.99 (17.1%) stddev-sans-first:21.03 15:21:51 INFO - PID 27132 | Values: 150.0 117.0 117.0 181.0 121.0 122.0 124.0 116.0 139.0 117.0 15:21:51 INFO - PID 27132 | 15:21:51 INFO - PID 27132 | [#2] audio-dft Cycles:10 Average:161.40 Median:161.50 stddev:1.35 (0.8%) stddev-sans-first:1.42 15:21:51 INFO - PID 27132 | Values: 161.0 161.0 162.0 163.0 161.0 163.0 161.0 159.0 163.0 160.0 15:21:51 INFO - PID 27132 | 15:21:51 INFO - PID 27132 | [#3] audio-fft Cycles:10 Average:79.60 Median:75.00 stddev:11.27 (15.0%) stddev-sans-first:11.61 15:21:51 INFO - PID 27132 | Values: 72.0 75.0 76.0 105.0 75.0 74.0 74.0 74.0 96.0 75.0 15:21:51 INFO - PID 27132 | 15:21:51 INFO - PID 27132 | [#4] audio-oscillator Cycles:10 Average:87.40 Median:82.00 stddev:9.85 (12.0%) stddev-sans-first:10.25 15:21:51 INFO - PID 27132 | Values: 82.0 82.0 103.0 81.0 82.0 81.0 94.0 81.0 82.0 106.0 15:21:51 INFO - PID 27132 | 15:21:51 INFO - PID 27132 | [#5] imaging-gaussian-blur Cycles:10 Average:112.90 Median:113.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 15:21:51 INFO - PID 27132 | Values: 113.0 113.0 114.0 113.0 113.0 113.0 113.0 113.0 112.0 112.0 15:21:51 INFO - PID 27132 | 15:21:51 INFO - PID 27132 | [#6] imaging-darkroom Cycles:10 Average:146.40 Median:146.50 stddev:0.52 (0.4%) stddev-sans-first:0.50 15:21:51 INFO - PID 27132 | Values: 147.0 147.0 146.0 146.0 146.0 146.0 146.0 147.0 146.0 147.0 15:21:51 INFO - PID 27132 | 15:21:51 INFO - PID 27132 | [#7] imaging-desaturate Cycles:10 Average:93.70 Median:94.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 15:21:51 INFO - PID 27132 | Values: 94.0 94.0 94.0 93.0 93.0 94.0 94.0 94.0 94.0 93.0 15:21:51 INFO - PID 27132 | 15:21:51 INFO - PID 27132 | [#8] json-parse-financial Cycles:10 Average:45.30 Median:45.50 stddev:0.95 (2.1%) stddev-sans-first:0.88 15:21:51 INFO - PID 27132 | Values: 44.0 45.0 45.0 44.0 47.0 46.0 46.0 46.0 45.0 45.0 15:21:51 INFO - PID 27132 | 15:21:51 INFO - PID 27132 | [#9] json-stringify-tinderbox Cycles:10 Average:54.40 Median:54.50 stddev:0.52 (0.9%) stddev-sans-first:0.53 15:21:51 INFO - PID 27132 | Values: 54.0 54.0 55.0 54.0 55.0 54.0 55.0 54.0 54.0 55.0 15:21:51 INFO - PID 27132 | 15:21:51 INFO - PID 27132 | [#10] stanford-crypto-aes Cycles:10 Average:81.80 Median:81.00 stddev:2.90 (3.6%) stddev-sans-first:2.03 15:21:51 INFO - PID 27132 | Values: 88.0 82.0 80.0 80.0 80.0 80.0 82.0 80.0 86.0 80.0 15:21:51 INFO - PID 27132 | 15:21:51 INFO - PID 27132 | [#11] stanford-crypto-ccm Cycles:10 Average:133.20 Median:130.50 stddev:12.91 (9.9%) stddev-sans-first:13.49 15:21:51 INFO - PID 27132 | Values: 127.0 127.0 130.0 138.0 125.0 125.0 127.0 134.0 168.0 131.0 15:21:51 INFO - PID 27132 | 15:21:51 INFO - PID 27132 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:183.80 Median:185.50 stddev:3.16 (1.7%) stddev-sans-first:2.55 15:21:51 INFO - PID 27132 | Values: 178.0 187.0 187.0 184.0 187.0 186.0 181.0 182.0 181.0 185.0 15:21:51 INFO - PID 27132 | 15:21:51 INFO - PID 27132 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.50 Median:66.00 stddev:3.89 (5.9%) stddev-sans-first:4.13 15:21:51 INFO - PID 27132 | Values: 66.0 65.0 67.0 66.0 64.0 67.0 65.0 77.0 65.0 63.0 15:21:51 INFO - PID 27132 | -------- Summary: end -------- 15:21:51 INFO - PID 27132 | 15:21:53 INFO - TEST-INFO | 27132: exit 0 15:21:53 INFO - TEST-OK | kraken | took 61079ms 15:21:53 INFO - SUITE-END | took 1176s 15:21:53 INFO - Completed test suite (00:19:36) 15:21:53 INFO - javascript benchmark 15:21:53 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7467.428552684064, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3252.528383384409, 3276.6231883333394, 3292.2592416706243, 3299.7030267275954, 3301.966810693223, 5420.512153906147, 5543.1408131739545, 5604.80383186588, 5674.906783574052, 5685.289338832646, 5537.556995440365, 5566.053770858964, 5573.665580065199, 5726.799562015331, 5779.3642699303045, 4997.450280469155, 5007.549320561149, 5024.397072351323, 5055.671381360218, 5067.949320506785, 4975.651704380694, 5066.620003499752, 5095.490450954912, 5172.948270517284, 5228.372595288552, 4905.3132561441425, 5134.563562097226, 5135.845924622267, 5170.819021334254, 5172.19830926207, 5007.774650140716, 5042.243663450475, 5045.41977672565, 5106.489351064901, 5117.53942145205, 5125.897482050375, 5142.151544995071, 5147.794088236466, 5148.382194136728, 5155.484451554852, 5655.8586035349035, 5663.943360566383, 5683.488486036235, 5693.743781529841, 5695.743691533849, 6184.783532576338, 6193.4425901669065, 6193.4425901669065, 6196.225471816023, 6210.347913469111, 6007.609505382136, 6085.847853803691, 6106.023036314168, 6122.326544080192, 6238.251409830849, 5650.29371328584, 5705.0, 5744.798932037442, 5782.739776710058, 5788.044972579477, 6304.369563043659, 6331.525135614847, 6336.20797400325, 6356.14192084072, 6361.522885783585, 6108.633481991006, 6111.816645500642, 6124.35694252106, 6125.509959203253, 6133.233345831771, 5970.701464926737, 6046.2139921809885, 6054.576179667381, 6118.832384214075, 6123.571350005457, 5878.735456904449, 6164.075388691643, 6181.011038233861, 6186.876262474725, 6195.256569211723, 6005.249343832021, 6029.246344206974, 6069.119977603223, 6114.397440808724, 6123.720072747168, 4658.627309815207, 4662.953370466252, 4665.5567721066445, 4692.5307469253485, 4719.834805781781, 4158.334666453353, 4162.958370416257, 4170.35359519275, 4170.812313445902, 4210.989362552965, 5575.944240557624, 5605.187247849039, 5605.495505404451, 5618.185363122406, 5743.0, 6089.908651370233, 6112.633242005494, 6113.296970848321, 6114.541409394314, 6114.969425152845, 5628.943710562924, 5700.344460387026, 5705.400932902068, 5706.657600543981, 5756.050251708505, 5365.785368585213, 5366.248725178478, 5369.060414427459, 5370.409254981949, 5410.810621628224, 6464.127342808754, 6475.158229430144, 6478.4169424752, 6481.0, 6484.416402523795, 5952.345242023461, 6054.545909056927, 6202.689865506797, 6204.658743768956, 6219.626822390671, 6247.625142491283, 6331.493480521455, 6413.647249401328, 6415.871682566416, 6428.164338635947, 6045.183900173421, 6059.121427393092, 6068.478616545584, 6074.0281554951, 6107.511399088151, 6115.502909186769, 6162.198914141133, 6168.475679567287, 6174.8147555573405, 6175.2589689237575, 5775.8556036099435, 5852.531797456279, 5984.491318237824, 5984.910226346521, 6009.7896573621465, 6063.393660634078, 6067.332593414809, 6071.5446341523675, 6075.058365953284, 6075.605085669417, 6029.75880964774, 6030.336662967158, 6031.939680603138, 6035.758569657164, 6048.0625503047095, 5758.222639943554, 5857.9121313179485, 5890.793822216202, 5944.6730429826775, 6058.485028772604, 5913.05391137416, 5927.199828023334, 5933.614315069507, 5944.524438045032, 5945.881082378241], "value": 5623.423667808788, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [713.9143302803665, 793.41287447289, 813.4671789977565, 1140.1676775953554, 1160.965171044868, 29585.55621665674, 30218.54672179919, 30228.09315720529, 30239.092827215165, 33620.49569256457, 38080.0, 38582.0, 38642.42036369457, 38666.420003699895, 38678.61321386785, 7167.784966451002, 7292.8906066409045, 7299.087614048244, 7303.137699886522, 7305.780826575211, 5647.632903861257, 5803.332616749086, 7292.525985810932, 7377.188509263977, 7397.0, 7143.42852571793, 7329.633518324089, 7343.816404589875, 7349.5590264584025, 7357.521761085539, 7330.890036649428, 7392.815179620498, 7396.630168491554, 7398.593077380769, 7403.407727381797, 5616.606837521375, 5789.189513468118, 7243.456740744413, 7328.596927169004, 7334.229905859861, 34283.657163428295, 35052.6494735052, 35136.64863351385, 35233.64766352329, 35266.82366588151, 3458.654134586546, 3467.0292318150705, 3495.94756078659, 3500.177458297298, 3501.037214765934, 28917.56623650647, 29019.564706529418, 29037.41925161485, 29042.854785725936, 29057.564136537756, 3601.333753255656, 3665.5601327840563, 3875.670568001723, 3876.8643097491454, 3890.5720370759195, 176688.0, 176760.0, 176770.11614941971, 177911.0, 178030.0, 47350.28974565384, 47427.0, 47513.0, 47531.76234118876, 47595.76202119036, 48702.75648621805, 48762.75618621955, 48932.51067489351, 49048.509514905105, 49055.75472122688, 15323.23383830804, 15387.692246155015, 15416.075035497906, 15422.460213892684, 15434.382624694887, 12437.62687119388, 12452.626421207378, 12467.625971220878, 12482.0, 12489.125761196628, 12040.518379264906, 12323.445444955, 12343.0, 13746.518871839438, 14125.576232713034, 4830.694670408822, 5494.230807686927, 5606.327240731139, 5739.110437882135, 5749.655020698771, 1070.8072546941469, 1085.218642577343, 1110.8444817725524, 1114.916381271408, 1124.7413094988035, 26246.21261362162, 26537.86731066332, 26592.867035665084, 26608.60087098695, 26670.5999410009, 1131.264677959333, 1166.1487114406532, 1171.0, 1172.267332916927, 1190.922590031645, 13362.53231136925, 13484.325783710776, 13696.520621778389, 13767.655808604864, 13812.1022133561, 250554.0, 253548.0, 253996.0, 254151.0, 254326.0, 53502.0, 53739.462605374225, 53764.19353709697, 53815.730921345144, 53857.46142538603, 1462.5831637983124, 1476.9113853168844, 1511.508759653117, 1515.0606623893257, 1515.4089904937084, 23840.284791456284, 25086.74913250844, 25209.0, 25234.36914077163, 25259.242222733348, 35478.0, 35685.28629427345, 35698.46452303165, 35728.464073039446, 35728.64271357253, 222175.0, 222887.0, 223012.0, 223218.0, 224020.0, 33071.66928330782, 33382.499262510595, 33402.4989625151, 33422.0, 33430.83284583561, 34233.82883085569, 39937.0, 40717.1856562873, 42820.1435971285, 42929.57070429381, 30074.248143795703, 30580.0, 30695.2326191847, 30911.536326954665, 31441.685583143877, 30095.69904300929, 30206.697933020387, 30584.541231881984, 31165.220869478446, 31248.843755781076, 35059.298814024085, 35487.0, 35543.28913421769, 35582.14744502951, 35880.64119358773, 29389.412211756073, 29739.40521189521, 30022.3995520084, 30024.0, 30339.241518962204, 23988.40028999289, 24316.392090197885, 24717.25848224556, 24963.0, 25007.624885626366], "value": 16627.850509919368, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [376.52369752263377, 450.96843220974523, 454.5545365541769, 460.7396820796248, 464.4380299837196, 19041.143148558313, 19175.32886348978, 19688.21247150114, 20004.69992950107, 20187.697184542245, 21521.892390538065, 21551.245706400277, 21791.346259612237, 22192.8890355548, 22212.0, 5535.944640553604, 5673.517750991171, 5677.148427735831, 5681.346645135821, 5683.232763576926, 5297.973510132444, 5445.156000819879, 5474.671519708831, 5489.505944464997, 5492.038893193695, 5452.40023597404, 5454.836354909359, 5456.563474921997, 5456.7544460499175, 5469.781208751645, 5383.192521121843, 5529.640573362719, 5561.165825126263, 5565.499105080562, 5566.638168519034, 5001.524855138756, 5020.497950204986, 5069.0, 5071.391433028023, 5072.771725272335, 24148.63777043346, 24435.26694199177, 24516.0, 24561.14036008749, 24750.133745318828, 2085.7914208579173, 2100.4433825036376, 2118.8622739521884, 2119.5231073008604, 2120.363890832744, 15965.680686386324, 16609.169541522875, 16650.0, 16707.749383759252, 16732.916335418246, 2087.217293514932, 2118.0892216346965, 2165.53441010182, 2173.8913054347217, 2174.065151984646, 97182.0, 98505.0, 98994.0100598992, 99175.0, 100560.94390560959, 11068.723281918017, 12213.0, 12281.324527150913, 12426.378681065911, 12652.493900244071, 16035.19824008795, 16055.357785688675, 16960.321587136375, 17771.111444427985, 17779.288828446977, 8191.754247372588, 8243.752687419386, 8401.831963360699, 8406.117357677478, 8475.406721529556, 7405.8889116663295, 7414.480986330905, 7420.85158296831, 7577.052868391451, 7598.81002974919, 7838.21617838223, 7843.490173138728, 7879.724209652634, 7935.365170786438, 8111.513309201467, 2104.3266154830612, 2177.6406892862815, 2188.4528867783056, 2252.695886055394, 2253.876036817958, 1030.7989941961396, 1057.9949048403894, 1062.1184416934082, 1065.1798115451058, 1071.3518321415431, 19113.904430478036, 20813.0, 21210.893945530483, 21215.68176477354, 21259.46851328698, 1055.5566662001977, 1064.350746044912, 1065.7069305940772, 1068.2575609951164, 1077.9622713205001, 10777.353358798497, 11389.658310250707, 11436.656900293005, 11466.48400821965, 11504.0, 510057.0, 511170.0, 517282.0, 529334.0, 532362.0, 93203.0, 94588.52705736565, 94998.0, 96179.0, 97620.58327958487, 1138.8918052784973, 1185.199990006742, 1197.0423661071281, 1199.7660456210956, 1202.5971299614553, 16661.91669041647, 17010.48968530946, 17317.393891213746, 17573.912130439265, 17839.197236124666, 43882.0, 44770.328445074, 45484.77257613691, 45541.0, 45697.54302457066, 57191.71404142953, 57480.71259643675, 57740.4225957735, 57985.420145798, 62946.37053629405, 9413.764655883384, 9532.046795320413, 9598.760030999281, 9632.133108020313, 10041.548130334006, 14408.13551186932, 14932.328045237773, 15246.923765381101, 15427.9200455967, 15905.443309484113, 12432.440540175532, 12450.501979920702, 12586.056045796418, 12757.362131893553, 12918.806217906551, 11572.18994670365, 11877.703057423634, 12073.517059317881, 12133.453994570089, 13067.150635209062, 12542.686432839251, 12608.432620532281, 12710.618681439571, 13025.218486890817, 13795.0, 9594.280428967715, 9706.592544080928, 9776.071273229032, 9898.50507474609, 9941.65204217849, 12492.625221243377, 12549.498020079094, 12734.490620375082, 13081.280529570964, 14120.576382708536], "value": 9982.886127253856, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1325.9270740109293, 1376.6420730610039, 1409.9436022559098, 1423.4804296431791, 1423.9715205695886, 10653.680389588315, 11108.16688748343, 11116.499757510912, 11134.554617815287, 11159.107271418286, 10880.238383313152, 11029.393383363911, 11412.372319522423, 11419.885801141985, 11421.885781142186, 2199.8570092943987, 2220.18963078476, 2223.7665045170265, 2237.3847192022163, 2242.7308722953267, 1983.5338695406567, 2276.1805749930013, 2310.87290199039, 2339.6841426407473, 2340.847844890077, 1892.3376818113618, 2145.4743587821004, 2290.6678531612906, 2292.942676433086, 2293.8738369389675, 2288.8397812153157, 2312.0867257433306, 2317.1774020222747, 2324.035525257025, 2325.2210509479346, 2174.9782502174935, 2188.927425561479, 2274.465500607356, 2289.8053665438456, 2294.52962142762, 10718.785624287548, 10742.086922611586, 10831.566737330497, 10842.403667798268, 10848.945755271174, 6329.746810127589, 6493.610383377012, 6498.837529061764, 6535.836604084936, 6537.5750576212395, 3643.4352675335367, 3895.02624343914, 3933.6853051756075, 3979.96520904564, 4012.558618551957, 1120.4341807387218, 1157.0859021373105, 1157.3692337675986, 1242.0188051439352, 1271.6375832887582, 15675.059496430136, 15786.447474338458, 15793.92103039489, 15806.60483487922, 15809.92095039529, 4970.0, 5118.334616499831, 5195.064888320138, 5367.543758780547, 5397.8380648580605, 11735.4132293385, 11744.119191060534, 11748.236364636272, 11756.0, 11765.588204412805, 6366.554341196164, 6376.0, 6378.712957916905, 6379.681015949277, 6386.393292637192, 5913.822585322448, 6011.789587364421, 6051.425114614105, 6067.635941843503, 6114.57197996136, 4139.97930010348, 4192.727472714264, 4203.705740598129, 4241.706279584694, 4294.935575966363, 1101.8512500812449, 1118.9160812939062, 1119.4682525800342, 1142.5601143559788, 1152.6369193703956, 718.3247747117797, 731.436793668872, 738.2654259012318, 747.8766003609452, 773.3658400111967, 5600.0, 5660.660360378391, 5711.371749107595, 5729.742161602738, 5961.344252132262, 866.8868591575152, 884.8805411269525, 894.5750768384966, 899.964001439935, 921.5806807902388, 3561.0919215600375, 3570.732195085379, 3574.160072382988, 3578.6600272974547, 3634.6910512606196, 14738.484153054591, 15359.308831102628, 15379.538613841603, 15385.153816539974, 15388.769168462482, 14684.118952862862, 15019.0, 15319.540413787381, 15351.462698805488, 15361.923190383977, 9329.393589416666, 9355.719328420158, 9572.61709531625, 9595.568199430903, 9620.71137865865, 6325.905111423241, 6371.745130194926, 6383.265924418752, 6422.550421470452, 6493.253275873335, 13116.08187426871, 13242.139260948008, 13307.201567905957, 13783.586492405244, 13947.0, 13700.65748356299, 13802.309884505936, 14038.227897465737, 14075.507357242448, 14199.432022718975, 8394.748157555283, 8472.534010629228, 8476.957615212132, 8557.315414766928, 8578.270846978077, 10824.837627435438, 10993.560257589606, 10998.175136864607, 11002.33985960845, 11003.284786488852, 9285.210757085724, 9418.670346537838, 9438.669646562337, 9662.3236373456, 9718.70843874685, 9226.261899048195, 9259.67591134307, 9324.627014919328, 9344.15902568772, 9443.952780236055, 7609.429292802951, 7757.883631745642, 7770.53376797394, 7777.688892444466, 7780.144184139627, 5543.25166102571, 5589.385167631476, 5616.494515493625, 5746.310442746897, 5862.853428664147, 5659.122835960433, 5767.048437007847, 5774.769009239583, 5874.882502349844, 5947.405259474018], "value": 5151.073734883285, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [399.8180827723385, 401.09953155166653, 402.24779662032006, 402.25181163036746, 413.099443213794, 5693.601447898649, 5694.800681976131, 5718.857028574277, 5732.570057245707, 5739.368669446363, 5436.836894893149, 5554.1391084381885, 5579.0, 5588.86027849304, 5604.887902241963, 4398.362237475564, 4401.405810215612, 4402.701203145072, 4403.788958036534, 4431.911361772763, 4413.227685155101, 4422.226110430678, 4423.977880110595, 4425.137098265839, 4449.688521803475, 4084.7344922579937, 4212.115455754295, 4223.64099051581, 4245.745255284677, 4418.447694038246, 4222.2611043067645, 4225.746175444906, 4226.154769046203, 4245.469316335458, 4247.617714405703, 3692.9630703693156, 3703.2223233121076, 3735.1782607826235, 3740.3267411865854, 3758.0, 5344.22508736235, 5471.647191707564, 5517.144842549411, 5550.5282051025715, 5553.667799320416, 4947.332110165117, 4954.355933728628, 4959.975200124012, 4988.476209997971, 4989.875253118665, 5930.614510056876, 5940.851478713023, 5967.522598192134, 5969.283685957669, 5971.671558064305, 4123.402106694542, 4157.3140431828715, 4171.290880550314, 4190.8533201337805, 4207.97896010518, 5927.555433342516, 6085.2697676278685, 6151.846203844895, 6200.565960382775, 6252.781152659635, 4050.25070361984, 4088.345864661699, 4105.85629502966, 4107.466029416217, 4121.62905338521, 4003.279409706281, 4058.573849745734, 4154.854580089743, 4159.7920103994675, 4168.353500367399, 4746.501617330199, 4759.8814278644495, 4760.428748550127, 4767.570918617272, 4772.546608072227, 5900.822975310747, 5908.527317814651, 5923.17075609415, 5929.555283353766, 5951.5238780897425, 1428.0788891165141, 1459.9050711966026, 1465.8241011078526, 1474.2555009720238, 1474.8451412601737, 975.3903810118676, 978.2614126334572, 986.7977064701719, 993.8459538771502, 998.8851282102651, 5727.28408948873, 5756.366799652035, 5771.509421699203, 5776.277965254343, 5779.15686068768, 6011.218541589566, 6028.397160284024, 6082.391760823971, 6095.988323853117, 6117.959946809053, 5635.690037048002, 5713.342965558931, 5738.397468265855, 5751.252337196222, 5781.774017003484, 3210.229544909205, 3225.177579717157, 3230.1601583588435, 3233.531137984979, 3245.8052516849066, 6291.905621415683, 6293.905591416133, 6367.649779262092, 6416.582922110048, 6430.0, 6184.567080304336, 6209.006558950547, 6215.34738852423, 6218.689065546704, 6267.2479302484, 6185.257769067741, 6368.936310636835, 6395.904061439082, 6406.4554512866, 6431.74273029083, 6052.364501727431, 6053.243344581927, 6081.148639190428, 6086.269647642312, 6117.265928088658, 6018.1875446815875, 6039.406553100898, 6042.0332746760305, 6047.365026672136, 6063.120847477179, 6197.0, 6359.8092057238355, 6418.133551970611, 6456.386643268882, 6469.191351081115, 4136.482939632546, 4140.15126898991, 4140.3168477200925, 4145.585441455831, 4151.875443736692, 6057.454829065406, 6086.239220097488, 6191.721372538336, 6191.84520386994, 6201.844953876009, 5915.763369465173, 5982.551308651781, 6009.399060093956, 6019.428154325332, 6024.9397506026135, 5958.344582096052, 5973.850653733692, 5977.3126090500145, 6001.609895356963, 6003.8198854034445, 5849.970750146222, 5894.587378883609, 5922.940770592411, 5965.28416590012, 6010.579259451796, 5953.7023148843255, 5964.701764911824, 5980.551458640706, 5985.952458319864, 5994.430529099728, 5742.885142297047, 5829.300483941955, 5861.856937897069, 5874.324452687824, 5878.706064696663], "value": 4505.0079362286615, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [860.7331727164583, 867.717991652713, 872.3752807086554, 878.5299864572455, 894.6913314906357, 16702.248398822067, 16833.83166168338, 17002.234899429524, 17021.574460638476, 17026.574335641584, 16922.153892305396, 18147.818521814777, 18570.16434260458, 18744.156512956917, 18962.62074758504, 949.9715008549738, 978.8238117138912, 980.1570649241646, 980.2060331131806, 980.6861804222651, 1032.1123833503182, 1035.1098055672117, 1035.7824856780085, 1036.0520124086452, 1036.440322225997, 1078.8759292681364, 1079.8542196803448, 1080.0873262093519, 1081.621432498623, 1081.9296745711542, 1069.8983596558314, 1070.42197213505, 1070.7644318249972, 1070.9464526773709, 1071.0, 792.4334101117729, 794.1383598795314, 794.2692722695134, 794.7575989323254, 795.645937557787, 15183.924080379527, 15475.380984760595, 15475.922620386826, 15698.293576789072, 15827.446039388682, 15814.920925395414, 16144.273507692182, 16344.836551634451, 16434.178291085398, 16654.75017874733, 14003.859961400358, 14049.157050576998, 14186.290685465789, 14236.928815355857, 14265.002899594065, 3366.0406784066668, 3381.746369022333, 3388.457846744509, 3395.575553055868, 3398.235397035672, 94386.0, 95096.52451737766, 95271.0, 95599.0, 103087.48456257746, 13960.650983725489, 14041.5085472008, 14191.574252772434, 14285.85714142866, 14300.642483937776, 25039.87480062588, 25215.495690086464, 25603.0, 25887.870560647076, 26136.34659133499, 7893.526388416713, 7962.6416811243635, 8029.598520073973, 8070.959645201737, 8092.150324215991, 3993.341098718737, 4090.4682391288943, 4106.3429851224255, 4114.238865809834, 4129.442525259112, 4245.61789438952, 4340.739555626673, 4341.806003349041, 4344.109457561192, 4371.147626212858, 833.4124442268186, 847.4449235750593, 849.9915000850036, 850.4472093139509, 851.646566674823, 709.0569542508451, 711.9501634885612, 718.0808565036762, 737.3658653557936, 747.5738828867493, 10901.618443354444, 11096.778064438828, 11154.386508741934, 11753.823692644617, 12748.80876786849, 679.7858674517511, 681.8636272745471, 686.6944209826679, 689.3864460630043, 706.3078183380316, 5228.189630607262, 5229.607779416483, 5322.361316642027, 5360.624756267024, 5430.755615997289, 84397.0, 84715.0, 85340.0, 86982.0, 88689.0, 67726.322736772, 67749.3225067753, 72014.63992680002, 72815.63592182111, 72929.6353518229, 58622.563708797235, 59436.0, 60874.6052684179, 62322.0, 63583.36416635867, 11913.821292680443, 12932.806007909701, 12980.415881285553, 12987.610371688865, 13034.0, 30826.53760193554, 31581.526277105404, 31855.681443185273, 32928.83535582403, 33142.502862457564, 38174.23651526898, 38290.0, 38522.22955540929, 38597.421038685, 39385.606143938196, 15534.300956457213, 15572.29924653416, 15692.0, 15750.369985200463, 16010.119443430724, 18140.637187256445, 18180.636387271916, 18430.907845460686, 18452.63094738071, 18696.34562790296, 17020.148992550075, 17028.233729481955, 17236.741448878027, 17341.65316693684, 17692.965308989114, 16295.429659961845, 16618.916905415397, 16738.748918766472, 17175.484735457958, 17249.741253881453, 14216.147031178163, 14296.499622513162, 14314.141151530941, 14359.282035898372, 14720.043197192577, 10379.11777498921, 10387.117095047006, 10493.47532623381, 10524.36853788775, 10545.9472702636, 10958.616448424267, 11041.227114102257, 11544.365059921785, 11601.883981160081, 11765.52937882475], "value": 8004.0027691640935, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1487.0, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 109.0, 111.0, 109.0, 108.0, 112.0, 112.0, 109.0, 110.0, 110.0], "value": 110.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 117.0, 117.0, 181.0, 121.0, 122.0, 124.0, 116.0, 139.0, 117.0], "value": 130.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 162.0, 163.0, 161.0, 163.0, 161.0, 159.0, 163.0, 160.0], "value": 161.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 75.0, 76.0, 105.0, 75.0, 74.0, 74.0, 74.0, 96.0, 75.0], "value": 79.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 103.0, 81.0, 82.0, 81.0, 94.0, 81.0, 82.0, 106.0], "value": 87.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 113.0, 114.0, 113.0, 113.0, 113.0, 113.0, 113.0, 112.0, 112.0], "value": 112.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 146.0, 146.0, 146.0, 146.0, 146.0, 147.0, 146.0, 147.0], "value": 146.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 93.0, 93.0, 94.0, 94.0, 94.0, 94.0, 93.0], "value": 93.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [44.0, 45.0, 45.0, 44.0, 47.0, 46.0, 46.0, 46.0, 45.0, 45.0], "value": 45.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 55.0, 54.0, 55.0, 54.0, 55.0, 54.0, 54.0, 55.0], "value": 54.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 82.0, 80.0, 80.0, 80.0, 80.0, 82.0, 80.0, 86.0, 80.0], "value": 81.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [127.0, 127.0, 130.0, 138.0, 125.0, 125.0, 127.0, 134.0, 168.0, 131.0], "value": 133.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [178.0, 187.0, 187.0, 184.0, 187.0, 186.0, 181.0, 182.0, 181.0, 185.0], "value": 183.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 65.0, 67.0, 66.0, 64.0, 67.0, 65.0, 77.0, 65.0, 63.0], "value": 66.5, "unit": "score"}]}]} 15:21:53 INFO - Return code: 0 15:21:53 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 15:21:53 INFO - # TBPL SUCCESS # 15:21:53 INFO - Running post-action listener: _resource_record_post_action 15:21:53 INFO - [mozharness: 2017-05-05 22:21:53.605166Z] Finished run-tests step (success) 15:21:53 INFO - Running post-run listener: _resource_record_post_run 15:21:53 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 12288; Write bytes: 359907328; Read time: 252; Write time: 245860 15:21:53 INFO - TinderboxPrint: CPU usage
12.9% 15:21:53 INFO - TinderboxPrint: I/O read bytes / time
12,288 / 252 15:21:53 INFO - TinderboxPrint: I/O write bytes / time
359,907,328 / 245,860 15:21:53 INFO - TinderboxPrint: CPU idle
8,296.0 (87.1%) 15:21:53 INFO - TinderboxPrint: CPU user
1,183.2 (12.4%) 15:21:53 INFO - TinderboxPrint: Swap in / out
0 / 0 15:21:53 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 4096; Write bytes: 94478336; Read time: 76; Write time: 76620 15:21:53 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 4096; Write bytes: 264863744; Read time: 168; Write time: 169200 15:21:54 INFO - Running post-run listener: _upload_blobber_files 15:21:54 INFO - Blob upload gear active. 15:21:54 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:21:54 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 15:21:54 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', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 15:21:54 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 Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 15:21:54 INFO - (blobuploader) - INFO - Open directory for files ... 15:21:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 15:21:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:21:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:21:55 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 15:21:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:21:55 INFO - (blobuploader) - INFO - Done attempting. 15:21:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 15:21:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:21:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:21:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 15:21:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:21:56 INFO - (blobuploader) - INFO - Done attempting. 15:21:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:21:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:21:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:21:59 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:21:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:21:59 INFO - (blobuploader) - INFO - Done attempting. 15:21:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 15:21:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:21:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:21:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 15:21:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:21:59 INFO - (blobuploader) - INFO - Done attempting. 15:21:59 INFO - (blobuploader) - INFO - Iteration through files over. 15:21:59 INFO - Return code: 0 15:21:59 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:21:59 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:21:59 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2f2ce3c45472f8ea0dfe8603455727c11971bd1f2570daa522eff8973cc04666b6d3c52a9cc266b7532e65fb7c7f6a4b58bd8f3d8f2d93b6cd266b72093aa2f7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0c1bd6330160d4e3108cfb2ae7645f8f5fc4878d0105e921eaefa46afd755e733d59085dc2381419a25e7c84fde004c1fa8f83f93732e08da43d40f5d04f3cf7", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f9d7dee35cb9a63189acc06faa535b112c1b1db43c47413aa30e188f0bfac2ad5468577a78fa285fdf72471fe7e5efef48fb389b13dad8d8e5020c0982c04ed3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4b086bb58bc84364b6d703b3733b55ca64798da0ddf09dddb63aa90a5c3e3bd7992ef45ab81d479ae57d924668dcf5c527bd95b28b506f1d22f2ed6fb0f8d072"} 15:21:59 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:21:59 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:21:59 INFO - Contents: 15:21:59 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2f2ce3c45472f8ea0dfe8603455727c11971bd1f2570daa522eff8973cc04666b6d3c52a9cc266b7532e65fb7c7f6a4b58bd8f3d8f2d93b6cd266b72093aa2f7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0c1bd6330160d4e3108cfb2ae7645f8f5fc4878d0105e921eaefa46afd755e733d59085dc2381419a25e7c84fde004c1fa8f83f93732e08da43d40f5d04f3cf7", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f9d7dee35cb9a63189acc06faa535b112c1b1db43c47413aa30e188f0bfac2ad5468577a78fa285fdf72471fe7e5efef48fb389b13dad8d8e5020c0982c04ed3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4b086bb58bc84364b6d703b3733b55ca64798da0ddf09dddb63aa90a5c3e3bd7992ef45ab81d479ae57d924668dcf5c527bd95b28b506f1d22f2ed6fb0f8d072"} 15:21:59 INFO - Running post-run listener: copy_logs_to_upload_dir 15:21:59 INFO - Copying logs to upload dir... 15:21:59 INFO - mkdir: /builds/slave/test/build/upload/logs 15:21:59 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1246.480057 ========= master_lag: 0.06 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2017-05-05 15:21:59.515616) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-05 15:21:59.522628) ========= 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: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=826874ccc97bd7bf541b4875000001d5-1494021671.550139-2105730831 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2f2ce3c45472f8ea0dfe8603455727c11971bd1f2570daa522eff8973cc04666b6d3c52a9cc266b7532e65fb7c7f6a4b58bd8f3d8f2d93b6cd266b72093aa2f7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0c1bd6330160d4e3108cfb2ae7645f8f5fc4878d0105e921eaefa46afd755e733d59085dc2381419a25e7c84fde004c1fa8f83f93732e08da43d40f5d04f3cf7", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f9d7dee35cb9a63189acc06faa535b112c1b1db43c47413aa30e188f0bfac2ad5468577a78fa285fdf72471fe7e5efef48fb389b13dad8d8e5020c0982c04ed3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4b086bb58bc84364b6d703b3733b55ca64798da0ddf09dddb63aa90a5c3e3bd7992ef45ab81d479ae57d924668dcf5c527bd95b28b506f1d22f2ed6fb0f8d072"} build_url:https://queue.taskcluster.net/v1/task/aCGisYsrQDiwGShbAkUgJg/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011219 build_url: 'https://queue.taskcluster.net/v1/task/aCGisYsrQDiwGShbAkUgJg/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2f2ce3c45472f8ea0dfe8603455727c11971bd1f2570daa522eff8973cc04666b6d3c52a9cc266b7532e65fb7c7f6a4b58bd8f3d8f2d93b6cd266b72093aa2f7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0c1bd6330160d4e3108cfb2ae7645f8f5fc4878d0105e921eaefa46afd755e733d59085dc2381419a25e7c84fde004c1fa8f83f93732e08da43d40f5d04f3cf7", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f9d7dee35cb9a63189acc06faa535b112c1b1db43c47413aa30e188f0bfac2ad5468577a78fa285fdf72471fe7e5efef48fb389b13dad8d8e5020c0982c04ed3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4b086bb58bc84364b6d703b3733b55ca64798da0ddf09dddb63aa90a5c3e3bd7992ef45ab81d479ae57d924668dcf5c527bd95b28b506f1d22f2ed6fb0f8d072"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-05 15:21:59.549397) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-05 15:21:59.549724) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=826874ccc97bd7bf541b4875000001d5-1494021671.550139-2105730831 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004774 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-05 15:21:59.600931) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-05 15:21:59.603234) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-05 15:21:59.603539) ========= ========= Total master_lag: 0.18 =========