builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-011 starttime: 1485434169.44 results: success (0) revision: a338e596b1d9f37186aaeddcfaa572ae043e578d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-26 04:36:09.437191) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-26 04:36:09.437630) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-26 04:36:09.437906) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-26 04:36:09.452169) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-26 04:36:09.452518) ========= 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=5cf47e208febbcd81da23b2e0000026f-1485434169.163693-979319669 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-01-26 04:36:09-- 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% 225M=0s 2017-01-26 04:36:09 (225 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.125628 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-26 04:36:09.593114) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-26 04:36:09.593434) ========= 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=5cf47e208febbcd81da23b2e0000026f-1485434169.163693-979319669 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.013912 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-26 04:36:09.643454) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-26 04:36:09.644489) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev a338e596b1d9f37186aaeddcfaa572ae043e578d --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 a338e596b1d9f37186aaeddcfaa572ae043e578d --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=5cf47e208febbcd81da23b2e0000026f-1485434169.163693-979319669 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-01-26 04:36:10,084 truncating revision to first 12 chars 2017-01-26 04:36:10,084 Setting DEBUG logging. 2017-01-26 04:36:10,084 attempt 1/10 2017-01-26 04:36:10,084 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/a338e596b1d9?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-26 04:36:10,579 unpacking tar archive at: mozilla-central-a338e596b1d9/testing/mozharness/ program finished with exit code 0 elapsedTime=0.814897 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-26 04:36:10.472621) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-26 04:36:10.472944) ========= script_repo_revision: a338e596b1d9f37186aaeddcfaa572ae043e578d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-26 04:36:10.473340) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-26 04:36:10.473622) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-26 04:36:10.482236) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2017-01-26 04:36:10.482547) ========= /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=5cf47e208febbcd81da23b2e0000026f-1485434169.163693-979319669 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:36:11 INFO - MultiFileLogger online at 20170126 04:36:11 in /builds/slave/test 04:36:11 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 04:36:11 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:36:11 INFO - {'append_to_log': False, 04:36:11 INFO - 'base_work_dir': '/builds/slave/test', 04:36:11 INFO - 'blob_upload_branch': 'Firefox', 04:36:11 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:36:11 INFO - 'branch': 'Firefox', 04:36:11 INFO - 'buildbot_json_path': 'buildprops.json', 04:36:11 INFO - 'config_files': ('talos/linux_config.py',), 04:36:11 INFO - 'default_actions': ('clobber', 04:36:11 INFO - 'read-buildbot-config', 04:36:11 INFO - 'download-and-extract', 04:36:11 INFO - 'populate-webroot', 04:36:11 INFO - 'create-virtualenv', 04:36:11 INFO - 'install', 04:36:11 INFO - 'run-tests'), 04:36:11 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:36:11 INFO - 'download_minidump_stackwalk': True, 04:36:11 INFO - 'download_symbols': 'ondemand', 04:36:11 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:36:11 INFO - 'tooltool.py': '/tools/tooltool.py', 04:36:11 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:36:11 INFO - '/tools/misc-python/virtualenv.py')}, 04:36:11 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:36:11 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:36:11 INFO - 'installer_path': 'installer.exe', 04:36:11 INFO - 'log_level': 'info', 04:36:11 INFO - 'log_name': 'talos', 04:36:11 INFO - 'log_to_console': True, 04:36:11 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:36:11 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:36:11 INFO - 'opt_config_files': (), 04:36:11 INFO - 'pip_index': False, 04:36:11 INFO - 'sps_profile': False, 04:36:11 INFO - 'sps_profile_interval': 0, 04:36:11 INFO - 'suite': 'dromaeojs', 04:36:11 INFO - 'system_bits': '32', 04:36:11 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:36:11 INFO - 'title': 'talos-linux64-ix-011', 04:36:11 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:36:11 INFO - 'use_talos_json': True, 04:36:11 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:36:11 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:36:11 INFO - 'work_dir': 'build'} 04:36:11 INFO - [mozharness: 2017-01-26 12:36:11.024832Z] Running clobber step. 04:36:11 INFO - Running pre-action listener: _resource_record_pre_action 04:36:11 INFO - Running main action method: clobber 04:36:11 INFO - rmtree: /builds/slave/test/build 04:36:11 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:36:11 INFO - Running post-action listener: _resource_record_post_action 04:36:11 INFO - [mozharness: 2017-01-26 12:36:11.492840Z] Finished clobber step (success) 04:36:11 INFO - [mozharness: 2017-01-26 12:36:11.492943Z] Running read-buildbot-config step. 04:36:11 INFO - Running pre-action listener: _resource_record_pre_action 04:36:11 INFO - Running main action method: read_buildbot_config 04:36:11 INFO - Using buildbot properties: 04:36:11 INFO - { 04:36:11 INFO - "project": "", 04:36:11 INFO - "product": "firefox", 04:36:11 INFO - "who": "cbook@mozilla.com", 04:36:11 INFO - "installer_path": "public/build/target.tar.bz2", 04:36:11 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 04:36:11 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 04:36:11 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 04:36:11 INFO - "stage_platform": "linux64-pgo", 04:36:11 INFO - "basedir": "/builds/slave/test", 04:36:11 INFO - "buildnumber": 2, 04:36:11 INFO - "platform": "ubuntu64_hw", 04:36:11 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 04:36:11 INFO - "slavebuilddir": "test", 04:36:11 INFO - "taskId": "ccJ1lXRgTRedMoR0YQFaOg", 04:36:11 INFO - "branch": "mozilla-central", 04:36:11 INFO - "script_repo_revision": "production", 04:36:11 INFO - "revision": "a338e596b1d9f37186aaeddcfaa572ae043e578d", 04:36:11 INFO - "slavename": "talos-linux64-ix-011", 04:36:11 INFO - "repo_path": "mozilla-central" 04:36:11 INFO - } 04:36:11 INFO - Finding installer, test and symbols from parent task. 04:36:11 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ccJ1lXRgTRedMoR0YQFaOg'}, attempt #1 04:36:11 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ccJ1lXRgTRedMoR0YQFaOg'}, attempt #1 04:36:12 INFO - Task dependencies: EKXW-e4zQ4e1VnvEJh8APg 04:36:12 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/EKXW-e4zQ4e1VnvEJh8APg'}, attempt #1 04:36:12 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/EKXW-e4zQ4e1VnvEJh8APg/artifacts/public/build/target.tar.bz2 04:36:12 INFO - Set test_url: https://queue.taskcluster.net/v1/task/EKXW-e4zQ4e1VnvEJh8APg/artifacts/public/build/test_packages.json 04:36:12 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/EKXW-e4zQ4e1VnvEJh8APg/artifacts/public/build/target.crashreporter-symbols.zip 04:36:12 INFO - Running post-action listener: _resource_record_post_action 04:36:12 INFO - [mozharness: 2017-01-26 12:36:12.903929Z] Finished read-buildbot-config step (success) 04:36:12 INFO - [mozharness: 2017-01-26 12:36:12.904147Z] Running download-and-extract step. 04:36:12 INFO - Running pre-action listener: _resource_record_pre_action 04:36:12 INFO - Running main action method: download_and_extract 04:36:12 INFO - mkdir: /builds/slave/test/build/tests 04:36:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:36:12 INFO - trying https://queue.taskcluster.net/v1/task/EKXW-e4zQ4e1VnvEJh8APg/artifacts/public/build/target.test_packages.json 04:36:12 INFO - Downloading https://queue.taskcluster.net/v1/task/EKXW-e4zQ4e1VnvEJh8APg/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 04:36:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/EKXW-e4zQ4e1VnvEJh8APg/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 04:36:13 INFO - Downloaded 896 bytes. 04:36:13 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 04:36:13 INFO - Using the following test package requirements: 04:36:13 INFO - {u'common': [u'target.common.tests.zip'], 04:36:13 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 04:36:13 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 04:36:13 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 04:36:13 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 04:36:13 INFO - u'mozbase': [u'target.common.tests.zip'], 04:36:13 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 04:36:13 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 04:36:13 INFO - u'web-platform': [u'target.common.tests.zip', 04:36:13 INFO - u'target.web-platform.tests.zip'], 04:36:13 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 04:36:13 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 04:36:13 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/EKXW-e4zQ4e1VnvEJh8APg/artifacts/public/build/target.common.tests.zip 04:36:13 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/EKXW-e4zQ4e1VnvEJh8APg/artifacts/public/build/target.common.tests.zip'}, attempt #1 04:36:13 INFO - Fetch https://queue.taskcluster.net/v1/task/EKXW-e4zQ4e1VnvEJh8APg/artifacts/public/build/target.common.tests.zip into memory 04:36:14 INFO - Expected file size: 21896602 04:36:14 INFO - Obtained file size: 21896602 04:36:18 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 04:36:18 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/EKXW-e4zQ4e1VnvEJh8APg/artifacts/public/build/target.common.tests.zip 04:36:18 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/EKXW-e4zQ4e1VnvEJh8APg/artifacts/public/build/target.common.tests.zip'}, attempt #1 04:36:18 INFO - Fetch https://queue.taskcluster.net/v1/task/EKXW-e4zQ4e1VnvEJh8APg/artifacts/public/build/target.common.tests.zip into memory 04:36:19 INFO - Expected file size: 21896602 04:36:19 INFO - Obtained file size: 21896602 04:36:23 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/EKXW-e4zQ4e1VnvEJh8APg/artifacts/public/build/target.talos.tests.zip 04:36:23 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/EKXW-e4zQ4e1VnvEJh8APg/artifacts/public/build/target.talos.tests.zip'}, attempt #1 04:36:23 INFO - Fetch https://queue.taskcluster.net/v1/task/EKXW-e4zQ4e1VnvEJh8APg/artifacts/public/build/target.talos.tests.zip into memory 04:36:24 INFO - Expected file size: 14403435 04:36:24 INFO - Obtained file size: 14403435 04:36:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:36:24 INFO - trying https://queue.taskcluster.net/v1/task/EKXW-e4zQ4e1VnvEJh8APg/artifacts/public/build/target.tar.bz2 04:36:24 INFO - Downloading https://queue.taskcluster.net/v1/task/EKXW-e4zQ4e1VnvEJh8APg/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 04:36:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/EKXW-e4zQ4e1VnvEJh8APg/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 04:36:25 INFO - Downloaded 61807226 bytes. 04:36:25 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/EKXW-e4zQ4e1VnvEJh8APg/artifacts/public/build/target.tar.bz2 04:36:25 INFO - mkdir: /builds/slave/test/properties 04:36:25 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:36:25 INFO - Writing to file /builds/slave/test/properties/build_url 04:36:25 INFO - Contents: 04:36:25 INFO - build_url:https://queue.taskcluster.net/v1/task/EKXW-e4zQ4e1VnvEJh8APg/artifacts/public/build/target.tar.bz2 04:36:25 INFO - Running post-action listener: _resource_record_post_action 04:36:25 INFO - Running post-action listener: set_extra_try_arguments 04:36:25 INFO - [mozharness: 2017-01-26 12:36:25.747779Z] Finished download-and-extract step (success) 04:36:25 INFO - [mozharness: 2017-01-26 12:36:25.747876Z] Running populate-webroot step. 04:36:25 INFO - Running pre-action listener: _resource_record_pre_action 04:36:25 INFO - Running main action method: populate_webroot 04:36:25 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:36:25 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:36:25 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:36:25 INFO - '--tppagecycles', 04:36:25 INFO - '7'], 04:36:25 INFO - 'tests': ['tsvgm']}}, 04:36:25 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:36:25 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:36:25 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:36:25 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:36:25 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:36:25 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:36:25 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 04:36:25 INFO - 'talos_options': ['--disable-e10s'], 04:36:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:36:25 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 04:36:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:36:25 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 04:36:25 INFO - 'talos_options': ['--disable-e10s'], 04:36:25 INFO - 'tests': ['damp', 'tps']}, 04:36:25 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 04:36:25 INFO - 'tests': ['damp', 'tps']}, 04:36:25 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:36:25 INFO - 'tests': ['dromaeo_dom']}, 04:36:25 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:36:25 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:36:25 INFO - 'tests': ['basic_compositor_video']}, 04:36:25 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:36:25 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:36:25 INFO - 'tests': ['a11yr', 04:36:25 INFO - 'ts_paint', 04:36:25 INFO - 'tpaint', 04:36:25 INFO - 'sessionrestore', 04:36:25 INFO - 'sessionrestore_no_auto_restore', 04:36:25 INFO - 'tabpaint']}, 04:36:25 INFO - 'other-e10s': {'tests': ['a11yr', 04:36:25 INFO - 'ts_paint', 04:36:25 INFO - 'tpaint', 04:36:25 INFO - 'sessionrestore', 04:36:25 INFO - 'sessionrestore_no_auto_restore', 04:36:25 INFO - 'tabpaint']}, 04:36:25 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:36:25 INFO - 'ts_paint', 04:36:25 INFO - 'tpaint', 04:36:25 INFO - 'sessionrestore', 04:36:25 INFO - 'sessionrestore_no_auto_restore', 04:36:25 INFO - 'tabpaint']}, 04:36:25 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:36:25 INFO - 'ts_paint', 04:36:25 INFO - 'tpaint', 04:36:25 INFO - 'sessionrestore', 04:36:25 INFO - 'sessionrestore_no_auto_restore', 04:36:25 INFO - 'tabpaint']}, 04:36:25 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:36:25 INFO - 'tests': ['a11yr', 04:36:25 INFO - 'ts_paint', 04:36:25 INFO - 'tpaint', 04:36:25 INFO - 'sessionrestore', 04:36:25 INFO - 'sessionrestore_no_auto_restore', 04:36:25 INFO - 'tabpaint']}, 04:36:25 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:36:25 INFO - 'tests': ['a11yr', 04:36:25 INFO - 'ts_paint', 04:36:25 INFO - 'tpaint', 04:36:25 INFO - 'sessionrestore', 04:36:25 INFO - 'sessionrestore_no_auto_restore', 04:36:25 INFO - 'tabpaint']}, 04:36:25 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:36:25 INFO - 'tests': ['tsvgx', 04:36:25 INFO - 'tsvgr_opacity', 04:36:25 INFO - 'tart', 04:36:25 INFO - 'tscrollx', 04:36:25 INFO - 'cart', 04:36:25 INFO - 'tsvg_static']}, 04:36:25 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:36:25 INFO - 'tsvgr_opacity', 04:36:25 INFO - 'tart', 04:36:25 INFO - 'tscrollx', 04:36:25 INFO - 'cart', 04:36:25 INFO - 'tsvg_static']}, 04:36:25 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 04:36:25 INFO - 'talos_options': ['--disable-e10s'], 04:36:25 INFO - 'tests': ['tp5o']}, 04:36:25 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 04:36:25 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 04:36:25 INFO - 'talos_options': ['--disable-e10s', 04:36:25 INFO - '--xperf_path', 04:36:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:36:25 INFO - 'tests': ['tp5n']}, 04:36:25 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 04:36:25 INFO - 'talos_options': ['--xperf_path', 04:36:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:36:25 INFO - 'tests': ['tp5n']}}, 04:36:25 INFO - 'talos.zip': {'path': '', 04:36:25 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:36:25 INFO - Running post-action listener: _resource_record_post_action 04:36:25 INFO - [mozharness: 2017-01-26 12:36:25.760973Z] Finished populate-webroot step (success) 04:36:25 INFO - [mozharness: 2017-01-26 12:36:25.761067Z] Running create-virtualenv step. 04:36:25 INFO - Running pre-action listener: _resource_record_pre_action 04:36:25 INFO - Running main action method: create_virtualenv 04:36:25 INFO - Creating virtualenv /builds/slave/test/build/venv 04:36:25 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 04:36:25 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:36:25 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:36:25 INFO - Using real prefix '/usr' 04:36:25 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:36:26 INFO - Installing distribute.............................................................................................................................................................................................done. 04:36:28 INFO - Installing pip.................done. 04:36:28 INFO - Return code: 0 04:36:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 04:36:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 04:36:28 INFO - Reading from file tmpfile_stdout 04:36:28 INFO - Output received: 04:36:28 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) 04:36:28 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:36:28 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')]} 04:36:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:36:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:36:28 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')]} 04:36:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:36:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:36:28 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 0x206b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2237a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23dcc70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23da3f0>, '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 0x23dacf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23db1a0>, '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': '5cf47e208febbcd81da23b2e0000026f-1485434169.163693-979319669', '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 04:36:28 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 04:36:28 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 04:36:28 INFO - Using env: {'DISPLAY': ':0', 04:36:28 INFO - 'HOME': '/home/cltbld', 04:36:28 INFO - 'LANG': 'en_US.UTF-8', 04:36:28 INFO - 'LANGUAGE': 'en_US:en', 04:36:28 INFO - 'LOGNAME': 'cltbld', 04:36:28 INFO - 'MAIL': '/var/mail/cltbld', 04:36:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:36:28 INFO - 'MOZ_NO_REMOTE': '1', 04:36:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:36:28 INFO - 'NO_EM_RESTART': '1', 04:36:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:36:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:36:28 INFO - 'PWD': '/builds/slave/test', 04:36:28 INFO - 'SHELL': '/bin/bash', 04:36:28 INFO - 'SHLVL': '1', 04:36:28 INFO - 'TERM': 'linux', 04:36:28 INFO - 'TMOUT': '86400', 04:36:28 INFO - 'USER': 'cltbld', 04:36:28 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1485434169.163693-979319669', 04:36:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:36:28 INFO - '_': '/tools/buildbot/bin/python'} 04:36:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:36:28 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 04:36:28 INFO - Cleaning up... 04:36:28 INFO - Return code: 0 04:36:28 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:36:28 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')]} 04:36:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:36:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:36:28 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')]} 04:36:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:36:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:36:28 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 0x206b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2237a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23dcc70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23da3f0>, '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 0x23dacf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23db1a0>, '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': '5cf47e208febbcd81da23b2e0000026f-1485434169.163693-979319669', '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 04:36:28 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 04:36:28 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 04:36:28 INFO - Using env: {'DISPLAY': ':0', 04:36:28 INFO - 'HOME': '/home/cltbld', 04:36:28 INFO - 'LANG': 'en_US.UTF-8', 04:36:28 INFO - 'LANGUAGE': 'en_US:en', 04:36:28 INFO - 'LOGNAME': 'cltbld', 04:36:28 INFO - 'MAIL': '/var/mail/cltbld', 04:36:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:36:28 INFO - 'MOZ_NO_REMOTE': '1', 04:36:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:36:28 INFO - 'NO_EM_RESTART': '1', 04:36:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:36:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:36:28 INFO - 'PWD': '/builds/slave/test', 04:36:28 INFO - 'SHELL': '/bin/bash', 04:36:28 INFO - 'SHLVL': '1', 04:36:28 INFO - 'TERM': 'linux', 04:36:28 INFO - 'TMOUT': '86400', 04:36:28 INFO - 'USER': 'cltbld', 04:36:28 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1485434169.163693-979319669', 04:36:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:36:28 INFO - '_': '/tools/buildbot/bin/python'} 04:36:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:36:28 INFO - Downloading/unpacking psutil>=3.1.1 04:36:28 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 04:36:28 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 04:36:28 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 04:36:28 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 04:36:28 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 04:36:28 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 04:36:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:36:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:36:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:36:31 INFO - Installing collected packages: psutil 04:36:31 INFO - Running setup.py install for psutil 04:36:31 INFO - building 'psutil._psutil_linux' extension 04:36:31 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 04:36:31 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 04:36:31 INFO - building 'psutil._psutil_posix' extension 04:36:31 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 04:36:31 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 04:36:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:36:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:36:31 INFO - Successfully installed psutil 04:36:31 INFO - Cleaning up... 04:36:31 INFO - Return code: 0 04:36:31 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:36:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:36:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:36:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:36:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:36:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:36:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:36:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x206b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2237a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23dcc70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23da3f0>, '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 0x23dacf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23db1a0>, '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': '5cf47e208febbcd81da23b2e0000026f-1485434169.163693-979319669', '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 04:36:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 04:36:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 04:36:31 INFO - Using env: {'DISPLAY': ':0', 04:36:31 INFO - 'HOME': '/home/cltbld', 04:36:31 INFO - 'LANG': 'en_US.UTF-8', 04:36:31 INFO - 'LANGUAGE': 'en_US:en', 04:36:31 INFO - 'LOGNAME': 'cltbld', 04:36:31 INFO - 'MAIL': '/var/mail/cltbld', 04:36:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:36:31 INFO - 'MOZ_NO_REMOTE': '1', 04:36:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:36:31 INFO - 'NO_EM_RESTART': '1', 04:36:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:36:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:36:31 INFO - 'PWD': '/builds/slave/test', 04:36:31 INFO - 'SHELL': '/bin/bash', 04:36:31 INFO - 'SHLVL': '1', 04:36:31 INFO - 'TERM': 'linux', 04:36:31 INFO - 'TMOUT': '86400', 04:36:31 INFO - 'USER': 'cltbld', 04:36:31 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1485434169.163693-979319669', 04:36:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:36:31 INFO - '_': '/tools/buildbot/bin/python'} 04:36:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:36:31 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:36:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:36:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:36:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:36:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:36:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:36:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:36:33 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:36:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:36:33 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:36:33 INFO - Installing collected packages: mozsystemmonitor 04:36:33 INFO - Running setup.py install for mozsystemmonitor 04:36:34 INFO - Successfully installed mozsystemmonitor 04:36:34 INFO - Cleaning up... 04:36:34 INFO - Return code: 0 04:36:34 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:36:34 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')]} 04:36:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:36:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:36:34 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')]} 04:36:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:36:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:36:34 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 0x206b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2237a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23dcc70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23da3f0>, '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 0x23dacf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23db1a0>, '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': '5cf47e208febbcd81da23b2e0000026f-1485434169.163693-979319669', '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 04:36:34 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 04:36:34 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 04:36:34 INFO - Using env: {'DISPLAY': ':0', 04:36:34 INFO - 'HOME': '/home/cltbld', 04:36:34 INFO - 'LANG': 'en_US.UTF-8', 04:36:34 INFO - 'LANGUAGE': 'en_US:en', 04:36:34 INFO - 'LOGNAME': 'cltbld', 04:36:34 INFO - 'MAIL': '/var/mail/cltbld', 04:36:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:36:34 INFO - 'MOZ_NO_REMOTE': '1', 04:36:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:36:34 INFO - 'NO_EM_RESTART': '1', 04:36:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:36:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:36:34 INFO - 'PWD': '/builds/slave/test', 04:36:34 INFO - 'SHELL': '/bin/bash', 04:36:34 INFO - 'SHLVL': '1', 04:36:34 INFO - 'TERM': 'linux', 04:36:34 INFO - 'TMOUT': '86400', 04:36:34 INFO - 'USER': 'cltbld', 04:36:34 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1485434169.163693-979319669', 04:36:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:36:34 INFO - '_': '/tools/buildbot/bin/python'} 04:36:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:36:34 INFO - Downloading/unpacking jsonschema==2.5.1 04:36:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:36:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:36:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:36:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:36:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:36:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:36:36 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:36:36 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:36:36 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 04:36:36 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 04:36:36 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 04:36:36 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 04:36:36 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 04:36:36 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 04:36:36 INFO - Downloading functools32-3.2.3-2.tar.gz 04:36:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:36:36 INFO - warning: no files found matching '*.txt' 04:36:36 INFO - no previously-included directories found matching 'build' 04:36:36 INFO - no previously-included directories found matching 'dist' 04:36:36 INFO - no previously-included directories found matching '.git*' 04:36:36 INFO - Installing collected packages: jsonschema, functools32 04:36:36 INFO - Running setup.py install for functools32 04:36:36 INFO - warning: no files found matching '*.txt' 04:36:36 INFO - no previously-included directories found matching 'build' 04:36:36 INFO - no previously-included directories found matching 'dist' 04:36:36 INFO - no previously-included directories found matching '.git*' 04:36:36 INFO - Successfully installed jsonschema functools32 04:36:36 INFO - Cleaning up... 04:36:36 INFO - Return code: 0 04:36:36 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:36:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:36:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:36:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:36:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:36:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:36:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:36:36 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 0x206b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2237a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23dcc70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23da3f0>, '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 0x23dacf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23db1a0>, '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': '5cf47e208febbcd81da23b2e0000026f-1485434169.163693-979319669', '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 04:36:36 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 04:36:36 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 04:36:36 INFO - Using env: {'DISPLAY': ':0', 04:36:36 INFO - 'HOME': '/home/cltbld', 04:36:36 INFO - 'LANG': 'en_US.UTF-8', 04:36:36 INFO - 'LANGUAGE': 'en_US:en', 04:36:36 INFO - 'LOGNAME': 'cltbld', 04:36:36 INFO - 'MAIL': '/var/mail/cltbld', 04:36:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:36:36 INFO - 'MOZ_NO_REMOTE': '1', 04:36:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:36:36 INFO - 'NO_EM_RESTART': '1', 04:36:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:36:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:36:36 INFO - 'PWD': '/builds/slave/test', 04:36:36 INFO - 'SHELL': '/bin/bash', 04:36:36 INFO - 'SHLVL': '1', 04:36:36 INFO - 'TERM': 'linux', 04:36:36 INFO - 'TMOUT': '86400', 04:36:36 INFO - 'USER': 'cltbld', 04:36:36 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1485434169.163693-979319669', 04:36:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:36:36 INFO - '_': '/tools/buildbot/bin/python'} 04:36:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:36:36 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:36:36 INFO - Cleaning up... 04:36:36 INFO - Return code: 0 04:36:36 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:36:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:36:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:36:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:36:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:36:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:36:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:36:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x206b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2237a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23dcc70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23da3f0>, '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 0x23dacf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23db1a0>, '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': '5cf47e208febbcd81da23b2e0000026f-1485434169.163693-979319669', '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 04:36:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:36:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:36:37 INFO - Using env: {'DISPLAY': ':0', 04:36:37 INFO - 'HOME': '/home/cltbld', 04:36:37 INFO - 'LANG': 'en_US.UTF-8', 04:36:37 INFO - 'LANGUAGE': 'en_US:en', 04:36:37 INFO - 'LOGNAME': 'cltbld', 04:36:37 INFO - 'MAIL': '/var/mail/cltbld', 04:36:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:36:37 INFO - 'MOZ_NO_REMOTE': '1', 04:36:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:36:37 INFO - 'NO_EM_RESTART': '1', 04:36:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:36:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:36:37 INFO - 'PWD': '/builds/slave/test', 04:36:37 INFO - 'SHELL': '/bin/bash', 04:36:37 INFO - 'SHLVL': '1', 04:36:37 INFO - 'TERM': 'linux', 04:36:37 INFO - 'TMOUT': '86400', 04:36:37 INFO - 'USER': 'cltbld', 04:36:37 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1485434169.163693-979319669', 04:36:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:36:37 INFO - '_': '/tools/buildbot/bin/python'} 04:36:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:36:37 INFO - Downloading/unpacking blobuploader==1.2.4 04:36:37 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 04:36:37 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 04:36:37 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 04:36:37 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 04:36:37 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 04:36:37 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 04:36:39 INFO - Downloading blobuploader-1.2.4.tar.gz 04:36:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:36:39 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:36:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:36:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:36:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:36:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:36:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:36:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:36:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:36:39 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:36:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:36:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:36:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:36:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:36:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:36:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:36:39 INFO - Downloading docopt-0.6.1.tar.gz 04:36:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:36:40 INFO - Installing collected packages: blobuploader, requests, docopt 04:36:40 INFO - Running setup.py install for blobuploader 04:36:40 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:36:40 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:36:40 INFO - Running setup.py install for requests 04:36:40 INFO - Running setup.py install for docopt 04:36:40 INFO - Successfully installed blobuploader requests docopt 04:36:40 INFO - Cleaning up... 04:36:40 INFO - Return code: 0 04:36:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:36:40 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')]} 04:36:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:36:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:36:40 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')]} 04:36:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:36:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:36:40 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 0x206b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2237a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23dcc70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23da3f0>, '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 0x23dacf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23db1a0>, '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': '5cf47e208febbcd81da23b2e0000026f-1485434169.163693-979319669', '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 04:36:40 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 04:36:40 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 04:36:40 INFO - Using env: {'DISPLAY': ':0', 04:36:40 INFO - 'HOME': '/home/cltbld', 04:36:40 INFO - 'LANG': 'en_US.UTF-8', 04:36:40 INFO - 'LANGUAGE': 'en_US:en', 04:36:40 INFO - 'LOGNAME': 'cltbld', 04:36:40 INFO - 'MAIL': '/var/mail/cltbld', 04:36:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:36:40 INFO - 'MOZ_NO_REMOTE': '1', 04:36:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:36:40 INFO - 'NO_EM_RESTART': '1', 04:36:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:36:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:36:40 INFO - 'PWD': '/builds/slave/test', 04:36:40 INFO - 'SHELL': '/bin/bash', 04:36:40 INFO - 'SHLVL': '1', 04:36:40 INFO - 'TERM': 'linux', 04:36:40 INFO - 'TMOUT': '86400', 04:36:40 INFO - 'USER': 'cltbld', 04:36:40 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1485434169.163693-979319669', 04:36:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:36:40 INFO - '_': '/tools/buildbot/bin/python'} 04:36:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:36:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:36:40 INFO - Running setup.py (path:/tmp/pip-GTkoud-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:36:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:36:40 INFO - Running setup.py (path:/tmp/pip-1yT5Wa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:36:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:36:40 INFO - Running setup.py (path:/tmp/pip-0hAD69-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:36:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:36:41 INFO - Running setup.py (path:/tmp/pip-ayzeJK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:36:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:36:41 INFO - Running setup.py (path:/tmp/pip-EunZ4e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:36:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:36:41 INFO - Running setup.py (path:/tmp/pip-yRJQJv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:36:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:36:41 INFO - Running setup.py (path:/tmp/pip-x_2fBq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:36:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:36:41 INFO - Running setup.py (path:/tmp/pip-_Z3wr1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:36:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:36:41 INFO - Running setup.py (path:/tmp/pip-7Gyf68-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:36:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:36:41 INFO - Running setup.py (path:/tmp/pip-kiXtPy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:36:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:36:41 INFO - Running setup.py (path:/tmp/pip-wV4ZXr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:36:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:36:41 INFO - Running setup.py (path:/tmp/pip-p4wO5N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:36:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:36:41 INFO - Running setup.py (path:/tmp/pip-Tu5OEq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:36:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:36:41 INFO - Running setup.py (path:/tmp/pip-kqpxK6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:36:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:36:41 INFO - Running setup.py (path:/tmp/pip-l36VQ7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:36:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:36:41 INFO - Running setup.py (path:/tmp/pip-JZQAAc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:36:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:36:42 INFO - Running setup.py (path:/tmp/pip-7xQsEm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:36:42 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:36:42 INFO - Running setup.py install for manifestparser 04:36:42 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:36:42 INFO - Running setup.py install for mozcrash 04:36:42 INFO - Running setup.py install for mozdebug 04:36:42 INFO - Running setup.py install for mozdevice 04:36:42 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:36:42 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:36:42 INFO - Running setup.py install for mozfile 04:36:42 INFO - Running setup.py install for mozhttpd 04:36:42 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:36:42 INFO - Running setup.py install for mozinfo 04:36:42 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:36:42 INFO - Running setup.py install for mozInstall 04:36:42 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:36:42 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:36:42 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:36:42 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:36:42 INFO - Running setup.py install for mozleak 04:36:42 INFO - Running setup.py install for mozlog 04:36:43 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:36:43 INFO - Running setup.py install for moznetwork 04:36:43 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:36:43 INFO - Running setup.py install for mozprocess 04:36:43 INFO - Running setup.py install for mozprofile 04:36:43 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:36:43 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:36:43 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:36:43 INFO - Running setup.py install for mozrunner 04:36:43 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:36:43 INFO - Running setup.py install for mozscreenshot 04:36:43 INFO - Running setup.py install for moztest 04:36:43 INFO - Running setup.py install for mozversion 04:36:43 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:36:43 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:36:43 INFO - Cleaning up... 04:36:43 INFO - Return code: 0 04:36:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:36:43 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')]} 04:36:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:36:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:36:43 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')]} 04:36:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:36:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:36:43 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 0x206b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2237a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23dcc70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23da3f0>, '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 0x23dacf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23db1a0>, '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': '5cf47e208febbcd81da23b2e0000026f-1485434169.163693-979319669', '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 04:36:43 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 04:36:43 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 04:36:43 INFO - Using env: {'DISPLAY': ':0', 04:36:43 INFO - 'HOME': '/home/cltbld', 04:36:43 INFO - 'LANG': 'en_US.UTF-8', 04:36:43 INFO - 'LANGUAGE': 'en_US:en', 04:36:43 INFO - 'LOGNAME': 'cltbld', 04:36:43 INFO - 'MAIL': '/var/mail/cltbld', 04:36:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:36:43 INFO - 'MOZ_NO_REMOTE': '1', 04:36:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:36:43 INFO - 'NO_EM_RESTART': '1', 04:36:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:36:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:36:43 INFO - 'PWD': '/builds/slave/test', 04:36:43 INFO - 'SHELL': '/bin/bash', 04:36:43 INFO - 'SHLVL': '1', 04:36:43 INFO - 'TERM': 'linux', 04:36:43 INFO - 'TMOUT': '86400', 04:36:43 INFO - 'USER': 'cltbld', 04:36:43 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1485434169.163693-979319669', 04:36:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:36:43 INFO - '_': '/tools/buildbot/bin/python'} 04:36:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:36:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:36:44 INFO - Running setup.py (path:/tmp/pip-9bZrhU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:36:44 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)) 04:36:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:36:44 INFO - Running setup.py (path:/tmp/pip-FDo1jD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:36:44 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)) 04:36:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:36:44 INFO - Running setup.py (path:/tmp/pip-NLbLhn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:36:44 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)) 04:36:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:36:44 INFO - Running setup.py (path:/tmp/pip-EDmwSK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:36:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 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)) 04:36:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:36:44 INFO - Running setup.py (path:/tmp/pip-k74tUz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:36:44 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)) 04:36:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:36:44 INFO - Running setup.py (path:/tmp/pip-90Buqg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:36:44 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)) 04:36:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:36:44 INFO - Running setup.py (path:/tmp/pip-9RNLDQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:36:44 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)) 04:36:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:36:44 INFO - Running setup.py (path:/tmp/pip-dhpcTJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:36:44 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)) 04:36:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:36:44 INFO - Running setup.py (path:/tmp/pip-nicCzs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:36:44 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)) 04:36:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:36:44 INFO - Running setup.py (path:/tmp/pip-xY6L6B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:36:44 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)) 04:36:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:36:44 INFO - Running setup.py (path:/tmp/pip-BUQ9e2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:36:44 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)) 04:36:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:36:44 INFO - Running setup.py (path:/tmp/pip-I7XHKG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:36:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 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)) 04:36:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:36:44 INFO - Running setup.py (path:/tmp/pip-71Lugi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:36:45 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)) 04:36:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:36:45 INFO - Running setup.py (path:/tmp/pip-vHIvt3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:36:45 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)) 04:36:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:36:45 INFO - Running setup.py (path:/tmp/pip-MwzqhX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:36:45 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)) 04:36:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:36:45 INFO - Running setup.py (path:/tmp/pip-oTr13z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:36:45 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)) 04:36:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:36:45 INFO - Running setup.py (path:/tmp/pip-6jiVAL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:36:45 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)) 04:36:45 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)) 04:36:45 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)) 04:36:45 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)) 04:36:45 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:36:45 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:36:45 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:36: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 04:36: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 04:36: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 04:36: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 04:36: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 04:36: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 04:36:47 INFO - Downloading blessings-1.6.tar.gz 04:36:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:36:47 INFO - Installing collected packages: blessings 04:36:47 INFO - Running setup.py install for blessings 04:36:47 INFO - Successfully installed blessings 04:36:47 INFO - Cleaning up... 04:36:47 INFO - Return code: 0 04:36:47 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:36:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:36:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:36:47 INFO - Reading from file tmpfile_stdout 04:36:47 INFO - Current package versions: 04:36:47 INFO - argparse == 1.2.1 04:36:47 INFO - blessings == 1.6 04:36:47 INFO - blobuploader == 1.2.4 04:36:47 INFO - docopt == 0.6.1 04:36:47 INFO - functools32 == 3.2.3-2 04:36:47 INFO - jsonschema == 2.5.1 04:36:47 INFO - manifestparser == 1.1 04:36:47 INFO - mozInstall == 1.12 04:36:47 INFO - mozcrash == 1.0 04:36:47 INFO - mozdebug == 0.1 04:36:47 INFO - mozdevice == 0.49 04:36:47 INFO - mozfile == 1.2 04:36:47 INFO - mozhttpd == 0.7 04:36:47 INFO - mozinfo == 0.9 04:36:47 INFO - mozleak == 0.1 04:36:47 INFO - mozlog == 3.4 04:36:47 INFO - moznetwork == 0.27 04:36:47 INFO - mozprocess == 0.24 04:36:47 INFO - mozprofile == 0.28 04:36:47 INFO - mozrunner == 6.13 04:36:47 INFO - mozscreenshot == 0.1 04:36:47 INFO - mozsystemmonitor == 0.3 04:36:47 INFO - moztest == 0.8 04:36:47 INFO - mozversion == 1.4 04:36:47 INFO - psutil == 3.1.1 04:36:47 INFO - requests == 1.2.3 04:36:47 INFO - wsgiref == 0.1.2 04:36:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:36: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')]} 04:36:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:36:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:36: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')]} 04:36:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:36:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:36:47 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 0x206b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2237a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23dcc70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23da3f0>, '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 0x23dacf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23db1a0>, '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': '5cf47e208febbcd81da23b2e0000026f-1485434169.163693-979319669', '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 04:36:47 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 04:36:47 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 04:36:47 INFO - Using env: {'DISPLAY': ':0', 04:36:47 INFO - 'HOME': '/home/cltbld', 04:36:47 INFO - 'LANG': 'en_US.UTF-8', 04:36:47 INFO - 'LANGUAGE': 'en_US:en', 04:36:47 INFO - 'LOGNAME': 'cltbld', 04:36:47 INFO - 'MAIL': '/var/mail/cltbld', 04:36:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:36:47 INFO - 'MOZ_NO_REMOTE': '1', 04:36:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:36:47 INFO - 'NO_EM_RESTART': '1', 04:36:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:36:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:36:47 INFO - 'PWD': '/builds/slave/test', 04:36:47 INFO - 'SHELL': '/bin/bash', 04:36:47 INFO - 'SHLVL': '1', 04:36:47 INFO - 'TERM': 'linux', 04:36:47 INFO - 'TMOUT': '86400', 04:36:47 INFO - 'USER': 'cltbld', 04:36:47 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1485434169.163693-979319669', 04:36:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:36:47 INFO - '_': '/tools/buildbot/bin/python'} 04:36:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:36:48 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)) 04:36:48 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)) 04:36:48 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)) 04:36:48 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)) 04:36:48 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)) 04:36:48 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)) 04:36:48 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)) 04:36:48 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)) 04:36:48 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)) 04:36:48 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)) 04:36:48 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)) 04:36:48 INFO - Cleaning up... 04:36:48 INFO - Return code: 0 04:36:48 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:36: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')]} 04:36:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:36:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:36: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')]} 04:36:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:36:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:36: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']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x206b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2237a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23dcc70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23da3f0>, '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 0x23dacf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23db1a0>, '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': '5cf47e208febbcd81da23b2e0000026f-1485434169.163693-979319669', '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 04:36: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'] in /builds/slave/test/build 04:36: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 04:36:48 INFO - Using env: {'DISPLAY': ':0', 04:36:48 INFO - 'HOME': '/home/cltbld', 04:36:48 INFO - 'LANG': 'en_US.UTF-8', 04:36:48 INFO - 'LANGUAGE': 'en_US:en', 04:36:48 INFO - 'LOGNAME': 'cltbld', 04:36:48 INFO - 'MAIL': '/var/mail/cltbld', 04:36:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:36:48 INFO - 'MOZ_NO_REMOTE': '1', 04:36:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:36:48 INFO - 'NO_EM_RESTART': '1', 04:36:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:36:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:36:48 INFO - 'PWD': '/builds/slave/test', 04:36:48 INFO - 'SHELL': '/bin/bash', 04:36:48 INFO - 'SHLVL': '1', 04:36:48 INFO - 'TERM': 'linux', 04:36:48 INFO - 'TMOUT': '86400', 04:36:48 INFO - 'USER': 'cltbld', 04:36:48 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1485434169.163693-979319669', 04:36:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:36:48 INFO - '_': '/tools/buildbot/bin/python'} 04:36:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:36:48 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:36:48 INFO - Cleaning up... 04:36:48 INFO - Return code: 0 04:36:48 INFO - Running post-action listener: _resource_record_post_action 04:36:48 INFO - Running post-action listener: _start_resource_monitoring 04:36:48 INFO - Starting resource monitoring. 04:36:48 INFO - [mozharness: 2017-01-26 12:36:48.325605Z] Finished create-virtualenv step (success) 04:36:48 INFO - [mozharness: 2017-01-26 12:36:48.326114Z] Running install step. 04:36:48 INFO - Running pre-action listener: _resource_record_pre_action 04:36:48 INFO - Running main action method: install 04:36:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:36:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:36:48 INFO - Reading from file tmpfile_stdout 04:36:48 INFO - Detecting whether we're running mozinstall >=1.0... 04:36:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:36:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:36:48 INFO - Reading from file tmpfile_stdout 04:36:48 INFO - Output received: 04:36:48 INFO - Usage: mozinstall [options] installer 04:36:48 INFO - Options: 04:36:48 INFO - -h, --help show this help message and exit 04:36:48 INFO - -d DEST, --destination=DEST 04:36:48 INFO - Directory to install application into. [default: 04:36:48 INFO - "/builds/slave/test"] 04:36:48 INFO - --app=APP Application being installed. [default: firefox] 04:36:48 INFO - mkdir: /builds/slave/test/build/application 04:36:48 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'] 04:36:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 04:37:06 INFO - Reading from file tmpfile_stdout 04:37:06 INFO - Output received: 04:37:06 INFO - /builds/slave/test/build/application/firefox/firefox 04:37:06 INFO - Running post-action listener: _resource_record_post_action 04:37:06 INFO - [mozharness: 2017-01-26 12:37:06.179556Z] Finished install step (success) 04:37:06 INFO - [mozharness: 2017-01-26 12:37:06.179701Z] Running run-tests step. 04:37:06 INFO - Running pre-action listener: _resource_record_pre_action 04:37:06 INFO - Running main action method: run_tests 04:37:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:37:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:37:06 INFO - Python 2.7.3 04:37:06 INFO - Return code: 0 04:37:06 INFO - grabbing minidump binary from tooltool 04:37:06 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')]} 04:37:06 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 0x23da3f0>, '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 0x23dacf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23db1a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:37:06 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 04:37:06 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 04:37:06 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 04:37:06 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:37:06 INFO - Return code: 0 04:37:06 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:37:06 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:37:06 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:37:06 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:37:06 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:37:06 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/EKXW-e4zQ4e1VnvEJh8APg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-011', '--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 04:37:06 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/EKXW-e4zQ4e1VnvEJh8APg/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-011 --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 04:37:06 INFO - Using env: {'DISPLAY': ':0', 04:37:06 INFO - 'HOME': '/home/cltbld', 04:37:06 INFO - 'LANG': 'en_US.UTF-8', 04:37:06 INFO - 'LANGUAGE': 'en_US:en', 04:37:06 INFO - 'LOGNAME': 'cltbld', 04:37:06 INFO - 'MAIL': '/var/mail/cltbld', 04:37:06 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:37:06 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:37:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:37:06 INFO - 'MOZ_NO_REMOTE': '1', 04:37:06 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:37:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:37:06 INFO - 'NO_EM_RESTART': '1', 04:37:06 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:37:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:37:06 INFO - 'PWD': '/builds/slave/test', 04:37:06 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:37:06 INFO - 'SHELL': '/bin/bash', 04:37:06 INFO - 'SHLVL': '1', 04:37:06 INFO - 'TERM': 'linux', 04:37:06 INFO - 'TMOUT': '86400', 04:37:06 INFO - 'USER': 'cltbld', 04:37:06 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1485434169.163693-979319669', 04:37:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:37:06 INFO - '_': '/tools/buildbot/bin/python'} 04:37:06 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/EKXW-e4zQ4e1VnvEJh8APg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-011', '--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 04:37:06 INFO - mozversion application_buildid: 20170126113202 04:37:06 INFO - mozversion application_changeset: a338e596b1d9f37186aaeddcfaa572ae043e578d 04:37:06 INFO - mozversion application_display_name: Nightly 04:37:06 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:37:06 INFO - mozversion application_name: Firefox 04:37:06 INFO - mozversion application_remotingname: firefox 04:37:06 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:37:06 INFO - mozversion application_vendor: Mozilla 04:37:06 INFO - mozversion application_version: 54.0a1 04:37:06 INFO - mozversion platform_buildid: 20170126113202 04:37:06 INFO - mozversion platform_changeset: a338e596b1d9f37186aaeddcfaa572ae043e578d 04:37:06 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:37:06 INFO - mozversion platform_version: 54.0a1 04:37:06 INFO - using testdate: 1485434226 04:37:06 INFO - actual date: 1485434226 04:37:06 INFO - starting webserver on 'localhost:54216' 04:37:06 INFO - SUITE-START | Running 2 tests 04:37:06 INFO - TEST-START | dromaeo_css 04:37:06 INFO - operating with platform_type : linux_ 04:37:06 INFO - Initialising browser for dromaeo_css test... 04:37:06 INFO - TEST-INFO | started process 29373 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpsbKfhe/profile http://localhost:54216/getInfo.html) 04:37:10 INFO - PROCESS | 29373 | __metrics Screen width/height:1600/1200 04:37:10 INFO - PROCESS | 29373 | colorDepth:24 04:37:10 INFO - PROCESS | 29373 | Browser inner width/height: 1024/697 04:37:10 INFO - PROCESS | 29373 | __metrics 04:37:11 INFO - PROCESS | 29373 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 04:37:11 INFO - PROCESS | 29373 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:37:11 INFO - PROCESS | 29373 | console.error: PushService: 04:37:11 INFO - PROCESS | 29373 | stateChangeProcessEnqueue: Error transitioning state 04:37:11 INFO - PROCESS | 29373 | UnknownError 04:37:12 INFO - TEST-INFO | 29373: exit 0 04:37:12 INFO - Browser initialized. 04:37:12 INFO - Running cycle 1/1 for dromaeo_css test... 04:37:12 INFO - TEST-INFO | started process 29456 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpsbKfhe/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:37:24 INFO - PROCESS | 29456 | RSS: Main: 149446656 04:37:24 INFO - PROCESS | 29456 | 04:40:25 INFO - PROCESS | 29456 | Cycle 1(1): loaded http://localhost:54216/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54216/tests/dromaeo/cssquery-ext.html) 04:40:27 INFO - PROCESS | 29456 | RSS: Main: 291430400 04:40:27 INFO - PROCESS | 29456 | 04:42:14 INFO - PROCESS | 29456 | ************************* 04:42:14 INFO - PROCESS | 29456 | A coding exception was thrown and uncaught in a Task. 04:42:14 INFO - PROCESS | 29456 | 04:42:14 ERROR - PROCESS | 29456 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:42:14 INFO - PROCESS | 29456 | Full stack: 04:42:14 INFO - PROCESS | 29456 | ************************* 04:43:29 INFO - PROCESS | 29456 | Cycle 1(1): loaded http://localhost:54216/tests/dromaeo/cssquery-ext.html (next: http://localhost:54216/tests/dromaeo/cssquery-jquery.html) 04:43:30 INFO - PROCESS | 29456 | RSS: Main: 238813184 04:43:30 INFO - PROCESS | 29456 | 04:46:32 INFO - PROCESS | 29456 | Cycle 1(1): loaded http://localhost:54216/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54216/tests/dromaeo/cssquery-mootools.html) 04:46:32 INFO - PROCESS | 29456 | RSS: Main: 224100352 04:46:32 INFO - PROCESS | 29456 | 04:49:34 INFO - PROCESS | 29456 | Cycle 1(1): loaded http://localhost:54216/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54216/tests/dromaeo/cssquery-prototype.html) 04:49:35 INFO - PROCESS | 29456 | RSS: Main: 183119872 04:49:35 INFO - PROCESS | 29456 | 04:52:38 INFO - PROCESS | 29456 | Cycle 1(1): loaded http://localhost:54216/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54216/tests/dromaeo/cssquery-yui.html) 04:52:38 INFO - PROCESS | 29456 | RSS: Main: 186261504 04:52:38 INFO - PROCESS | 29456 | 04:55:41 INFO - PROCESS | 29456 | Cycle 1(1): loaded http://localhost:54216/tests/dromaeo/cssquery-yui.html (next: http://localhost:54216/tests/dromaeo/cssquery-dojo.html) 04:55:41 INFO - PROCESS | 29456 | RSS: Main: 270573568 04:55:41 INFO - PROCESS | 29456 | 04:55:41 INFO - PROCESS | 29456 | __start_tp_report 04:55:41 INFO - PROCESS | 29456 | _x_x_mozilla_page_load 04:55:41 INFO - PROCESS | 29456 | _x_x_mozilla_page_load_details 04:55:41 INFO - PROCESS | 29456 | |i|pagename|runs| 04:55:41 INFO - PROCESS | 29456 | |0;dojo.html;3129.9374012519747;3220.5974253218346;3247.8700851965923;3251.3172233830896;3268.6567910369413;5192;5258.158694608864;5348.144296912495;5397.78408863645;5398.163284690874;5346.304980352558;5379.569634429236;5386.218998245252;5416.945830541703;5448.509634132927;4710.74090924999;4777.689450185727;4787.0904528139545;4794.42466903972;4921.335619691349;4882.43851957026;4914.631402644798;4925.876853078666;4939.456659767423;4944.53026962438;4751.691140075884;4753.3582966299455;4785.258284965836;4797.136515427222;4907;4824.1316563018645;4883.780229889663;4891.510848915115;4902.901941961177;4916.827911023097;4762.809487620491;4794.976025119852;4808.903821923542;4812.398450193726;4846.806127754886;5287.47125287472;5393.002294575516;5399.7030163341;5400.567954563626;5403.621746477748;5687.232223649796;5739.282589676291;5779.422057794229;5787.479126878559;5835.766569337264;5806.071028635398;5822.97088514559;5834.241548598698;5835.153902684129;5844.853878653025;5422.783088676488;5424.1321388577635;5427.565794736412;5430.022595932731;5430.538404235605;5759.712014399263;5783.334916484658;5819.127130930309;5856.209411729362;5929.644221346733;5648.9717551412805;5696.8860622787315;5708.086706127;5727.914081288784;5746.88506229873;5682.40334764852;5718.885622287531;5818.79634212809;5824;5831.300243970751;5662.03745363281;5671.291088613923;5685.687287199244;5753.769849205984;5790.10253410722;5787.045137552257;5790.420957904176;5795.13073039039;5795.333536643256;5803.390643982321;4416.315471101984;4435.26818075014;4445.888852778642;4460.375547423363;4490.865274041784;3998.080441498472;3998.5001874765653;3999.7000224983244;4012.4583181270737;4045.2516284487465;5322;5370.624056316098;5433.375161856358;5480.534154596904;5485.396606373296;5840.88318233633;5885.823425297248;5888.146218798251;5888.322842873039;5893.941060589425;5481.75332110056;5489.917651235235;5505.229267902497;5513.3108361454815;5515.117581186991;4844.563989240985;4886.071646387175;4911.607071434277;4931.186354251508;4959.280904268933;6031.788887389096;6039.909401358896;6085.817425477243;6114.6636934969;6120.081987701791;5838.299404071368;5873.911891321719;5895.233619629592;5905.025670764276;5908.143319218775;5872.618279811799;5924.644521328734;5929.080992446177;5971.193888824953;6075.665838378932;5736.19693242938;5737;5741.885162296814;5782.884342313046;5783.8554036149435;5767.625104368202;5819.185314056121;5823.883522329615;5827.475527202572;5829.446202610745;5570.19232211319;5609.467100625434;5643.125315576092;5677.034904066236;5713.085906254979;5751.1373294006235;5759.395263497272;5765.164051212467;5799.5070419014855;5820;5739.8852022960145;5748.6838223898085;5748.741306641295;5752.597318187687;5755.7122143893475;5598.888022239614;5647.29408823897;5652.236948012131;5654.915176272277;5733.569982251432;5580.4080660998925;5590.664560126405;5637.351704554028;5677.687727175045;5686.829395118153 04:55:41 INFO - PROCESS | 29456 | |1;ext.html;558.7066789935284;579.7970710251412;586.6685322792622;628.7233617208431;679.4496457869124;32982.34035319292;42175;43954;43987.560124398784;49067;46979;46986.29520557194;47087;47123.29315060277;47310.52689473104;8862.468251904891;9025;9031.864522032174;9035.683751068715;9048.457092574434;8615.65537378504;8810.427322224066;8918.732438026836;10377.896221037807;10622.203334749885;10790.784184316348;10852.968967948073;10865;10865.076468500187;10880.782384352307;10763.569457221702;10790.352578845215;10830.512626931806;10832.241743077988;10836.945815270952;10701.892981070168;10755.838662419992;10773.299735517166;10787.244892857503;10793.622223222228;42766.78616606928;43239.13521729548;43248;43283.56716432858;43339.23268440469;4053.6351728344293;4093.2836753568304;4096.487939007624;4096.815643296059;4135.524414692319;32356.20519690868;32381;32672.183195420068;32823.6717632823;34369.65630343714;4091.652209562191;4216.7259128156575;4316.223079845627;4351.651867850596;4486.5962063414445;329864;331082;331209.3439532811;331350;331517;61913.38086619166;62398.37601623926;62439.37560624335;62565.4973801052;62575;64256;64444;64475.35524644787;64624.35375646278;64625.67687161534;17042.659146816994;17597.912010439864;17609.7358539622;17636.647267054843;17641.29434822593;12383.566575169825;13670.658233544242;13725.382357793924;13748.862511374758;13763.243021633907;14827.77758333626;16351.26419311134;16446.506604801874;16853.410130645367;16974.915125424293;6562.901556476657;6678.966605166943;6714.362135597111;6762.188537375547;6789.490788190906;900.5317235037744;909.8362294787001;910.1535571918047;912.8311262416341;930.2418528898926;27765.305867353476;28234;28305.57541636877;28626.71373286282;28658.570121448196;1006.1849901579744;1089.145021158387;1106.8727096383857;1107.8892110788856;1111.4387234446554;13836.792448113287;15087.1895372556;15275.296693453907;15280.770788438182;15283.617909552127;451066;454764;455033;456502;457091;62518.687406563586;62520;62684;62751.6862415685;62777.68611157007;1427.5360507834787;1468.1704836767192;1484.8589384008717;1487.4868170481166;1495.5588101510082;25769.871150644878;27596.586051208847;27997.300067498476;28055.859720701264;28165.295867602654;53167;53373.73313133565;53652;53812;53843;360835;365939;367368;368003;370135;40448;41097;41206;41442;41469.585304146574;46497;47170.29244561266;47260.7636961813;47422.051558967934;48114;37766.62233377631;38189.809050954565;38565.6143438562;39134.217315654096;40033.79983100066;35574.28851423009;39032.219355612164;39421.408678870415;41206.38190427206;41702;37663;38080.61919380771;38532.42201367038;38634.613653864224;38896.41655375115;31938.840305798323;33886.152846179044;34421.311573768886;34605.13487162841;34859;25822.87088564545;26031.479370412864;26207;26285.474290514467;26564 04:55:41 INFO - PROCESS | 29456 | |2;jquery.html;388.69875846219156;415.5366766055849;427.4165763732505;432.18964441671864;433.2310149484665;14715.602017808318;16335.75496367554;19960.70058949117;20630.38108856733;22389.104435822588;20055.498612534695;20319.898400507976;20635.69046464304;21866.89066554665;22436.88781556094;5289.814856480014;5928.496077833368;6116.877662446748;6168.907466388007;6270.247570291572;6072.301685306202;6141;6230.688465576725;6271.968640156792;6274.466670333027;6159.90760138596;6161.537884658646;6166.414190651881;6172.506199504029;6178.505719542426;6158.353372895848;6164.630122192661;6429.7749578764515;6825.5222134450605;6851.897221541681;6126.264848218242;6130.264368275791;6133.601315914451;6144.262688477366;6147.569670123094;14020.509282175075;14403.135811851322;14514.346854391577;14622.415103395957;14636.634084147981;2628.040765120736;2736.1244401791437;2778.4304217635336;2781.7913656475644;2790.6372171617763;10148.289619726622;11021.724456888562;12404.689882752913;14613.415463381558;15359.616009599738;1876.8217019383137;1937.0798870536523;1949.2885096939515;1961.5292329840736;1986.6622674145285;83968;85724;86515.13484865133;87553.56223218907;88137;9821;10252.58989640421;10416.510468992821;11697.356645384416;11851.703707407383;14096.083754556126;14126.717465650629;14159.787603185754;14250.714985700228;14265.57203283903;8177.632006559719;8326.70856520019;8452.450590711584;8547;8561.529115898686;8279.420440569224;8307.460015098999;8349.0177626162;8614.26778723803;8638.956805215934;4248.893777655521;4255.765932873722;4319.33050377192;4484.394606728115;4514.119746649438;2085.426507710392;2110.9472263193234;2112.1445814445174;2132.626790311689;2170.1211009540843;874.728834061443;889.7019498467956;897.9371443998857;907.274180655473;914.7210100919284;18962.52593685169;20704.068316925775;20731.170753170005;20870.79129208719;20886.164553417995;890.5369208011798;893.6961433112643;904.6833608237064;905.0587389115246;922.7923717163585;10609.257351985441;11616.244944078608;11651.30092194471;11668.64994050163;11700.648980530597;588736;602859;607533;611785;612260;101279;104314;104413.47793260985;106589;109600.4519977395;1048.8741351037925;1065.5844220753756;1077.7067518977258;1079.2768844873954;1080.233034545466;16942.322307107577;17340.91329543344;17794.46616601504;17931.69639286588;17998.190081446104;44091.55908440874;44356.556434435246;44503.77748111239;44674.77662611666;45421.77289113533;62209;63285.367146327946;63947.68026159839;64637;65507.344926550126;6194.194754681863;8781.648734050566;8967.596458159269;9056.864147037932;9082.500462474627;13010;13088.476460941456;13183.538576150173;13887.166769993833;14617;11999.640010799341;12050.156489045683;12216;12227.02183825274;12576.622701318975;11561.768764624829;11647.6505704829;11676.766464670829;11699;11942.880571194524;11441.084713223088;11728.296302221894;11837.348945808064;11841.111916606116;12061.336626485627;7326.9267307326245;8513.616887239965;8548.974123105267;8555.743327700178;8684.478931264144;9514.666986655433;11195.720106997065;11323.830142548033;11527.76944461123;11774.3524106175 04:55:41 INFO - PROCESS | 29456 | |3;mootools.html;1306.203216038216;1392.5683038258135;1402.4740722229164;1412.3926711514052;1418.1916307704605;7523.247675232474;8341.374396920224;8519.27586155176;8587.656493740244;8770.079141690127;8617.439866408678;8684.392092553524;8690.08754080822;8698.08670089641;8700.825983480327;2047.488127968008;2351.1653363056084;2390.7489713580085;2391.772781585755;2394.174009966559;2090.174381119457;2353.7646235376496;2426.9757302426924;2430.7812296893276;2449.5835707929696;2346.8005219556358;2368.656544801003;2371.3715865295712;2373.264288070695;2381.071382160959;2378.857268563892;2401.97598024021;2404.410919324759;2406.290144407404;2407.711074671042;2232.0290673557056;2295.173737454515;2302.8848557572055;2305.804006659436;2308.515211805523;8629.223369896677;8640;8697.434666746642;8711.956440217822;8722.258608018263;5296.761645725913;5407.107827208506;5449.155380915925;5454.809081682161;5466.972665136649;3251.5772949516413;3271.8527666255077;3358.1772465745803;3395.2700169463437;3397.9490307645406;1419.198153043527;1432.0977783996016;1432.641839540115;1482.629342664334;1528.3275358842075;11771.941140294244;11773.587924422603;11793.174477786559;11810.822837657443;11849.703757406047;4719.015856532352;4781.13939490895;4838.371011768448;4881.536254055859;4899.779509922062;10149.188064954786;10175.84736228957;10177.066357392072;10195.592176312864;10198.43908585035;5510.8071217507195;5525.585581081435;5528.723563821793;5529.364123125892;5529.585281103853;4926.236433352764;4948.975255123702;5022.59819214462;5065.037642847848;5109.233614957711;4080.1227736036303;4114.468918838679;4118.91762164755;4138.255114079434;4143.6685065194715;1335.3841851359768;1349.6760777413351;1352.790317500789;1354.3837553912947;1360.9183448993092;775.507552704037;810.4448452809844;898.196114477552;902.2376092202079;927.4342650982895;5394.514493695587;5490.615656903979;5565.163956767141;5596.468335508121;5708.885822283614;1011.585250047477;1017.130353547706;1020.3010937507831;1047.6961681112543;1052.7841792432532;3570.2145527983803;3735.2529494101286;3749.4000959846294;3758.642928921748;3759.793211373401;10038.949805251073;10334.276600637882;10465.68602941913;10603.575856965635;10614.469276536296;10534.20993425496;10536.841947370796;10555.208359373079;10557.208209384327;10560.102391296672;8026.518408895485;8043.195680432027;8221.342292616577;8248.216419440143;8260.710875119343;5509.917351239815;5527.751251193626;5567.3040869891265;5669.31968163823;5747.8563035924435;9652.324337296322;9658.130768230892;9698.951505242429;9737.318387712792;9796.363236389612;8676.91323086761;9501.952490237505;9974.152197063331;9987.60049598008;10010.749731256778;6927.549709268881;7397.593132377771;7510.39916806665;7611.619419029137;7794.2205779423875;8387.119352467904;8391.790205244917;8429.620667069874;8465.322774178174;8473.44922580055;7462.589557574385;7481.850362992818;7551.886721699069;7577.507462014952;7688.615569221628;7370.63146842645;7374.483786134919;7394.519356241827;7423.777286681408;7448.329650331496;6713.462922966249;6727.260001399744;6730.360615741497;6769.323067693192;6775.457963363017;4855.465898751064;4862.489438608895;4922.187839006524;4991.3511243538105;5018.121828679893;4441.600255976978;4507.459104907432;4540.0919816037585;4610.400647915883;4712.976435117939 04:55:41 INFO - PROCESS | 29456 | |4;prototype.html;393.36667964577026;400.67345113732307;408.6281483849696;410.7145533853971;414.85272728181474;4932.457429682732;5307.540426382747;5327.334083239595;5354.5716342692585;5381.5963802714805;4968.205087186042;5043.268726034723;5100.628207883334;5145.845624631258;5232.6075544334135;4117.711760176789;4131;4137.54487006429;4148.958510414903;4184.205001049806;4157.52188498322;4166.58334166584;4169;4183.581641835807;4215.0726840095285;3819.4843696100947;3951.9604803952025;4094.263032654121;4099.6105369989955;4153.916921661565;4110.835566577333;4118.155778065489;4121.752694838289;4138.296489596791;4138.8137533810905;3729.4778730977687;3747.4753534504916;3748.6626203641804;3759.793211373373;3774.1508160663907;4852.708837469763;5087.9745601272125;5142.588592912558;5180.507851754077;5188.6367954243215;4698.718076915396;4700.647451441156;4700.670953033289;4714.434267887841;4720;5482.588805839578;5491.533219676332;5495.560355171577;5517.337919449652;5546.422557450422;3808.90477738056;3962.346212874872;4034.8184331705143;4037.9394309085387;4055.918881622351;5680.488756011979;5697.259356283698;5711.7144142792695;5717.285339332542;5728.51307638847;4074.898127546835;4094.570070142592;4119.752814831119;4134.111166099303;4148.854790082393;3981.402789581586;4127.4015267786;4160.167966406731;4162.354835000579;4189.706720529594;4668.39310889589;4683.15703173432;4685.789139488663;4687.648426368036;4715.575598196178;5465.344158700981;5491.478309560585;5511.669299842022;5543.362513311021;5565.7217139143695;1328.7111501843196;1401.740677974578;1407.8451370349253;1410.8800751935996;1411.4495346814751;958.5830163878735;976.8632391465201;978.6330126202674;986.3785814936545;990.3760630802549;4872.613533594189;5061.797528098835;5105.7191854448365;5116.258142569307;5142.177251639794;5361.329833770778;5403.918941215885;5424.566034717213;5462.7268636568015;5467.398586155519;5099.980003999215;5104.642675012714;5123.7438128093445;5124.797001873829;5131.948680513222;2805.5931889875856;2875.7843161762953;2886.3649997000625;2892.5516544935567;2907.6946920573037;5600.355959064678;5620.285812827045;5641.9435805641415;5642.858928526737;5654.038813401731;5310.867228319323;5596.300462442195;5618.438156184349;5630.789380283259;5642.830715078554;5422.8915421691345;5588.720563971867;5655.575831812631;5679.488846003796;5696.629719068247;5424.267723857229;5472.771065071627;5481.314835645544;5531.751071201725;5535.640183388067;5165.66423182492;5393.86515337104;5400.432954539874;5425.21334406501;5431.864203394789;5606.635568688022;5608.242887210337;5614.101743720985;5615.241942337732;5617.9719101404235;3990.4413382127104;4019.3569028955226;4024.5170579530645;4041.2523683118716;4069.1251380953236;5158.420789605198;5399.136138217867;5512.6968016759465;5604.85987850307;5640.435956404327;5441.5374693151525;5467.152591348347;5471.835844924659;5475.5072043516275;5479.904019196097;5152.330197074356;5436.0758671026815;5445.401005889428;5498.257735205696;5499.790046189832;5423.511883930465;5426;5440.646357986877;5475.835724928259;5483.862903427446;5463.863403414946;5467.9453205467435;5482.205080263259;5493.533049690661;5502.862428439321;5222.42553319127;5386.165144402624;5388.057090009311;5395.325584301962;5401.540869026177 04:55:41 INFO - PROCESS | 29456 | |5;yui.html;758.5638258001648;762.4967521435854;772.9227077292271;779.7426849139785;805.9556724380159;12940.547080852171;13467.461301547939;13821.861781382184;14037.50868719595;14046.43814247429;12646.494140234403;12822.80765788514;12935.353232338393;13039.674008149777;13102.606921792338;746.6416120262278;759.3166150464598;763.1910175214263;763.2672634271106;763.4960925788953;642.2453617000007;660.7918505670698;739.2976672161441;757.360030773995;762.9237076292354;799.3724925933144;801.2068052627915;801.3188789528912;801.3749275565068;801.5230937592123;793.3137835772015;794.2811755361407;794.8132188935596;794.8728203487415;795.1928792275845;496.42166875589896;501.79677230721614;504.51566496163724;578.7916350113956;578.9768409263625;11592.014678752315;12368;12549.372531373487;12746.171498852545;13022.804657930139;13657.863421365759;13816.723665526633;14191.503297384543;14194.57416277503;14205.147691138565;10864.293820901616;10933.617323393722;10964.342139471657;11261.324320540794;11291.548338066468;3710.7402481826284;3724.7951362675044;3727.9440808387894;3870.4581358609817;3884.941725874114;73979.26020739778;74526.25473745247;75271.62364188199;75731.24268757297;77380.61309693471;10728.678139655824;10872.130229581615;10924.180686448548;10958.452077396098;11060.281081729661;19315;19362.128704208346;19599.608007839764;19618.901905490668;19839.60320793605;7676.961615191888;7680.5391676498475;7690.15408305086;7821.139674635786;7878.566678832719;4185.100203456272;4213.789310534461;4223.239816832999;4293.849715259951;4306.354046892991;3275.2630658101734;3356.412627790127;3360.479125735515;3390.559227300435;3395.303962687643;600.5495878091432;603.1074010464449;604.1602172979561;613.2824595223599;620.8168590265882;627.6673363117555;648.0926702616375;649.3798422506495;652.8988006858945;673.3031312591543;8625.827483450295;9535.47554884474;9938.652147174815;9962.601495940226;10003.149732272694;627.328758228691;629.7418058595954;666.4868051600241;704.5596502186133;810.107914744357;4450.888727781767;4676.415448068991;4702.247640377524;4724.811007559659;4739.644526660514;53090.46909530932;67010.66494667593;70868;72041.6397918007;73463;61721.38278617156;61765.69117154476;61805.38194618086;62465.37534624687;63183;52242.22978544753;55006.44993550093;55023;55529.72235138799;56853.71573142191;8848.690295839615;8946.955265223633;9008.099190080939;9043.68347107848;9090.59092340833;38048.23903521859;38558.228835423695;38690.80654596822;39127.217455650156;39931.80034099811;46701;48305.51694483151;49858.50141498539;50909;51542.742286288325;12409.93795031019;12800.74398512043;12802.231866088065;12967;13255.536056237985;12740.681482963;12799.680007999874;12849.100562960877;12932.935335323264;13361.599152025456;12704.491820327083;12897.161684490478;12924.353782310658;12966.281478523624;13074.346282685638;12453.014546796001;12602.49590016389;12643.494260229489;12695.301758403377;12739.681507962376;10478.214133940137;10799.460026998462;10939.56241750321;11718.17972741934;12756.48974041028;10386.169106471616;10880.238383313408;11281.379524126252;11457.312561246352;11474.4262786862;10378.117859981685;10826.891731082904;11037.448127593427;11130.387828669178;11234.3259404436 04:55:41 INFO - PROCESS | 29456 | __end_tp_report 04:55:41 INFO - PROCESS | 29456 | __start_cc_report 04:55:41 INFO - PROCESS | 29456 | _x_x_mozilla_cycle_collect,1304 04:55:41 INFO - PROCESS | 29456 | __end_cc_report 04:55:41 INFO - PROCESS | 29456 | __startTimestamp1485435341567__endTimestamp 04:55:41 INFO - PROCESS | 29456 | 04:55:41 INFO - PROCESS | 29456 | ------- Summary: start ------- 04:55:41 INFO - PROCESS | 29456 | Number of tests: 6 04:55:41 INFO - PROCESS | 29456 | 04:55:41 INFO - PROCESS | 29456 | [#0] dojo.html Cycles:165 Average:5378.09 Median:5647.29 stddev:615.14 (10.9%) stddev-sans-first:591.20 04:55:41 INFO - PROCESS | 29456 | Values: 3129.9 3220.6 3247.9 3251.3 3268.7 5192.0 5258.2 5348.1 5397.8 5398.2 5346.3 5379.6 5386.2 5416.9 5448.5 4710.7 4777.7 4787.1 4794.4 4921.3 4882.4 4914.6 4925.9 4939.5 4944.5 4751.7 4753.4 4785.3 4797.1 4907.0 4824.1 4883.8 4891.5 4902.9 4916.8 4762.8 4795.0 4808.9 4812.4 4846.8 5287.5 5393.0 5399.7 5400.6 5403.6 5687.2 5739.3 5779.4 5787.5 5835.8 5806.1 5823.0 5834.2 5835.2 5844.9 5422.8 5424.1 5427.6 5430.0 5430.5 5759.7 5783.3 5819.1 5856.2 5929.6 5649.0 5696.9 5708.1 5727.9 5746.9 5682.4 5718.9 5818.8 5824.0 5831.3 5662.0 5671.3 5685.7 5753.8 5790.1 5787.0 5790.4 5795.1 5795.3 5803.4 4416.3 4435.3 4445.9 4460.4 4490.9 3998.1 3998.5 3999.7 4012.5 4045.3 5322.0 5370.6 5433.4 5480.5 5485.4 5840.9 5885.8 5888.1 5888.3 5893.9 5481.8 5489.9 5505.2 5513.3 5515.1 4844.6 4886.1 4911.6 4931.2 4959.3 6031.8 6039.9 6085.8 6114.7 6120.1 5838.3 5873.9 5895.2 5905.0 5908.1 5872.6 5924.6 5929.1 5971.2 6075.7 5736.2 5737.0 5741.9 5782.9 5783.9 5767.6 5819.2 5823.9 5827.5 5829.4 5570.2 5609.5 5643.1 5677.0 5713.1 5751.1 5759.4 5765.2 5799.5 5820.0 5739.9 5748.7 5748.7 5752.6 5755.7 5598.9 5647.3 5652.2 5654.9 5733.6 5580.4 5590.7 5637.4 5677.7 5686.8 04:55:41 INFO - PROCESS | 29456 | 04:55:41 INFO - PROCESS | 29456 | [#1] ext.html Cycles:180 Average:55949.99 Median:38765.52 stddev:102125.48 (263.4%) stddev-sans-first:102327.29 04:55:41 INFO - PROCESS | 29456 | Values: 558.7 579.8 586.7 628.7 679.4 32982.3 42175.0 43954.0 43987.6 49067.0 46979.0 46986.3 47087.0 47123.3 47310.5 8862.5 9025.0 9031.9 9035.7 9048.5 8615.7 8810.4 8918.7 10377.9 10622.2 10790.8 10853.0 10865.0 10865.1 10880.8 10763.6 10790.4 10830.5 10832.2 10836.9 10701.9 10755.8 10773.3 10787.2 10793.6 42766.8 43239.1 43248.0 43283.6 43339.2 4053.6 4093.3 4096.5 4096.8 4135.5 32356.2 32381.0 32672.2 32823.7 34369.7 4091.7 4216.7 4316.2 4351.7 4486.6 329864.0 331082.0 331209.3 331350.0 331517.0 61913.4 62398.4 62439.4 62565.5 62575.0 64256.0 64444.0 64475.4 64624.4 64625.7 17042.7 17597.9 17609.7 17636.6 17641.3 12383.6 13670.7 13725.4 13748.9 13763.2 14827.8 16351.3 16446.5 16853.4 16974.9 6562.9 6679.0 6714.4 6762.2 6789.5 900.5 909.8 910.2 912.8 930.2 27765.3 28234.0 28305.6 28626.7 28658.6 1006.2 1089.1 1106.9 1107.9 1111.4 13836.8 15087.2 15275.3 15280.8 15283.6 451066.0 454764.0 455033.0 456502.0 457091.0 62518.7 62520.0 62684.0 62751.7 62777.7 1427.5 1468.2 1484.9 1487.5 1495.6 25769.9 27596.6 27997.3 28055.9 28165.3 53167.0 53373.7 53652.0 53812.0 53843.0 360835.0 365939.0 367368.0 368003.0 370135.0 40448.0 41097.0 41206.0 41442.0 41469.6 46497.0 47170.3 47260.8 47422.1 48114.0 37766.6 38189.8 38565.6 39134.2 40033.8 35574.3 39032.2 39421.4 41206.4 41702.0 37663.0 38080.6 38532.4 38634.6 38896.4 31938.8 33886.2 34421.3 34605.1 34859.0 25822.9 26031.5 26207.0 26285.5 26564.0 04:55:41 INFO - PROCESS | 29456 | 04:55:41 INFO - PROCESS | 29456 | [#2] jquery.html Cycles:180 Average:32933.12 Median:2780.11 stddev:99557.64 (3581.1%) stddev-sans-first:99806.94 04:55:41 INFO - PROCESS | 29456 | Values: 388.7 415.5 427.4 432.2 433.2 14715.6 16335.8 19960.7 20630.4 22389.1 20055.5 20319.9 20635.7 21866.9 22436.9 5289.8 5928.5 6116.9 6168.9 6270.2 6072.3 6141.0 6230.7 6272.0 6274.5 6159.9 6161.5 6166.4 6172.5 6178.5 6158.4 6164.6 6429.8 6825.5 6851.9 6126.3 6130.3 6133.6 6144.3 6147.6 14020.5 14403.1 14514.3 14622.4 14636.6 2628.0 2736.1 2778.4 2781.8 2790.6 10148.3 11021.7 12404.7 14613.4 15359.6 1876.8 1937.1 1949.3 1961.5 1986.7 83968.0 85724.0 86515.1 87553.6 88137.0 9821.0 10252.6 10416.5 11697.4 11851.7 14096.1 14126.7 14159.8 14250.7 14265.6 8177.6 8326.7 8452.5 8547.0 8561.5 8279.4 8307.5 8349.0 8614.3 8639.0 4248.9 4255.8 4319.3 4484.4 4514.1 2085.4 2110.9 2112.1 2132.6 2170.1 874.7 889.7 897.9 907.3 914.7 18962.5 20704.1 20731.2 20870.8 20886.2 890.5 893.7 904.7 905.1 922.8 10609.3 11616.2 11651.3 11668.6 11700.6 588736.0 602859.0 607533.0 611785.0 612260.0 101279.0 104314.0 104413.5 106589.0 109600.5 1048.9 1065.6 1077.7 1079.3 1080.2 16942.3 17340.9 17794.5 17931.7 17998.2 44091.6 44356.6 44503.8 44674.8 45421.8 62209.0 63285.4 63947.7 64637.0 65507.3 6194.2 8781.6 8967.6 9056.9 9082.5 13010.0 13088.5 13183.5 13887.2 14617.0 11999.6 12050.2 12216.0 12227.0 12576.6 11561.8 11647.7 11676.8 11699.0 11942.9 11441.1 11728.3 11837.3 11841.1 12061.3 7326.9 8513.6 8549.0 8555.7 8684.5 9514.7 11195.7 11323.8 11527.8 11774.4 04:55:41 INFO - PROCESS | 29456 | 04:55:41 INFO - PROCESS | 29456 | [#3] mootools.html Cycles:180 Average:5670.17 Median:4872.01 stddev:3154.49 (64.7%) stddev-sans-first:3146.29 04:55:41 INFO - PROCESS | 29456 | Values: 1306.2 1392.6 1402.5 1412.4 1418.2 7523.2 8341.4 8519.3 8587.7 8770.1 8617.4 8684.4 8690.1 8698.1 8700.8 2047.5 2351.2 2390.7 2391.8 2394.2 2090.2 2353.8 2427.0 2430.8 2449.6 2346.8 2368.7 2371.4 2373.3 2381.1 2378.9 2402.0 2404.4 2406.3 2407.7 2232.0 2295.2 2302.9 2305.8 2308.5 8629.2 8640.0 8697.4 8712.0 8722.3 5296.8 5407.1 5449.2 5454.8 5467.0 3251.6 3271.9 3358.2 3395.3 3397.9 1419.2 1432.1 1432.6 1482.6 1528.3 11771.9 11773.6 11793.2 11810.8 11849.7 4719.0 4781.1 4838.4 4881.5 4899.8 10149.2 10175.8 10177.1 10195.6 10198.4 5510.8 5525.6 5528.7 5529.4 5529.6 4926.2 4949.0 5022.6 5065.0 5109.2 4080.1 4114.5 4118.9 4138.3 4143.7 1335.4 1349.7 1352.8 1354.4 1360.9 775.5 810.4 898.2 902.2 927.4 5394.5 5490.6 5565.2 5596.5 5708.9 1011.6 1017.1 1020.3 1047.7 1052.8 3570.2 3735.3 3749.4 3758.6 3759.8 10038.9 10334.3 10465.7 10603.6 10614.5 10534.2 10536.8 10555.2 10557.2 10560.1 8026.5 8043.2 8221.3 8248.2 8260.7 5509.9 5527.8 5567.3 5669.3 5747.9 9652.3 9658.1 9699.0 9737.3 9796.4 8676.9 9502.0 9974.2 9987.6 10010.7 6927.5 7397.6 7510.4 7611.6 7794.2 8387.1 8391.8 8429.6 8465.3 8473.4 7462.6 7481.9 7551.9 7577.5 7688.6 7370.6 7374.5 7394.5 7423.8 7448.3 6713.5 6727.3 6730.4 6769.3 6775.5 4855.5 4862.5 4922.2 4991.4 5018.1 4441.6 4507.5 4540.1 4610.4 4713.0 04:55:41 INFO - PROCESS | 29456 | 04:55:41 INFO - PROCESS | 29456 | [#4] prototype.html Cycles:180 Average:4588.55 Median:5173.09 stddev:1311.88 (25.4%) stddev-sans-first:1277.22 04:55:41 INFO - PROCESS | 29456 | Values: 393.4 400.7 408.6 410.7 414.9 4932.5 5307.5 5327.3 5354.6 5381.6 4968.2 5043.3 5100.6 5145.8 5232.6 4117.7 4131.0 4137.5 4149.0 4184.2 4157.5 4166.6 4169.0 4183.6 4215.1 3819.5 3952.0 4094.3 4099.6 4153.9 4110.8 4118.2 4121.8 4138.3 4138.8 3729.5 3747.5 3748.7 3759.8 3774.2 4852.7 5088.0 5142.6 5180.5 5188.6 4698.7 4700.6 4700.7 4714.4 4720.0 5482.6 5491.5 5495.6 5517.3 5546.4 3808.9 3962.3 4034.8 4037.9 4055.9 5680.5 5697.3 5711.7 5717.3 5728.5 4074.9 4094.6 4119.8 4134.1 4148.9 3981.4 4127.4 4160.2 4162.4 4189.7 4668.4 4683.2 4685.8 4687.6 4715.6 5465.3 5491.5 5511.7 5543.4 5565.7 1328.7 1401.7 1407.8 1410.9 1411.4 958.6 976.9 978.6 986.4 990.4 4872.6 5061.8 5105.7 5116.3 5142.2 5361.3 5403.9 5424.6 5462.7 5467.4 5100.0 5104.6 5123.7 5124.8 5131.9 2805.6 2875.8 2886.4 2892.6 2907.7 5600.4 5620.3 5641.9 5642.9 5654.0 5310.9 5596.3 5618.4 5630.8 5642.8 5422.9 5588.7 5655.6 5679.5 5696.6 5424.3 5472.8 5481.3 5531.8 5535.6 5165.7 5393.9 5400.4 5425.2 5431.9 5606.6 5608.2 5614.1 5615.2 5618.0 3990.4 4019.4 4024.5 4041.3 4069.1 5158.4 5399.1 5512.7 5604.9 5640.4 5441.5 5467.2 5471.8 5475.5 5479.9 5152.3 5436.1 5445.4 5498.3 5499.8 5423.5 5426.0 5440.6 5475.8 5483.9 5463.9 5467.9 5482.2 5493.5 5502.9 5222.4 5386.2 5388.1 5395.3 5401.5 04:55:41 INFO - PROCESS | 29456 | 04:55:41 INFO - PROCESS | 29456 | [#5] yui.html Cycles:180 Average:16002.23 Median:4378.62 stddev:20166.62 (460.6%) stddev-sans-first:20190.70 04:55:41 INFO - PROCESS | 29456 | Values: 758.6 762.5 772.9 779.7 806.0 12940.5 13467.5 13821.9 14037.5 14046.4 12646.5 12822.8 12935.4 13039.7 13102.6 746.6 759.3 763.2 763.3 763.5 642.2 660.8 739.3 757.4 762.9 799.4 801.2 801.3 801.4 801.5 793.3 794.3 794.8 794.9 795.2 496.4 501.8 504.5 578.8 579.0 11592.0 12368.0 12549.4 12746.2 13022.8 13657.9 13816.7 14191.5 14194.6 14205.1 10864.3 10933.6 10964.3 11261.3 11291.5 3710.7 3724.8 3727.9 3870.5 3884.9 73979.3 74526.3 75271.6 75731.2 77380.6 10728.7 10872.1 10924.2 10958.5 11060.3 19315.0 19362.1 19599.6 19618.9 19839.6 7677.0 7680.5 7690.2 7821.1 7878.6 4185.1 4213.8 4223.2 4293.8 4306.4 3275.3 3356.4 3360.5 3390.6 3395.3 600.5 603.1 604.2 613.3 620.8 627.7 648.1 649.4 652.9 673.3 8625.8 9535.5 9938.7 9962.6 10003.1 627.3 629.7 666.5 704.6 810.1 4450.9 4676.4 4702.2 4724.8 4739.6 53090.5 67010.7 70868.0 72041.6 73463.0 61721.4 61765.7 61805.4 62465.4 63183.0 52242.2 55006.4 55023.0 55529.7 56853.7 8848.7 8947.0 9008.1 9043.7 9090.6 38048.2 38558.2 38690.8 39127.2 39931.8 46701.0 48305.5 49858.5 50909.0 51542.7 12409.9 12800.7 12802.2 12967.0 13255.5 12740.7 12799.7 12849.1 12932.9 13361.6 12704.5 12897.2 12924.4 12966.3 13074.3 12453.0 12602.5 12643.5 12695.3 12739.7 10478.2 10799.5 10939.6 11718.2 12756.5 10386.2 10880.2 11281.4 11457.3 11474.4 10378.1 10826.9 11037.4 11130.4 11234.3 04:55:41 INFO - PROCESS | 29456 | -------- Summary: end -------- 04:55:41 INFO - PROCESS | 29456 | 04:55:42 INFO - TEST-INFO | 29456: exit 0 04:55:42 INFO - TEST-OK | dromaeo_css | took 1115939ms 04:55:42 INFO - TEST-START | kraken 04:55:42 INFO - operating with platform_type : linux_ 04:55:42 INFO - Initialising browser for kraken test... 04:55:42 INFO - TEST-INFO | started process 29761 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpr0Neqx/profile http://localhost:54216/getInfo.html) 04:55:46 INFO - PROCESS | 29761 | __metrics Screen width/height:1600/1200 04:55:46 INFO - PROCESS | 29761 | colorDepth:24 04:55:46 INFO - PROCESS | 29761 | Browser inner width/height: 1024/697 04:55:46 INFO - PROCESS | 29761 | __metrics 04:55:46 INFO - PROCESS | 29761 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 04:55:46 INFO - PROCESS | 29761 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:55:47 INFO - PROCESS | 29761 | console.error: 04:55:47 INFO - PROCESS | 29761 | Message: Error: Connection closed before committing the transaction. 04:55:47 INFO - PROCESS | 29761 | Stack: 04:55:47 INFO - PROCESS | 29761 | executeTransaction/promise resource://gre/modules/Promise-backend.js:917:23 04:55:47 INFO - PROCESS | 29761 | walkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:801:7 04:55:47 INFO - PROCESS | 29761 | Promise*scheduleWalkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:734:11 04:55:47 INFO - PROCESS | 29761 | schedulePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:765:7 04:55:47 INFO - PROCESS | 29761 | completePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:702:7 04:55:47 INFO - PROCESS | 29761 | TaskImpl_run@resource://gre/modules/Task.jsm:324:15 04:55:47 INFO - PROCESS | 29761 | observe@resource://gre/modules/AsyncShutdown.jsm:550:9 04:55:47 INFO - PROCESS | 29761 | addBlocker/moduleBlocker/<@resource://gre/components/nsAsyncShutdown.js:157:15 04:55:47 INFO - PROCESS | 29761 | Promise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:385:5 04:55:47 INFO - PROCESS | 29761 | moduleBlocker@resource://gre/components/nsAsyncShutdown.js:153:29 04:55:47 INFO - PROCESS | 29761 | trigger@resource://gre/modules/AsyncShutdown.jsm:719:23 04:55:47 INFO - PROCESS | 29761 | _wait@resource://gre/modules/AsyncShutdown.jsm:866:7 04:55:47 INFO - PROCESS | 29761 | wait@resource://gre/modules/AsyncShutdown.jsm:850:28 04:55:47 INFO - PROCESS | 29761 | observe@resource://gre/modules/AsyncShutdown.jsm:533:17 04:55:47 INFO - PROCESS | 29761 | 04:55:47 INFO - PROCESS | 29761 | console.error: PushService: 04:55:47 INFO - PROCESS | 29761 | stateChangeProcessEnqueue: Error transitioning state 04:55:47 INFO - PROCESS | 29761 | UnknownError 04:55:48 INFO - TEST-INFO | 29761: exit 0 04:55:48 INFO - Browser initialized. 04:55:48 INFO - Running cycle 1/1 for kraken test... 04:55:48 INFO - TEST-INFO | started process 29845 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpr0Neqx/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:56:00 INFO - PROCESS | 29845 | RSS: Main: 149274624 04:56:00 INFO - PROCESS | 29845 | 04:56:02 INFO - PROCESS | 29845 | Cycle 1(1): loaded http://localhost:54216/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54216/tests/kraken/driver.html?testName=audio-beat-detection) 04:56:03 INFO - PROCESS | 29845 | RSS: Main: 205082624 04:56:03 INFO - PROCESS | 29845 | 04:56:06 INFO - PROCESS | 29845 | Cycle 1(1): loaded http://localhost:54216/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54216/tests/kraken/driver.html?testName=audio-dft) 04:56:06 INFO - PROCESS | 29845 | RSS: Main: 184184832 04:56:06 INFO - PROCESS | 29845 | 04:56:09 INFO - PROCESS | 29845 | Cycle 1(1): loaded http://localhost:54216/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54216/tests/kraken/driver.html?testName=audio-fft) 04:56:10 INFO - PROCESS | 29845 | RSS: Main: 265285632 04:56:10 INFO - PROCESS | 29845 | 04:56:12 INFO - PROCESS | 29845 | Cycle 1(1): loaded http://localhost:54216/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54216/tests/kraken/driver.html?testName=audio-oscillator) 04:56:12 INFO - PROCESS | 29845 | RSS: Main: 175984640 04:56:12 INFO - PROCESS | 29845 | 04:56:15 INFO - PROCESS | 29845 | Cycle 1(1): loaded http://localhost:54216/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54216/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:56:15 INFO - PROCESS | 29845 | RSS: Main: 181448704 04:56:15 INFO - PROCESS | 29845 | 04:56:18 INFO - PROCESS | 29845 | Cycle 1(1): loaded http://localhost:54216/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54216/tests/kraken/driver.html?testName=imaging-darkroom) 04:56:19 INFO - PROCESS | 29845 | RSS: Main: 220176384 04:56:19 INFO - PROCESS | 29845 | 04:56:22 INFO - PROCESS | 29845 | Cycle 1(1): loaded http://localhost:54216/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54216/tests/kraken/driver.html?testName=imaging-desaturate) 04:56:23 INFO - PROCESS | 29845 | RSS: Main: 219074560 04:56:23 INFO - PROCESS | 29845 | 04:56:26 INFO - PROCESS | 29845 | Cycle 1(1): loaded http://localhost:54216/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54216/tests/kraken/driver.html?testName=json-parse-financial) 04:56:26 INFO - PROCESS | 29845 | RSS: Main: 217985024 04:56:26 INFO - PROCESS | 29845 | 04:56:28 INFO - PROCESS | 29845 | Cycle 1(1): loaded http://localhost:54216/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54216/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:56:28 INFO - PROCESS | 29845 | RSS: Main: 181080064 04:56:28 INFO - PROCESS | 29845 | 04:56:30 INFO - PROCESS | 29845 | Cycle 1(1): loaded http://localhost:54216/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54216/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:56:31 INFO - PROCESS | 29845 | RSS: Main: 187707392 04:56:31 INFO - PROCESS | 29845 | 04:56:33 INFO - PROCESS | 29845 | Cycle 1(1): loaded http://localhost:54216/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54216/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:56:33 INFO - PROCESS | 29845 | RSS: Main: 196780032 04:56:33 INFO - PROCESS | 29845 | 04:56:36 INFO - PROCESS | 29845 | Cycle 1(1): loaded http://localhost:54216/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54216/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:56:37 INFO - PROCESS | 29845 | RSS: Main: 205189120 04:56:37 INFO - PROCESS | 29845 | 04:56:39 INFO - PROCESS | 29845 | Cycle 1(1): loaded http://localhost:54216/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54216/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:56:40 INFO - PROCESS | 29845 | RSS: Main: 202371072 04:56:40 INFO - PROCESS | 29845 | 04:56:42 INFO - PROCESS | 29845 | Cycle 1(1): loaded http://localhost:54216/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54216/tests/kraken/driver.html?testName=ai-astar) 04:56:42 INFO - PROCESS | 29845 | RSS: Main: 253145088 04:56:42 INFO - PROCESS | 29845 | 04:56:42 INFO - PROCESS | 29845 | __start_tp_report 04:56:42 INFO - PROCESS | 29845 | _x_x_mozilla_page_load 04:56:42 INFO - PROCESS | 29845 | _x_x_mozilla_page_load_details 04:56:42 INFO - PROCESS | 29845 | |i|pagename|runs| 04:56:42 INFO - PROCESS | 29845 | |0;ai-astar;109;112;114;111;113;112;112;115;112;111 04:56:42 INFO - PROCESS | 29845 | |1;audio-beat-detection;141;118;119;167;120;119;119;117;142;119 04:56:42 INFO - PROCESS | 29845 | |2;audio-dft;160;161;160;162;160;161;160;163;162;161 04:56:42 INFO - PROCESS | 29845 | |3;audio-fft;75;75;77;115;77;76;76;75;90;75 04:56:42 INFO - PROCESS | 29845 | |4;audio-oscillator;83;83;99;83;83;82;104;82;83;109 04:56:42 INFO - PROCESS | 29845 | |5;imaging-gaussian-blur;117;117;116;117;117;116;117;116;117;117 04:56:42 INFO - PROCESS | 29845 | |6;imaging-darkroom;147;147;146;146;147;147;146;146;146;146 04:56:42 INFO - PROCESS | 29845 | |7;imaging-desaturate;98;96;96;96;96;96;96;96;96;97 04:56:42 INFO - PROCESS | 29845 | |8;json-parse-financial;52;51;51;51;53;51;52;52;52;52 04:56:42 INFO - PROCESS | 29845 | |9;json-stringify-tinderbox;65;66;66;66;66;66;66;67;67;67 04:56:42 INFO - PROCESS | 29845 | |10;stanford-crypto-aes;86;88;85;82;83;83;82;90;83;82 04:56:42 INFO - PROCESS | 29845 | |11;stanford-crypto-ccm;128;141;131;127;125;124;126;128;174;129 04:56:42 INFO - PROCESS | 29845 | |12;stanford-crypto-pbkdf2;170;170;167;166;171;171;173;169;167;174 04:56:42 INFO - PROCESS | 29845 | |13;stanford-crypto-sha256-iterative;67;64;63;62;63;62;62;61;62;61 04:56:42 INFO - PROCESS | 29845 | __end_tp_report 04:56:42 INFO - PROCESS | 29845 | __start_cc_report 04:56:42 INFO - PROCESS | 29845 | _x_x_mozilla_cycle_collect,1578 04:56:42 INFO - PROCESS | 29845 | __end_cc_report 04:56:42 INFO - PROCESS | 29845 | __startTimestamp1485435402469__endTimestamp 04:56:42 INFO - PROCESS | 29845 | 04:56:42 INFO - PROCESS | 29845 | ------- Summary: start ------- 04:56:42 INFO - PROCESS | 29845 | Number of tests: 14 04:56:42 INFO - PROCESS | 29845 | 04:56:42 INFO - PROCESS | 29845 | [#0] ai-astar Cycles:10 Average:112.10 Median:112.00 stddev:1.66 (1.5%) stddev-sans-first:1.33 04:56:42 INFO - PROCESS | 29845 | Values: 109.0 112.0 114.0 111.0 113.0 112.0 112.0 115.0 112.0 111.0 04:56:42 INFO - PROCESS | 29845 | 04:56:42 INFO - PROCESS | 29845 | [#1] audio-beat-detection Cycles:10 Average:128.10 Median:119.50 stddev:16.65 (13.9%) stddev-sans-first:16.99 04:56:42 INFO - PROCESS | 29845 | Values: 141.0 118.0 119.0 167.0 120.0 119.0 119.0 117.0 142.0 119.0 04:56:42 INFO - PROCESS | 29845 | 04:56:42 INFO - PROCESS | 29845 | [#2] audio-dft Cycles:10 Average:161.00 Median:161.00 stddev:1.05 (0.7%) stddev-sans-first:1.05 04:56:42 INFO - PROCESS | 29845 | Values: 160.0 161.0 160.0 162.0 160.0 161.0 160.0 163.0 162.0 161.0 04:56:42 INFO - PROCESS | 29845 | 04:56:42 INFO - PROCESS | 29845 | [#3] audio-fft Cycles:10 Average:81.10 Median:76.00 stddev:12.75 (16.8%) stddev-sans-first:13.33 04:56:42 INFO - PROCESS | 29845 | Values: 75.0 75.0 77.0 115.0 77.0 76.0 76.0 75.0 90.0 75.0 04:56:42 INFO - PROCESS | 29845 | 04:56:42 INFO - PROCESS | 29845 | [#4] audio-oscillator Cycles:10 Average:89.10 Median:83.00 stddev:10.56 (12.7%) stddev-sans-first:10.96 04:56:42 INFO - PROCESS | 29845 | Values: 83.0 83.0 99.0 83.0 83.0 82.0 104.0 82.0 83.0 109.0 04:56:42 INFO - PROCESS | 29845 | 04:56:42 INFO - PROCESS | 29845 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 04:56:42 INFO - PROCESS | 29845 | Values: 117.0 117.0 116.0 117.0 117.0 116.0 117.0 116.0 117.0 117.0 04:56:42 INFO - PROCESS | 29845 | 04:56:42 INFO - PROCESS | 29845 | [#6] imaging-darkroom Cycles:10 Average:146.40 Median:146.50 stddev:0.52 (0.4%) stddev-sans-first:0.50 04:56:42 INFO - PROCESS | 29845 | Values: 147.0 147.0 146.0 146.0 147.0 147.0 146.0 146.0 146.0 146.0 04:56:42 INFO - PROCESS | 29845 | 04:56:42 INFO - PROCESS | 29845 | [#7] imaging-desaturate Cycles:10 Average:96.30 Median:96.00 stddev:0.67 (0.7%) stddev-sans-first:0.33 04:56:42 INFO - PROCESS | 29845 | Values: 98.0 96.0 96.0 96.0 96.0 96.0 96.0 96.0 96.0 97.0 04:56:42 INFO - PROCESS | 29845 | 04:56:42 INFO - PROCESS | 29845 | [#8] json-parse-financial Cycles:10 Average:51.70 Median:52.00 stddev:0.67 (1.3%) stddev-sans-first:0.71 04:56:42 INFO - PROCESS | 29845 | Values: 52.0 51.0 51.0 51.0 53.0 51.0 52.0 52.0 52.0 52.0 04:56:42 INFO - PROCESS | 29845 | 04:56:42 INFO - PROCESS | 29845 | [#9] json-stringify-tinderbox Cycles:10 Average:66.20 Median:66.00 stddev:0.63 (1.0%) stddev-sans-first:0.50 04:56:42 INFO - PROCESS | 29845 | Values: 65.0 66.0 66.0 66.0 66.0 66.0 66.0 67.0 67.0 67.0 04:56:42 INFO - PROCESS | 29845 | 04:56:42 INFO - PROCESS | 29845 | [#10] stanford-crypto-aes Cycles:10 Average:84.40 Median:84.00 stddev:2.80 (3.3%) stddev-sans-first:2.91 04:56:42 INFO - PROCESS | 29845 | Values: 86.0 88.0 85.0 82.0 83.0 83.0 82.0 90.0 83.0 82.0 04:56:42 INFO - PROCESS | 29845 | 04:56:42 INFO - PROCESS | 29845 | [#11] stanford-crypto-ccm Cycles:10 Average:133.30 Median:128.50 stddev:15.07 (11.7%) stddev-sans-first:15.86 04:56:42 INFO - PROCESS | 29845 | Values: 128.0 141.0 131.0 127.0 125.0 124.0 126.0 128.0 174.0 129.0 04:56:42 INFO - PROCESS | 29845 | 04:56:42 INFO - PROCESS | 29845 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.80 Median:170.50 stddev:2.62 (1.5%) stddev-sans-first:2.77 04:56:42 INFO - PROCESS | 29845 | Values: 170.0 170.0 167.0 166.0 171.0 171.0 173.0 169.0 167.0 174.0 04:56:42 INFO - PROCESS | 29845 | 04:56:42 INFO - PROCESS | 29845 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.70 Median:62.50 stddev:1.77 (2.8%) stddev-sans-first:0.97 04:56:42 INFO - PROCESS | 29845 | Values: 67.0 64.0 63.0 62.0 63.0 62.0 62.0 61.0 62.0 61.0 04:56:42 INFO - PROCESS | 29845 | -------- Summary: end -------- 04:56:42 INFO - PROCESS | 29845 | 04:56:43 INFO - TEST-INFO | 29845: exit 0 04:56:43 INFO - TEST-OK | kraken | took 61164ms 04:56:43 INFO - SUITE-END | took 1177s 04:56:43 INFO - Completed test suite (00:19:37) 04:56:43 INFO - javascript benchmark 04:56:43 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3129.9374012519747, 3220.5974253218346, 3247.8700851965923, 3251.3172233830896, 3268.6567910369413, 5192.0, 5258.158694608864, 5348.144296912495, 5397.78408863645, 5398.163284690874, 5346.304980352558, 5379.569634429236, 5386.218998245252, 5416.945830541703, 5448.509634132927, 4710.74090924999, 4777.689450185727, 4787.0904528139545, 4794.42466903972, 4921.335619691349, 4882.43851957026, 4914.631402644798, 4925.876853078666, 4939.456659767423, 4944.53026962438, 4751.691140075884, 4753.3582966299455, 4785.258284965836, 4797.136515427222, 4907.0, 4824.1316563018645, 4883.780229889663, 4891.510848915115, 4902.901941961177, 4916.827911023097, 4762.809487620491, 4794.976025119852, 4808.903821923542, 4812.398450193726, 4846.806127754886, 5287.47125287472, 5393.002294575516, 5399.7030163341, 5400.567954563626, 5403.621746477748, 5687.232223649796, 5739.282589676291, 5779.422057794229, 5787.479126878559, 5835.766569337264, 5806.071028635398, 5822.97088514559, 5834.241548598698, 5835.153902684129, 5844.853878653025, 5422.783088676488, 5424.1321388577635, 5427.565794736412, 5430.022595932731, 5430.538404235605, 5759.712014399263, 5783.334916484658, 5819.127130930309, 5856.209411729362, 5929.644221346733, 5648.9717551412805, 5696.8860622787315, 5708.086706127, 5727.914081288784, 5746.88506229873, 5682.40334764852, 5718.885622287531, 5818.79634212809, 5824.0, 5831.300243970751, 5662.03745363281, 5671.291088613923, 5685.687287199244, 5753.769849205984, 5790.10253410722, 5787.045137552257, 5790.420957904176, 5795.13073039039, 5795.333536643256, 5803.390643982321, 4416.315471101984, 4435.26818075014, 4445.888852778642, 4460.375547423363, 4490.865274041784, 3998.080441498472, 3998.5001874765653, 3999.7000224983244, 4012.4583181270737, 4045.2516284487465, 5322.0, 5370.624056316098, 5433.375161856358, 5480.534154596904, 5485.396606373296, 5840.88318233633, 5885.823425297248, 5888.146218798251, 5888.322842873039, 5893.941060589425, 5481.75332110056, 5489.917651235235, 5505.229267902497, 5513.3108361454815, 5515.117581186991, 4844.563989240985, 4886.071646387175, 4911.607071434277, 4931.186354251508, 4959.280904268933, 6031.788887389096, 6039.909401358896, 6085.817425477243, 6114.6636934969, 6120.081987701791, 5838.299404071368, 5873.911891321719, 5895.233619629592, 5905.025670764276, 5908.143319218775, 5872.618279811799, 5924.644521328734, 5929.080992446177, 5971.193888824953, 6075.665838378932, 5736.19693242938, 5737.0, 5741.885162296814, 5782.884342313046, 5783.8554036149435, 5767.625104368202, 5819.185314056121, 5823.883522329615, 5827.475527202572, 5829.446202610745, 5570.19232211319, 5609.467100625434, 5643.125315576092, 5677.034904066236, 5713.085906254979, 5751.1373294006235, 5759.395263497272, 5765.164051212467, 5799.5070419014855, 5820.0, 5739.8852022960145, 5748.6838223898085, 5748.741306641295, 5752.597318187687, 5755.7122143893475, 5598.888022239614, 5647.29408823897, 5652.236948012131, 5654.915176272277, 5733.569982251432, 5580.4080660998925, 5590.664560126405, 5637.351704554028, 5677.687727175045, 5686.829395118153], "value": 5337.1434403075145, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [558.7066789935284, 579.7970710251412, 586.6685322792622, 628.7233617208431, 679.4496457869124, 32982.34035319292, 42175.0, 43954.0, 43987.560124398784, 49067.0, 46979.0, 46986.29520557194, 47087.0, 47123.29315060277, 47310.52689473104, 8862.468251904891, 9025.0, 9031.864522032174, 9035.683751068715, 9048.457092574434, 8615.65537378504, 8810.427322224066, 8918.732438026836, 10377.896221037807, 10622.203334749885, 10790.784184316348, 10852.968967948073, 10865.0, 10865.076468500187, 10880.782384352307, 10763.569457221702, 10790.352578845215, 10830.512626931806, 10832.241743077988, 10836.945815270952, 10701.892981070168, 10755.838662419992, 10773.299735517166, 10787.244892857503, 10793.622223222228, 42766.78616606928, 43239.13521729548, 43248.0, 43283.56716432858, 43339.23268440469, 4053.6351728344293, 4093.2836753568304, 4096.487939007624, 4096.815643296059, 4135.524414692319, 32356.20519690868, 32381.0, 32672.183195420068, 32823.6717632823, 34369.65630343714, 4091.652209562191, 4216.7259128156575, 4316.223079845627, 4351.651867850596, 4486.5962063414445, 329864.0, 331082.0, 331209.3439532811, 331350.0, 331517.0, 61913.38086619166, 62398.37601623926, 62439.37560624335, 62565.4973801052, 62575.0, 64256.0, 64444.0, 64475.35524644787, 64624.35375646278, 64625.67687161534, 17042.659146816994, 17597.912010439864, 17609.7358539622, 17636.647267054843, 17641.29434822593, 12383.566575169825, 13670.658233544242, 13725.382357793924, 13748.862511374758, 13763.243021633907, 14827.77758333626, 16351.26419311134, 16446.506604801874, 16853.410130645367, 16974.915125424293, 6562.901556476657, 6678.966605166943, 6714.362135597111, 6762.188537375547, 6789.490788190906, 900.5317235037744, 909.8362294787001, 910.1535571918047, 912.8311262416341, 930.2418528898926, 27765.305867353476, 28234.0, 28305.57541636877, 28626.71373286282, 28658.570121448196, 1006.1849901579744, 1089.145021158387, 1106.8727096383857, 1107.8892110788856, 1111.4387234446554, 13836.792448113287, 15087.1895372556, 15275.296693453907, 15280.770788438182, 15283.617909552127, 451066.0, 454764.0, 455033.0, 456502.0, 457091.0, 62518.687406563586, 62520.0, 62684.0, 62751.6862415685, 62777.68611157007, 1427.5360507834787, 1468.1704836767192, 1484.8589384008717, 1487.4868170481166, 1495.5588101510082, 25769.871150644878, 27596.586051208847, 27997.300067498476, 28055.859720701264, 28165.295867602654, 53167.0, 53373.73313133565, 53652.0, 53812.0, 53843.0, 360835.0, 365939.0, 367368.0, 368003.0, 370135.0, 40448.0, 41097.0, 41206.0, 41442.0, 41469.585304146574, 46497.0, 47170.29244561266, 47260.7636961813, 47422.051558967934, 48114.0, 37766.62233377631, 38189.809050954565, 38565.6143438562, 39134.217315654096, 40033.79983100066, 35574.28851423009, 39032.219355612164, 39421.408678870415, 41206.38190427206, 41702.0, 37663.0, 38080.61919380771, 38532.42201367038, 38634.613653864224, 38896.41655375115, 31938.840305798323, 33886.152846179044, 34421.311573768886, 34605.13487162841, 34859.0, 25822.87088564545, 26031.479370412864, 26207.0, 26285.474290514467, 26564.0], "value": 20251.61448211521, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [388.69875846219156, 415.5366766055849, 427.4165763732505, 432.18964441671864, 433.2310149484665, 14715.602017808318, 16335.75496367554, 19960.70058949117, 20630.38108856733, 22389.104435822588, 20055.498612534695, 20319.898400507976, 20635.69046464304, 21866.89066554665, 22436.88781556094, 5289.814856480014, 5928.496077833368, 6116.877662446748, 6168.907466388007, 6270.247570291572, 6072.301685306202, 6141.0, 6230.688465576725, 6271.968640156792, 6274.466670333027, 6159.90760138596, 6161.537884658646, 6166.414190651881, 6172.506199504029, 6178.505719542426, 6158.353372895848, 6164.630122192661, 6429.7749578764515, 6825.5222134450605, 6851.897221541681, 6126.264848218242, 6130.264368275791, 6133.601315914451, 6144.262688477366, 6147.569670123094, 14020.509282175075, 14403.135811851322, 14514.346854391577, 14622.415103395957, 14636.634084147981, 2628.040765120736, 2736.1244401791437, 2778.4304217635336, 2781.7913656475644, 2790.6372171617763, 10148.289619726622, 11021.724456888562, 12404.689882752913, 14613.415463381558, 15359.616009599738, 1876.8217019383137, 1937.0798870536523, 1949.2885096939515, 1961.5292329840736, 1986.6622674145285, 83968.0, 85724.0, 86515.13484865133, 87553.56223218907, 88137.0, 9821.0, 10252.58989640421, 10416.510468992821, 11697.356645384416, 11851.703707407383, 14096.083754556126, 14126.717465650629, 14159.787603185754, 14250.714985700228, 14265.57203283903, 8177.632006559719, 8326.70856520019, 8452.450590711584, 8547.0, 8561.529115898686, 8279.420440569224, 8307.460015098999, 8349.0177626162, 8614.26778723803, 8638.956805215934, 4248.893777655521, 4255.765932873722, 4319.33050377192, 4484.394606728115, 4514.119746649438, 2085.426507710392, 2110.9472263193234, 2112.1445814445174, 2132.626790311689, 2170.1211009540843, 874.728834061443, 889.7019498467956, 897.9371443998857, 907.274180655473, 914.7210100919284, 18962.52593685169, 20704.068316925775, 20731.170753170005, 20870.79129208719, 20886.164553417995, 890.5369208011798, 893.6961433112643, 904.6833608237064, 905.0587389115246, 922.7923717163585, 10609.257351985441, 11616.244944078608, 11651.30092194471, 11668.64994050163, 11700.648980530597, 588736.0, 602859.0, 607533.0, 611785.0, 612260.0, 101279.0, 104314.0, 104413.47793260985, 106589.0, 109600.4519977395, 1048.8741351037925, 1065.5844220753756, 1077.7067518977258, 1079.2768844873954, 1080.233034545466, 16942.322307107577, 17340.91329543344, 17794.46616601504, 17931.69639286588, 17998.190081446104, 44091.55908440874, 44356.556434435246, 44503.77748111239, 44674.77662611666, 45421.77289113533, 62209.0, 63285.367146327946, 63947.68026159839, 64637.0, 65507.344926550126, 6194.194754681863, 8781.648734050566, 8967.596458159269, 9056.864147037932, 9082.500462474627, 13010.0, 13088.476460941456, 13183.538576150173, 13887.166769993833, 14617.0, 11999.640010799341, 12050.156489045683, 12216.0, 12227.02183825274, 12576.622701318975, 11561.768764624829, 11647.6505704829, 11676.766464670829, 11699.0, 11942.880571194524, 11441.084713223088, 11728.296302221894, 11837.348945808064, 11841.111916606116, 12061.336626485627, 7326.9267307326245, 8513.616887239965, 8548.974123105267, 8555.743327700178, 8684.478931264144, 9514.666986655433, 11195.720106997065, 11323.830142548033, 11527.76944461123, 11774.3524106175], "value": 9482.802100415733, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1306.203216038216, 1392.5683038258135, 1402.4740722229164, 1412.3926711514052, 1418.1916307704605, 7523.247675232474, 8341.374396920224, 8519.27586155176, 8587.656493740244, 8770.079141690127, 8617.439866408678, 8684.392092553524, 8690.08754080822, 8698.08670089641, 8700.825983480327, 2047.488127968008, 2351.1653363056084, 2390.7489713580085, 2391.772781585755, 2394.174009966559, 2090.174381119457, 2353.7646235376496, 2426.9757302426924, 2430.7812296893276, 2449.5835707929696, 2346.8005219556358, 2368.656544801003, 2371.3715865295712, 2373.264288070695, 2381.071382160959, 2378.857268563892, 2401.97598024021, 2404.410919324759, 2406.290144407404, 2407.711074671042, 2232.0290673557056, 2295.173737454515, 2302.8848557572055, 2305.804006659436, 2308.515211805523, 8629.223369896677, 8640.0, 8697.434666746642, 8711.956440217822, 8722.258608018263, 5296.761645725913, 5407.107827208506, 5449.155380915925, 5454.809081682161, 5466.972665136649, 3251.5772949516413, 3271.8527666255077, 3358.1772465745803, 3395.2700169463437, 3397.9490307645406, 1419.198153043527, 1432.0977783996016, 1432.641839540115, 1482.629342664334, 1528.3275358842075, 11771.941140294244, 11773.587924422603, 11793.174477786559, 11810.822837657443, 11849.703757406047, 4719.015856532352, 4781.13939490895, 4838.371011768448, 4881.536254055859, 4899.779509922062, 10149.188064954786, 10175.84736228957, 10177.066357392072, 10195.592176312864, 10198.43908585035, 5510.8071217507195, 5525.585581081435, 5528.723563821793, 5529.364123125892, 5529.585281103853, 4926.236433352764, 4948.975255123702, 5022.59819214462, 5065.037642847848, 5109.233614957711, 4080.1227736036303, 4114.468918838679, 4118.91762164755, 4138.255114079434, 4143.6685065194715, 1335.3841851359768, 1349.6760777413351, 1352.790317500789, 1354.3837553912947, 1360.9183448993092, 775.507552704037, 810.4448452809844, 898.196114477552, 902.2376092202079, 927.4342650982895, 5394.514493695587, 5490.615656903979, 5565.163956767141, 5596.468335508121, 5708.885822283614, 1011.585250047477, 1017.130353547706, 1020.3010937507831, 1047.6961681112543, 1052.7841792432532, 3570.2145527983803, 3735.2529494101286, 3749.4000959846294, 3758.642928921748, 3759.793211373401, 10038.949805251073, 10334.276600637882, 10465.68602941913, 10603.575856965635, 10614.469276536296, 10534.20993425496, 10536.841947370796, 10555.208359373079, 10557.208209384327, 10560.102391296672, 8026.518408895485, 8043.195680432027, 8221.342292616577, 8248.216419440143, 8260.710875119343, 5509.917351239815, 5527.751251193626, 5567.3040869891265, 5669.31968163823, 5747.8563035924435, 9652.324337296322, 9658.130768230892, 9698.951505242429, 9737.318387712792, 9796.363236389612, 8676.91323086761, 9501.952490237505, 9974.152197063331, 9987.60049598008, 10010.749731256778, 6927.549709268881, 7397.593132377771, 7510.39916806665, 7611.619419029137, 7794.2205779423875, 8387.119352467904, 8391.790205244917, 8429.620667069874, 8465.322774178174, 8473.44922580055, 7462.589557574385, 7481.850362992818, 7551.886721699069, 7577.507462014952, 7688.615569221628, 7370.63146842645, 7374.483786134919, 7394.519356241827, 7423.777286681408, 7448.329650331496, 6713.462922966249, 6727.260001399744, 6730.360615741497, 6769.323067693192, 6775.457963363017, 4855.465898751064, 4862.489438608895, 4922.187839006524, 4991.3511243538105, 5018.121828679893, 4441.600255976978, 4507.459104907432, 4540.0919816037585, 4610.400647915883, 4712.976435117939], "value": 4589.642601658216, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [393.36667964577026, 400.67345113732307, 408.6281483849696, 410.7145533853971, 414.85272728181474, 4932.457429682732, 5307.540426382747, 5327.334083239595, 5354.5716342692585, 5381.5963802714805, 4968.205087186042, 5043.268726034723, 5100.628207883334, 5145.845624631258, 5232.6075544334135, 4117.711760176789, 4131.0, 4137.54487006429, 4148.958510414903, 4184.205001049806, 4157.52188498322, 4166.58334166584, 4169.0, 4183.581641835807, 4215.0726840095285, 3819.4843696100947, 3951.9604803952025, 4094.263032654121, 4099.6105369989955, 4153.916921661565, 4110.835566577333, 4118.155778065489, 4121.752694838289, 4138.296489596791, 4138.8137533810905, 3729.4778730977687, 3747.4753534504916, 3748.6626203641804, 3759.793211373373, 3774.1508160663907, 4852.708837469763, 5087.9745601272125, 5142.588592912558, 5180.507851754077, 5188.6367954243215, 4698.718076915396, 4700.647451441156, 4700.670953033289, 4714.434267887841, 4720.0, 5482.588805839578, 5491.533219676332, 5495.560355171577, 5517.337919449652, 5546.422557450422, 3808.90477738056, 3962.346212874872, 4034.8184331705143, 4037.9394309085387, 4055.918881622351, 5680.488756011979, 5697.259356283698, 5711.7144142792695, 5717.285339332542, 5728.51307638847, 4074.898127546835, 4094.570070142592, 4119.752814831119, 4134.111166099303, 4148.854790082393, 3981.402789581586, 4127.4015267786, 4160.167966406731, 4162.354835000579, 4189.706720529594, 4668.39310889589, 4683.15703173432, 4685.789139488663, 4687.648426368036, 4715.575598196178, 5465.344158700981, 5491.478309560585, 5511.669299842022, 5543.362513311021, 5565.7217139143695, 1328.7111501843196, 1401.740677974578, 1407.8451370349253, 1410.8800751935996, 1411.4495346814751, 958.5830163878735, 976.8632391465201, 978.6330126202674, 986.3785814936545, 990.3760630802549, 4872.613533594189, 5061.797528098835, 5105.7191854448365, 5116.258142569307, 5142.177251639794, 5361.329833770778, 5403.918941215885, 5424.566034717213, 5462.7268636568015, 5467.398586155519, 5099.980003999215, 5104.642675012714, 5123.7438128093445, 5124.797001873829, 5131.948680513222, 2805.5931889875856, 2875.7843161762953, 2886.3649997000625, 2892.5516544935567, 2907.6946920573037, 5600.355959064678, 5620.285812827045, 5641.9435805641415, 5642.858928526737, 5654.038813401731, 5310.867228319323, 5596.300462442195, 5618.438156184349, 5630.789380283259, 5642.830715078554, 5422.8915421691345, 5588.720563971867, 5655.575831812631, 5679.488846003796, 5696.629719068247, 5424.267723857229, 5472.771065071627, 5481.314835645544, 5531.751071201725, 5535.640183388067, 5165.66423182492, 5393.86515337104, 5400.432954539874, 5425.21334406501, 5431.864203394789, 5606.635568688022, 5608.242887210337, 5614.101743720985, 5615.241942337732, 5617.9719101404235, 3990.4413382127104, 4019.3569028955226, 4024.5170579530645, 4041.2523683118716, 4069.1251380953236, 5158.420789605198, 5399.136138217867, 5512.6968016759465, 5604.85987850307, 5640.435956404327, 5441.5374693151525, 5467.152591348347, 5471.835844924659, 5475.5072043516275, 5479.904019196097, 5152.330197074356, 5436.0758671026815, 5445.401005889428, 5498.257735205696, 5499.790046189832, 5423.511883930465, 5426.0, 5440.646357986877, 5475.835724928259, 5483.862903427446, 5463.863403414946, 5467.9453205467435, 5482.205080263259, 5493.533049690661, 5502.862428439321, 5222.42553319127, 5386.165144402624, 5388.057090009311, 5395.325584301962, 5401.540869026177], "value": 4192.690707329283, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [758.5638258001648, 762.4967521435854, 772.9227077292271, 779.7426849139785, 805.9556724380159, 12940.547080852171, 13467.461301547939, 13821.861781382184, 14037.50868719595, 14046.43814247429, 12646.494140234403, 12822.80765788514, 12935.353232338393, 13039.674008149777, 13102.606921792338, 746.6416120262278, 759.3166150464598, 763.1910175214263, 763.2672634271106, 763.4960925788953, 642.2453617000007, 660.7918505670698, 739.2976672161441, 757.360030773995, 762.9237076292354, 799.3724925933144, 801.2068052627915, 801.3188789528912, 801.3749275565068, 801.5230937592123, 793.3137835772015, 794.2811755361407, 794.8132188935596, 794.8728203487415, 795.1928792275845, 496.42166875589896, 501.79677230721614, 504.51566496163724, 578.7916350113956, 578.9768409263625, 11592.014678752315, 12368.0, 12549.372531373487, 12746.171498852545, 13022.804657930139, 13657.863421365759, 13816.723665526633, 14191.503297384543, 14194.57416277503, 14205.147691138565, 10864.293820901616, 10933.617323393722, 10964.342139471657, 11261.324320540794, 11291.548338066468, 3710.7402481826284, 3724.7951362675044, 3727.9440808387894, 3870.4581358609817, 3884.941725874114, 73979.26020739778, 74526.25473745247, 75271.62364188199, 75731.24268757297, 77380.61309693471, 10728.678139655824, 10872.130229581615, 10924.180686448548, 10958.452077396098, 11060.281081729661, 19315.0, 19362.128704208346, 19599.608007839764, 19618.901905490668, 19839.60320793605, 7676.961615191888, 7680.5391676498475, 7690.15408305086, 7821.139674635786, 7878.566678832719, 4185.100203456272, 4213.789310534461, 4223.239816832999, 4293.849715259951, 4306.354046892991, 3275.2630658101734, 3356.412627790127, 3360.479125735515, 3390.559227300435, 3395.303962687643, 600.5495878091432, 603.1074010464449, 604.1602172979561, 613.2824595223599, 620.8168590265882, 627.6673363117555, 648.0926702616375, 649.3798422506495, 652.8988006858945, 673.3031312591543, 8625.827483450295, 9535.47554884474, 9938.652147174815, 9962.601495940226, 10003.149732272694, 627.328758228691, 629.7418058595954, 666.4868051600241, 704.5596502186133, 810.107914744357, 4450.888727781767, 4676.415448068991, 4702.247640377524, 4724.811007559659, 4739.644526660514, 53090.46909530932, 67010.66494667593, 70868.0, 72041.6397918007, 73463.0, 61721.38278617156, 61765.69117154476, 61805.38194618086, 62465.37534624687, 63183.0, 52242.22978544753, 55006.44993550093, 55023.0, 55529.72235138799, 56853.71573142191, 8848.690295839615, 8946.955265223633, 9008.099190080939, 9043.68347107848, 9090.59092340833, 38048.23903521859, 38558.228835423695, 38690.80654596822, 39127.217455650156, 39931.80034099811, 46701.0, 48305.51694483151, 49858.50141498539, 50909.0, 51542.742286288325, 12409.93795031019, 12800.74398512043, 12802.231866088065, 12967.0, 13255.536056237985, 12740.681482963, 12799.680007999874, 12849.100562960877, 12932.935335323264, 13361.599152025456, 12704.491820327083, 12897.161684490478, 12924.353782310658, 12966.281478523624, 13074.346282685638, 12453.014546796001, 12602.49590016389, 12643.494260229489, 12695.301758403377, 12739.681507962376, 10478.214133940137, 10799.460026998462, 10939.56241750321, 11718.17972741934, 12756.48974041028, 10386.169106471616, 10880.238383313408, 11281.379524126252, 11457.312561246352, 11474.4262786862, 10378.117859981685, 10826.891731082904, 11037.448127593427, 11130.387828669178, 11234.3259404436], "value": 6714.297229244599, "unit": "score"}], "name": "dromaeo_css", "value": 7139.547124905049, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 112.0, 114.0, 111.0, 113.0, 112.0, 112.0, 115.0, 112.0, 111.0], "value": 112.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 118.0, 119.0, 167.0, 120.0, 119.0, 119.0, 117.0, 142.0, 119.0], "value": 128.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 161.0, 160.0, 162.0, 160.0, 161.0, 160.0, 163.0, 162.0, 161.0], "value": 161.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 77.0, 115.0, 77.0, 76.0, 76.0, 75.0, 90.0, 75.0], "value": 81.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 99.0, 83.0, 83.0, 82.0, 104.0, 82.0, 83.0, 109.0], "value": 89.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 117.0, 117.0, 116.0, 117.0, 116.0, 117.0, 117.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 146.0, 146.0, 147.0, 147.0, 146.0, 146.0, 146.0, 146.0], "value": 146.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 97.0], "value": 96.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 51.0, 51.0, 51.0, 53.0, 51.0, 52.0, 52.0, 52.0, 52.0], "value": 51.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 66.0, 66.0, 66.0, 66.0, 66.0, 67.0, 67.0, 67.0], "value": 66.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 88.0, 85.0, 82.0, 83.0, 83.0, 82.0, 90.0, 83.0, 82.0], "value": 84.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 141.0, 131.0, 127.0, 125.0, 124.0, 126.0, 128.0, 174.0, 129.0], "value": 133.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 170.0, 167.0, 166.0, 171.0, 171.0, 173.0, 169.0, 167.0, 174.0], "value": 169.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 64.0, 63.0, 62.0, 63.0, 62.0, 62.0, 61.0, 62.0, 61.0], "value": 62.7, "unit": "score"}], "name": "kraken", "value": 1498.9, "alertThreshold": 2.0}]} 04:56:43 INFO - Return code: 0 04:56:43 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:56:43 ERROR - # TBPL SUCCESS # 04:56:43 INFO - Running post-action listener: _resource_record_post_action 04:56:43 INFO - [mozharness: 2017-01-26 12:56:43.753524Z] Finished run-tests step (success) 04:56:43 INFO - Running post-run listener: _resource_record_post_run 04:56:43 INFO - Total resource usage - Wall time: 1195s; CPU: 13.0%; Read bytes: 4096; Write bytes: 412127232; Read time: 16; Write time: 424832 04:56:43 INFO - TinderboxPrint: CPU usage
13.1% 04:56:43 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 04:56:43 INFO - TinderboxPrint: I/O write bytes / time
412,127,232 / 424,832 04:56:43 INFO - TinderboxPrint: CPU idle
8,286.9 (86.9%) 04:56:43 INFO - TinderboxPrint: CPU user
1,201.9 (12.6%) 04:56:43 INFO - TinderboxPrint: Swap in / out
0 / 0 04:56:43 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 106024960; Read time: 0; Write time: 124112 04:56:43 INFO - run-tests - Wall time: 1178s; CPU: 13.0%; Read bytes: 4096; Write bytes: 295124992; Read time: 16; Write time: 296884 04:56:44 INFO - Running post-run listener: _upload_blobber_files 04:56:44 INFO - Blob upload gear active. 04:56:44 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:56:44 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 04:56:44 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'] 04:56:44 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 04:56:44 INFO - (blobuploader) - INFO - Open directory for files ... 04:56:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:56:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:56:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:56:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:56:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:56:45 INFO - (blobuploader) - INFO - Done attempting. 04:56:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:56:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:56:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:56:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:56:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:56:46 INFO - (blobuploader) - INFO - Done attempting. 04:56:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:56:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:56:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:56:49 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:56:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:56:49 INFO - (blobuploader) - INFO - Done attempting. 04:56:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 04:56:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:56:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:56:50 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 04:56:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:56:50 INFO - (blobuploader) - INFO - Done attempting. 04:56:50 INFO - (blobuploader) - INFO - Iteration through files over. 04:56:50 INFO - Return code: 0 04:56:50 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:56:50 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:56:50 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/24bff84272ffb01acab0cb62b0eb38ef495bc263732d67ff2a1576ce96a0f48d3a724ef20643c1d094979671fad8ee5ee568d0d4c0a20e94e222b203e66d0ef2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b88a019cb3ed0020e23091c1c4c7b2e459408271963a1a608e29391e3266636dcfc4adfccebee6d8185ccff9e9958d82f46bc8533b818783f0840e6f615806fc", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f5158dcae3ce7dc09f6759c871452fb21c28ea27ab70cb6e642893e73ed23cdcdc79e48c69800818923faf444e277b79a8b70baaa73d5015f2e66a0e4aed1d81", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/01c4203c512ba692e1bc18c6404bc886d2ccabcda28f227562c8ee4f2cbed51c2c56fcfb9ad78274fd846dc71521efe7aeb8d136be0ce932676b16e274785f52"} 04:56:50 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:56:50 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:56:50 INFO - Contents: 04:56:50 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/24bff84272ffb01acab0cb62b0eb38ef495bc263732d67ff2a1576ce96a0f48d3a724ef20643c1d094979671fad8ee5ee568d0d4c0a20e94e222b203e66d0ef2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b88a019cb3ed0020e23091c1c4c7b2e459408271963a1a608e29391e3266636dcfc4adfccebee6d8185ccff9e9958d82f46bc8533b818783f0840e6f615806fc", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f5158dcae3ce7dc09f6759c871452fb21c28ea27ab70cb6e642893e73ed23cdcdc79e48c69800818923faf444e277b79a8b70baaa73d5015f2e66a0e4aed1d81", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/01c4203c512ba692e1bc18c6404bc886d2ccabcda28f227562c8ee4f2cbed51c2c56fcfb9ad78274fd846dc71521efe7aeb8d136be0ce932676b16e274785f52"} 04:56:50 INFO - Running post-run listener: copy_logs_to_upload_dir 04:56:50 INFO - Copying logs to upload dir... 04:56:50 INFO - mkdir: /builds/slave/test/build/upload/logs 04:56:50 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1239.562423 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2017-01-26 04:56:50.072757) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-26 04:56:50.078705) ========= 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=5cf47e208febbcd81da23b2e0000026f-1485434169.163693-979319669 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/24bff84272ffb01acab0cb62b0eb38ef495bc263732d67ff2a1576ce96a0f48d3a724ef20643c1d094979671fad8ee5ee568d0d4c0a20e94e222b203e66d0ef2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b88a019cb3ed0020e23091c1c4c7b2e459408271963a1a608e29391e3266636dcfc4adfccebee6d8185ccff9e9958d82f46bc8533b818783f0840e6f615806fc", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f5158dcae3ce7dc09f6759c871452fb21c28ea27ab70cb6e642893e73ed23cdcdc79e48c69800818923faf444e277b79a8b70baaa73d5015f2e66a0e4aed1d81", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/01c4203c512ba692e1bc18c6404bc886d2ccabcda28f227562c8ee4f2cbed51c2c56fcfb9ad78274fd846dc71521efe7aeb8d136be0ce932676b16e274785f52"} build_url:https://queue.taskcluster.net/v1/task/EKXW-e4zQ4e1VnvEJh8APg/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011299 build_url: 'https://queue.taskcluster.net/v1/task/EKXW-e4zQ4e1VnvEJh8APg/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/24bff84272ffb01acab0cb62b0eb38ef495bc263732d67ff2a1576ce96a0f48d3a724ef20643c1d094979671fad8ee5ee568d0d4c0a20e94e222b203e66d0ef2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b88a019cb3ed0020e23091c1c4c7b2e459408271963a1a608e29391e3266636dcfc4adfccebee6d8185ccff9e9958d82f46bc8533b818783f0840e6f615806fc", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f5158dcae3ce7dc09f6759c871452fb21c28ea27ab70cb6e642893e73ed23cdcdc79e48c69800818923faf444e277b79a8b70baaa73d5015f2e66a0e4aed1d81", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/01c4203c512ba692e1bc18c6404bc886d2ccabcda28f227562c8ee4f2cbed51c2c56fcfb9ad78274fd846dc71521efe7aeb8d136be0ce932676b16e274785f52"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-26 04:56:50.104578) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-26 04:56:50.104943) ========= 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=5cf47e208febbcd81da23b2e0000026f-1485434169.163693-979319669 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004404 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-26 04:56:50.186490) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-26 04:56:50.186821) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-26 04:56:50.187125) ========= ========= Total master_lag: 0.18 =========